{"level":"warn","ts":"2026-05-12T05:38:24.371581Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-12T05:38:24.371715Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-12T05:38:24.371874Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-12T05:38:24.371888Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-05-12T05:38:24.371908Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-12T05:38:24.372589Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-05-12T05:38:24.372675Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-12T05:38:24.379935Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.696225ms"} {"level":"info","ts":"2026-05-12T05:38:24.388524Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-05-12T05:38:24.388619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T05:38:24.388687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-05-12T05:38:24.388715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T05:38:24.388777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-05-12T05:38:24.38886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-05-12T05:38:24.399054Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T05:38:24.400371Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T05:38:24.401517Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-12T05:38:24.403831Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T05:38:24.404157Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T05:38:24.404152Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T05:38:24.404342Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T05:38:24.404375Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-12T05:38:24.407525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-05-12T05:38:24.407673Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-05-12T05:38:24.410143Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-12T05:38:24.410247Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-05-12T05:38:24.410313Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-05-12T05:38:24.410563Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T05:38:24.410633Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T05:38:24.48991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T05:38:24.490024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T05:38:24.490083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-05-12T05:38:24.490108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-05-12T05:38:24.490121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-05-12T05:38:24.490215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-05-12T05:38:24.490258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-05-12T05:38:24.49148Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T05:38:24.492277Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T05:38:24.492316Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T05:38:24.492808Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T05:38:24.492853Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T05:38:24.492974Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T05:38:24.49312Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T05:38:24.493174Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T05:38:24.49227Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T05:38:24.496226Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-12T05:38:24.497084Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-05-12T05:38:28.518203Z","caller":"traceutil/trace.go:171","msg":"trace[466269848] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"170.645538ms","start":"2026-05-12T05:38:28.347505Z","end":"2026-05-12T05:38:28.51815Z","steps":["trace[466269848] 'process raft request' (duration: 99.286106ms)","trace[466269848] 'compare' (duration: 71.19587ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T05:38:28.855756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.949194ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T05:38:28.855939Z","caller":"traceutil/trace.go:171","msg":"trace[902425112] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"144.158511ms","start":"2026-05-12T05:38:28.711768Z","end":"2026-05-12T05:38:28.855927Z","steps":["trace[902425112] 'process raft request' (duration: 144.128261ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:28.855972Z","caller":"traceutil/trace.go:171","msg":"trace[1836851668] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"192.442773ms","start":"2026-05-12T05:38:28.663516Z","end":"2026-05-12T05:38:28.855958Z","steps":["trace[1836851668] 'process raft request' (duration: 192.332302ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:28.856132Z","caller":"traceutil/trace.go:171","msg":"trace[1510239234] linearizableReadLoop","detail":"{readStateIndex:232; appliedIndex:230; }","duration":"144.531075ms","start":"2026-05-12T05:38:28.711589Z","end":"2026-05-12T05:38:28.85612Z","steps":["trace[1510239234] 'read index received' (duration: 28.801302ms)","trace[1510239234] 'applied index is now lower than readState.Index' (duration: 115.728693ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:28.856139Z","caller":"traceutil/trace.go:171","msg":"trace[781775172] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"193.929259ms","start":"2026-05-12T05:38:28.662189Z","end":"2026-05-12T05:38:28.856118Z","steps":["trace[781775172] 'process raft request' (duration: 78.176846ms)","trace[781775172] 'compare' (duration: 114.817573ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T05:38:28.856228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.608146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-12T05:38:28.856255Z","caller":"traceutil/trace.go:171","msg":"trace[2145367209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:227; }","duration":"144.707386ms","start":"2026-05-12T05:38:28.711539Z","end":"2026-05-12T05:38:28.856247Z","steps":["trace[2145367209] 'agreement among raft nodes before linearized reading' (duration: 144.616515ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:29.255122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.25503ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T05:38:29.255209Z","caller":"traceutil/trace.go:171","msg":"trace[1498976856] linearizableReadLoop","detail":"{readStateIndex:244; appliedIndex:243; }","duration":"149.307715ms","start":"2026-05-12T05:38:29.105886Z","end":"2026-05-12T05:38:29.255194Z","steps":["trace[1498976856] 'read index received' (duration: 45.882063ms)","trace[1498976856] 'applied index is now lower than readState.Index' (duration: 103.424812ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T05:38:29.255329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.436927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:38:29.255355Z","caller":"traceutil/trace.go:171","msg":"trace[64318723] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:238; }","duration":"149.466287ms","start":"2026-05-12T05:38:29.10588Z","end":"2026-05-12T05:38:29.255346Z","steps":["trace[64318723] 'agreement among raft nodes before linearized reading' (duration: 149.394716ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:29.255418Z","caller":"traceutil/trace.go:171","msg":"trace[776751227] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"158.645576ms","start":"2026-05-12T05:38:29.096667Z","end":"2026-05-12T05:38:29.255312Z","steps":["trace[776751227] 'process raft request' (duration: 55.145443ms)","trace[776751227] 'compare' (duration: 103.131229ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:34.862434Z","caller":"traceutil/trace.go:171","msg":"trace[994877316] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:360; }","duration":"188.169667ms","start":"2026-05-12T05:38:34.67424Z","end":"2026-05-12T05:38:34.86241Z","steps":["trace[994877316] 'read index received' (duration: 150.231293ms)","trace[994877316] 'applied index is now lower than readState.Index' (duration: 37.937414ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:34.862473Z","caller":"traceutil/trace.go:171","msg":"trace[30273135] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"233.244155ms","start":"2026-05-12T05:38:34.629176Z","end":"2026-05-12T05:38:34.86242Z","steps":["trace[30273135] 'process raft request' (duration: 195.341801ms)","trace[30273135] 'compare' (duration: 37.659522ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:34.86256Z","caller":"traceutil/trace.go:171","msg":"trace[659683359] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"232.986153ms","start":"2026-05-12T05:38:34.629562Z","end":"2026-05-12T05:38:34.862549Z","steps":["trace[659683359] 'process raft request' (duration: 232.74353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:34.863012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.974976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-12T05:38:34.863062Z","caller":"traceutil/trace.go:171","msg":"trace[1094618440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:347; }","duration":"166.085287ms","start":"2026-05-12T05:38:34.69696Z","end":"2026-05-12T05:38:34.863046Z","steps":["trace[1094618440] 'agreement among raft nodes before linearized reading' (duration: 165.979616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:34.86339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.743153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-12T05:38:34.863444Z","caller":"traceutil/trace.go:171","msg":"trace[1925926524] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:347; }","duration":"138.855954ms","start":"2026-05-12T05:38:34.724574Z","end":"2026-05-12T05:38:34.86343Z","steps":["trace[1925926524] 'agreement among raft nodes before linearized reading' (duration: 138.726022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:34.863695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.4522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-12T05:38:34.863202Z","caller":"traceutil/trace.go:171","msg":"trace[665442332] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"228.110482ms","start":"2026-05-12T05:38:34.63508Z","end":"2026-05-12T05:38:34.863191Z","steps":["trace[665442332] 'process raft request' (duration: 227.283164ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:34.863768Z","caller":"traceutil/trace.go:171","msg":"trace[74982896] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:347; }","duration":"189.759553ms","start":"2026-05-12T05:38:34.673992Z","end":"2026-05-12T05:38:34.863752Z","steps":["trace[74982896] 'agreement among raft nodes before linearized reading' (duration: 189.615402ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:35.045851Z","caller":"traceutil/trace.go:171","msg":"trace[1559105019] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"113.301695ms","start":"2026-05-12T05:38:34.93253Z","end":"2026-05-12T05:38:35.045831Z","steps":["trace[1559105019] 'process raft request' (duration: 113.277695ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:35.045881Z","caller":"traceutil/trace.go:171","msg":"trace[2126037530] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:372; }","duration":"121.290438ms","start":"2026-05-12T05:38:34.924556Z","end":"2026-05-12T05:38:35.045846Z","steps":["trace[2126037530] 'read index received' (duration: 2.300494ms)","trace[2126037530] 'applied index is now lower than readState.Index' (duration: 118.985594ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:35.045953Z","caller":"traceutil/trace.go:171","msg":"trace[100680165] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"128.850287ms","start":"2026-05-12T05:38:34.91708Z","end":"2026-05-12T05:38:35.04593Z","steps":["trace[100680165] 'process raft request' (duration: 56.316226ms)","trace[100680165] 'compare' (duration: 72.242598ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:35.046036Z","caller":"traceutil/trace.go:171","msg":"trace[2086090849] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"114.399776ms","start":"2026-05-12T05:38:34.931583Z","end":"2026-05-12T05:38:35.045983Z","steps":["trace[2086090849] 'process raft request' (duration: 114.200024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:35.046255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.699753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-12T05:38:35.046389Z","caller":"traceutil/trace.go:171","msg":"trace[1944396705] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:363; }","duration":"121.875634ms","start":"2026-05-12T05:38:34.924465Z","end":"2026-05-12T05:38:35.04634Z","steps":["trace[1944396705] 'agreement among raft nodes before linearized reading' (duration: 121.549101ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:35.209787Z","caller":"traceutil/trace.go:171","msg":"trace[187191829] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"113.532513ms","start":"2026-05-12T05:38:35.09623Z","end":"2026-05-12T05:38:35.209763Z","steps":["trace[187191829] 'process raft request' (duration: 66.612938ms)","trace[187191829] 'compare' (duration: 46.682153ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T05:38:35.21001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.704766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-12T05:38:35.209961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.061518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2901"} {"level":"info","ts":"2026-05-12T05:38:35.210075Z","caller":"traceutil/trace.go:171","msg":"trace[690905321] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:374; }","duration":"113.953098ms","start":"2026-05-12T05:38:35.096106Z","end":"2026-05-12T05:38:35.21006Z","steps":["trace[690905321] 'agreement among raft nodes before linearized reading' (duration: 113.726426ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:35.210122Z","caller":"traceutil/trace.go:171","msg":"trace[1313887391] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:374; }","duration":"112.187509ms","start":"2026-05-12T05:38:35.097881Z","end":"2026-05-12T05:38:35.210068Z","steps":["trace[1313887391] 'agreement among raft nodes before linearized reading' (duration: 112.020278ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:35.209784Z","caller":"traceutil/trace.go:171","msg":"trace[1331782210] linearizableReadLoop","detail":"{readStateIndex:390; appliedIndex:388; }","duration":"101.60793ms","start":"2026-05-12T05:38:35.108152Z","end":"2026-05-12T05:38:35.20976Z","steps":["trace[1331782210] 'read index received' (duration: 54.668615ms)","trace[1331782210] 'applied index is now lower than readState.Index' (duration: 46.938325ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:35.209847Z","caller":"traceutil/trace.go:171","msg":"trace[117105153] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"113.006198ms","start":"2026-05-12T05:38:35.096816Z","end":"2026-05-12T05:38:35.209822Z","steps":["trace[117105153] 'process raft request' (duration: 112.878277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:35.511006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.365567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-12T05:38:35.511371Z","caller":"traceutil/trace.go:171","msg":"trace[1251426778] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"199.546573ms","start":"2026-05-12T05:38:35.311755Z","end":"2026-05-12T05:38:35.511302Z","steps":["trace[1251426778] 'process raft request' (duration: 12.794932ms)","trace[1251426778] 'compare' (duration: 186.156615ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:35.511503Z","caller":"traceutil/trace.go:171","msg":"trace[203048676] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"199.568603ms","start":"2026-05-12T05:38:35.311863Z","end":"2026-05-12T05:38:35.511431Z","steps":["trace[203048676] 'process raft request' (duration: 199.30435ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:35.511673Z","caller":"traceutil/trace.go:171","msg":"trace[1442624004] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"199.37231ms","start":"2026-05-12T05:38:35.312262Z","end":"2026-05-12T05:38:35.511635Z","steps":["trace[1442624004] 'process raft request' (duration: 198.951806ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:35.512181Z","caller":"traceutil/trace.go:171","msg":"trace[1871657010] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"197.062577ms","start":"2026-05-12T05:38:35.315098Z","end":"2026-05-12T05:38:35.51216Z","steps":["trace[1871657010] 'process raft request' (duration: 196.42549ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:36.539219Z","caller":"traceutil/trace.go:171","msg":"trace[587268413] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"146.860269ms","start":"2026-05-12T05:38:36.392337Z","end":"2026-05-12T05:38:36.539198Z","steps":["trace[587268413] 'process raft request' (duration: 146.740368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:38.703693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.198699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-05-12T05:38:38.70378Z","caller":"traceutil/trace.go:171","msg":"trace[1439021300] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:399; }","duration":"109.32979ms","start":"2026-05-12T05:38:38.59443Z","end":"2026-05-12T05:38:38.70376Z","steps":["trace[1439021300] 'range keys from in-memory index tree' (duration: 109.089367ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:41.792793Z","caller":"traceutil/trace.go:171","msg":"trace[1271863046] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"129.838827ms","start":"2026-05-12T05:38:41.662924Z","end":"2026-05-12T05:38:41.792762Z","steps":["trace[1271863046] 'process raft request' (duration: 50.468174ms)","trace[1271863046] 'compare' (duration: 79.248142ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T05:38:42.844506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.935706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"warn","ts":"2026-05-12T05:38:42.844571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.287283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"warn","ts":"2026-05-12T05:38:42.844573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.392893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:38:42.844614Z","caller":"traceutil/trace.go:171","msg":"trace[1450103350] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:415; }","duration":"242.096147ms","start":"2026-05-12T05:38:42.602497Z","end":"2026-05-12T05:38:42.844593Z","steps":["trace[1450103350] 'range keys from in-memory index tree' (duration: 241.851674ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:42.844632Z","caller":"traceutil/trace.go:171","msg":"trace[1668534656] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:415; }","duration":"512.367574ms","start":"2026-05-12T05:38:42.332244Z","end":"2026-05-12T05:38:42.844612Z","steps":["trace[1668534656] 'range keys from in-memory index tree' (duration: 512.218302ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:42.844764Z","caller":"traceutil/trace.go:171","msg":"trace[1224828776] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:415; }","duration":"533.545764ms","start":"2026-05-12T05:38:42.311091Z","end":"2026-05-12T05:38:42.844637Z","steps":["trace[1224828776] 'range keys from in-memory index tree' (duration: 533.316412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:42.844668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:42.332235Z","time spent":"512.424855ms","remote":"127.0.0.1:36226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4392,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-12T05:38:42.844872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:42.311073Z","time spent":"533.785787ms","remote":"127.0.0.1:36072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-12T05:38:43.478424Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367618728331441,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-12T05:38:43.613824Z","caller":"traceutil/trace.go:171","msg":"trace[473574821] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"760.578251ms","start":"2026-05-12T05:38:42.853224Z","end":"2026-05-12T05:38:43.613802Z","steps":["trace[473574821] 'process raft request' (duration: 760.43662ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:43.613985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:42.85321Z","time spent":"760.705502ms","remote":"127.0.0.1:36236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4119,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T05:38:44.14549Z","caller":"traceutil/trace.go:171","msg":"trace[392363997] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"1.168118389s","start":"2026-05-12T05:38:42.977347Z","end":"2026-05-12T05:38:44.145465Z","steps":["trace[392363997] 'read index received' (duration: 636.450667ms)","trace[392363997] 'applied index is now lower than readState.Index' (duration: 531.666802ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:44.145655Z","caller":"traceutil/trace.go:171","msg":"trace[1648322906] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"1.285506827s","start":"2026-05-12T05:38:42.860113Z","end":"2026-05-12T05:38:44.14562Z","steps":["trace[1648322906] 'process raft request' (duration: 1.273816762s)","trace[1648322906] 'compare' (duration: 11.436882ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T05:38:44.1458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.02165166s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-12T05:38:44.145755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.164944538s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-12T05:38:44.145811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021628379s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-12T05:38:44.145838Z","caller":"traceutil/trace.go:171","msg":"trace[261268909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:417; }","duration":"1.02172863s","start":"2026-05-12T05:38:43.124099Z","end":"2026-05-12T05:38:44.145827Z","steps":["trace[261268909] 'agreement among raft nodes before linearized reading' (duration: 1.021670749s)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:44.145852Z","caller":"traceutil/trace.go:171","msg":"trace[512827471] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:417; }","duration":"1.165074419s","start":"2026-05-12T05:38:42.980762Z","end":"2026-05-12T05:38:44.145837Z","steps":["trace[512827471] 'agreement among raft nodes before linearized reading' (duration: 1.164928328s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:44.145867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:43.12408Z","time spent":"1.02178022s","remote":"127.0.0.1:36340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-12T05:38:44.145855Z","caller":"traceutil/trace.go:171","msg":"trace[590891093] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:417; }","duration":"1.02170182s","start":"2026-05-12T05:38:43.12414Z","end":"2026-05-12T05:38:44.145842Z","steps":["trace[590891093] 'agreement among raft nodes before linearized reading' (duration: 1.021604269s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:44.145886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:42.980752Z","time spent":"1.1651271s","remote":"127.0.0.1:36340","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":"warn","ts":"2026-05-12T05:38:44.145925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:43.12408Z","time spent":"1.021834741s","remote":"127.0.0.1:36340","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-05-12T05:38:44.146159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:42.860102Z","time spent":"1.285706429s","remote":"127.0.0.1:36226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4361,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T05:38:44.145656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.168291701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-12T05:38:44.147288Z","caller":"traceutil/trace.go:171","msg":"trace[847461389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:417; }","duration":"1.169877467s","start":"2026-05-12T05:38:42.9773Z","end":"2026-05-12T05:38:44.147178Z","steps":["trace[847461389] 'agreement among raft nodes before linearized reading' (duration: 1.168298182s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:44.147363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:42.977282Z","time spent":"1.170047719s","remote":"127.0.0.1:36340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-12T05:38:48.410281Z","caller":"traceutil/trace.go:171","msg":"trace[1092429036] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"192.660433ms","start":"2026-05-12T05:38:48.217597Z","end":"2026-05-12T05:38:48.410258Z","steps":["trace[1092429036] 'process raft request' (duration: 192.593342ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:48.410323Z","caller":"traceutil/trace.go:171","msg":"trace[54079236] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"192.772984ms","start":"2026-05-12T05:38:48.217509Z","end":"2026-05-12T05:38:48.410282Z","steps":["trace[54079236] 'process raft request' (duration: 168.672631ms)","trace[54079236] 'compare' (duration: 23.81706ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:48.410472Z","caller":"traceutil/trace.go:171","msg":"trace[1841771911] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"192.828055ms","start":"2026-05-12T05:38:48.217534Z","end":"2026-05-12T05:38:48.410362Z","steps":["trace[1841771911] 'process raft request' (duration: 192.598982ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:58.625577Z","caller":"traceutil/trace.go:171","msg":"trace[2106350053] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"648.916775ms","start":"2026-05-12T05:38:57.976627Z","end":"2026-05-12T05:38:58.625544Z","steps":["trace[2106350053] 'process raft request' (duration: 648.748058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.625752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:57.976607Z","time spent":"649.066742ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T05:38:58.653554Z","caller":"traceutil/trace.go:171","msg":"trace[982865208] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"673.57738ms","start":"2026-05-12T05:38:57.979942Z","end":"2026-05-12T05:38:58.653519Z","steps":["trace[982865208] 'process raft request' (duration: 672.781284ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:58.653553Z","caller":"traceutil/trace.go:171","msg":"trace[1869450952] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"665.72221ms","start":"2026-05-12T05:38:57.987809Z","end":"2026-05-12T05:38:58.653532Z","steps":["trace[1869450952] 'process raft request' (duration: 665.599335ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:58.653894Z","caller":"traceutil/trace.go:171","msg":"trace[1936455453] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"639.957995ms","start":"2026-05-12T05:38:58.013924Z","end":"2026-05-12T05:38:58.653882Z","steps":["trace[1936455453] 'process raft request' (duration: 639.745875ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:58.653965Z","caller":"traceutil/trace.go:171","msg":"trace[1998906789] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"617.100477ms","start":"2026-05-12T05:38:58.036823Z","end":"2026-05-12T05:38:58.653923Z","steps":["trace[1998906789] 'process raft request' (duration: 616.900569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.654014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:58.013905Z","time spent":"640.030508ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T05:38:58.653945Z","caller":"traceutil/trace.go:171","msg":"trace[468814676] linearizableReadLoop","detail":"{readStateIndex:546; appliedIndex:534; }","duration":"382.210039ms","start":"2026-05-12T05:38:58.271711Z","end":"2026-05-12T05:38:58.653921Z","steps":["trace[468814676] 'read index received' (duration: 353.672612ms)","trace[468814676] 'applied index is now lower than readState.Index' (duration: 28.536627ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:38:58.654118Z","caller":"traceutil/trace.go:171","msg":"trace[1794845759] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"490.659838ms","start":"2026-05-12T05:38:58.163417Z","end":"2026-05-12T05:38:58.654077Z","steps":["trace[1794845759] 'process raft request' (duration: 490.445869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.65417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.375927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-12T05:38:58.654158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:58.036798Z","time spent":"617.245794ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T05:38:58.654232Z","caller":"traceutil/trace.go:171","msg":"trace[278016022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:524; }","duration":"382.562415ms","start":"2026-05-12T05:38:58.271658Z","end":"2026-05-12T05:38:58.65422Z","steps":["trace[278016022] 'agreement among raft nodes before linearized reading' (duration: 382.330274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.654294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:58.271636Z","time spent":"382.646848ms","remote":"127.0.0.1:36340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T05:38:58.653682Z","caller":"traceutil/trace.go:171","msg":"trace[1673415040] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"665.744001ms","start":"2026-05-12T05:38:57.987913Z","end":"2026-05-12T05:38:58.653657Z","steps":["trace[1673415040] 'process raft request' (duration: 665.535331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.654314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:58.163384Z","time spent":"490.836056ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T05:38:58.654376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:57.987908Z","time spent":"666.428881ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T05:38:58.653733Z","caller":"traceutil/trace.go:171","msg":"trace[2126521122] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"652.865907ms","start":"2026-05-12T05:38:58.000858Z","end":"2026-05-12T05:38:58.653723Z","steps":["trace[2126521122] 'process raft request' (duration: 652.702159ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:58.653671Z","caller":"traceutil/trace.go:171","msg":"trace[1781739984] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"657.275004ms","start":"2026-05-12T05:38:57.99636Z","end":"2026-05-12T05:38:58.653635Z","steps":["trace[1781739984] 'process raft request' (duration: 657.123917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.654537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:58.000846Z","time spent":"653.660942ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T05:38:58.653756Z","caller":"traceutil/trace.go:171","msg":"trace[778756535] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"655.886872ms","start":"2026-05-12T05:38:57.997858Z","end":"2026-05-12T05:38:58.653745Z","steps":["trace[778756535] 'process raft request' (duration: 655.664502ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:58.653753Z","caller":"traceutil/trace.go:171","msg":"trace[1523690636] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"651.706755ms","start":"2026-05-12T05:38:58.002034Z","end":"2026-05-12T05:38:58.653741Z","steps":["trace[1523690636] 'process raft request' (duration: 651.58485ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:38:58.653645Z","caller":"traceutil/trace.go:171","msg":"trace[1736313380] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"665.847645ms","start":"2026-05-12T05:38:57.987744Z","end":"2026-05-12T05:38:58.653591Z","steps":["trace[1736313380] 'process raft request' (duration: 665.618115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.654766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:58.002015Z","time spent":"652.72535ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T05:38:58.654819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:57.987725Z","time spent":"667.064559ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T05:38:58.654632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:57.99635Z","time spent":"658.216705ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T05:38:58.655041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:57.997833Z","time spent":"656.960569ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T05:38:58.655313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:57.987805Z","time spent":"666.041374ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T05:38:58.655545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:38:57.979926Z","time spent":"673.914925ms","remote":"127.0.0.1:36116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T05:38:58.6662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.197049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-12T05:38:58.666268Z","caller":"traceutil/trace.go:171","msg":"trace[1441507786] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:526; }","duration":"212.276373ms","start":"2026-05-12T05:38:58.453975Z","end":"2026-05-12T05:38:58.666251Z","steps":["trace[1441507786] 'agreement among raft nodes before linearized reading' (duration: 212.170058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.666503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.679933ms","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-05-12T05:38:58.666536Z","caller":"traceutil/trace.go:171","msg":"trace[169282740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:526; }","duration":"208.754327ms","start":"2026-05-12T05:38:58.457772Z","end":"2026-05-12T05:38:58.666527Z","steps":["trace[169282740] 'agreement among raft nodes before linearized reading' (duration: 208.698094ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:38:58.666724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.078611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-12T05:38:58.666755Z","caller":"traceutil/trace.go:171","msg":"trace[352930021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:526; }","duration":"209.162196ms","start":"2026-05-12T05:38:58.457584Z","end":"2026-05-12T05:38:58.666747Z","steps":["trace[352930021] 'agreement among raft nodes before linearized reading' (duration: 209.104103ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:02.539102Z","caller":"traceutil/trace.go:171","msg":"trace[991514793] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"113.889901ms","start":"2026-05-12T05:39:02.425185Z","end":"2026-05-12T05:39:02.539075Z","steps":["trace[991514793] 'process raft request' (duration: 111.912117ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.073362Z","caller":"traceutil/trace.go:171","msg":"trace[656185006] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"153.975149ms","start":"2026-05-12T05:39:04.91936Z","end":"2026-05-12T05:39:05.073335Z","steps":["trace[656185006] 'process raft request' (duration: 152.28289ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.232741Z","caller":"traceutil/trace.go:171","msg":"trace[1732272351] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:647; }","duration":"263.300645ms","start":"2026-05-12T05:39:04.969394Z","end":"2026-05-12T05:39:05.232695Z","steps":["trace[1732272351] 'read index received' (duration: 94.550024ms)","trace[1732272351] 'applied index is now lower than readState.Index' (duration: 168.749761ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:39:05.232792Z","caller":"traceutil/trace.go:171","msg":"trace[1938675929] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"279.736932ms","start":"2026-05-12T05:39:04.953016Z","end":"2026-05-12T05:39:05.232753Z","steps":["trace[1938675929] 'process raft request' (duration: 278.94936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.232937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.515904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.233015Z","caller":"traceutil/trace.go:171","msg":"trace[140342771] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:623; }","duration":"263.639858ms","start":"2026-05-12T05:39:04.969357Z","end":"2026-05-12T05:39:05.232997Z","steps":["trace[140342771] 'agreement among raft nodes before linearized reading' (duration: 263.470651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.233279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.774674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.233329Z","caller":"traceutil/trace.go:171","msg":"trace[1193119469] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"263.873198ms","start":"2026-05-12T05:39:04.969443Z","end":"2026-05-12T05:39:05.233317Z","steps":["trace[1193119469] 'agreement among raft nodes before linearized reading' (duration: 263.760684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.233339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.894824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.233367Z","caller":"traceutil/trace.go:171","msg":"trace[1572562848] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"100.943476ms","start":"2026-05-12T05:39:05.132415Z","end":"2026-05-12T05:39:05.233358Z","steps":["trace[1572562848] 'agreement among raft nodes before linearized reading' (duration: 100.899374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.233479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.751266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.233515Z","caller":"traceutil/trace.go:171","msg":"trace[432587044] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"123.797368ms","start":"2026-05-12T05:39:05.109708Z","end":"2026-05-12T05:39:05.233506Z","steps":["trace[432587044] 'agreement among raft nodes before linearized reading' (duration: 123.746136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.233644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.461575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.233678Z","caller":"traceutil/trace.go:171","msg":"trace[952219239] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"124.504537ms","start":"2026-05-12T05:39:05.109165Z","end":"2026-05-12T05:39:05.23367Z","steps":["trace[952219239] 'agreement among raft nodes before linearized reading' (duration: 124.457275ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.233795Z","caller":"traceutil/trace.go:171","msg":"trace[2074315027] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"106.285654ms","start":"2026-05-12T05:39:05.127387Z","end":"2026-05-12T05:39:05.233673Z","steps":["trace[2074315027] 'process raft request' (duration: 105.716431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.234971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.347973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.235008Z","caller":"traceutil/trace.go:171","msg":"trace[575745174] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"102.440167ms","start":"2026-05-12T05:39:05.132559Z","end":"2026-05-12T05:39:05.234999Z","steps":["trace[575745174] 'agreement among raft nodes before linearized reading' (duration: 102.376234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.235055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.001938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.235113Z","caller":"traceutil/trace.go:171","msg":"trace[498617420] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"126.084941ms","start":"2026-05-12T05:39:05.109015Z","end":"2026-05-12T05:39:05.2351Z","steps":["trace[498617420] 'agreement among raft nodes before linearized reading' (duration: 125.998078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.233906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.528439ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.235284Z","caller":"traceutil/trace.go:171","msg":"trace[2099546394] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:624; }","duration":"101.842722ms","start":"2026-05-12T05:39:05.133335Z","end":"2026-05-12T05:39:05.235178Z","steps":["trace[2099546394] 'agreement among raft nodes before linearized reading' (duration: 100.525279ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.415289Z","caller":"traceutil/trace.go:171","msg":"trace[1766405579] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"162.536269ms","start":"2026-05-12T05:39:05.252732Z","end":"2026-05-12T05:39:05.415269Z","steps":["trace[1766405579] 'read index received' (duration: 162.381663ms)","trace[1766405579] 'applied index is now lower than readState.Index' (duration: 153.586µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:39:05.415314Z","caller":"traceutil/trace.go:171","msg":"trace[621940186] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"163.05076ms","start":"2026-05-12T05:39:05.252236Z","end":"2026-05-12T05:39:05.415287Z","steps":["trace[621940186] 'process raft request' (duration: 162.902344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.415482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.738417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.415539Z","caller":"traceutil/trace.go:171","msg":"trace[1311554549] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:625; }","duration":"162.803979ms","start":"2026-05-12T05:39:05.25272Z","end":"2026-05-12T05:39:05.415524Z","steps":["trace[1311554549] 'agreement among raft nodes before linearized reading' (duration: 162.684845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.415618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.569147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T05:39:05.4156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.711085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.415667Z","caller":"traceutil/trace.go:171","msg":"trace[1792953248] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"146.664802ms","start":"2026-05-12T05:39:05.268988Z","end":"2026-05-12T05:39:05.415652Z","steps":["trace[1792953248] 'agreement among raft nodes before linearized reading' (duration: 146.573408ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.415711Z","caller":"traceutil/trace.go:171","msg":"trace[154819812] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"123.890422ms","start":"2026-05-12T05:39:05.291805Z","end":"2026-05-12T05:39:05.415696Z","steps":["trace[154819812] 'agreement among raft nodes before linearized reading' (duration: 123.714825ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.415714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.860212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.415792Z","caller":"traceutil/trace.go:171","msg":"trace[1658966672] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"123.993007ms","start":"2026-05-12T05:39:05.291781Z","end":"2026-05-12T05:39:05.415774Z","steps":["trace[1658966672] 'agreement among raft nodes before linearized reading' (duration: 123.83313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.415731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.395741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T05:39:05.415836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.253713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.415863Z","caller":"traceutil/trace.go:171","msg":"trace[1582220484] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"146.530947ms","start":"2026-05-12T05:39:05.269316Z","end":"2026-05-12T05:39:05.415846Z","steps":["trace[1582220484] 'agreement among raft nodes before linearized reading' (duration: 146.36794ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.41588Z","caller":"traceutil/trace.go:171","msg":"trace[1684708009] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"105.321456ms","start":"2026-05-12T05:39:05.310549Z","end":"2026-05-12T05:39:05.41587Z","steps":["trace[1684708009] 'agreement among raft nodes before linearized reading' (duration: 105.261913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.415924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.731913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T05:39:05.415952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.971075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.415964Z","caller":"traceutil/trace.go:171","msg":"trace[1085488012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"107.780146ms","start":"2026-05-12T05:39:05.308174Z","end":"2026-05-12T05:39:05.415954Z","steps":["trace[1085488012] 'agreement among raft nodes before linearized reading' (duration: 107.726534ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.415985Z","caller":"traceutil/trace.go:171","msg":"trace[885612901] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:625; }","duration":"147.032167ms","start":"2026-05-12T05:39:05.268945Z","end":"2026-05-12T05:39:05.415977Z","steps":["trace[885612901] 'agreement among raft nodes before linearized reading' (duration: 146.983825ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.416094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.921274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T05:39:05.416089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.487562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.416124Z","caller":"traceutil/trace.go:171","msg":"trace[593383739] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:625; }","duration":"162.976877ms","start":"2026-05-12T05:39:05.253139Z","end":"2026-05-12T05:39:05.416116Z","steps":["trace[593383739] 'agreement among raft nodes before linearized reading' (duration: 162.928015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.416126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.990282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.416159Z","caller":"traceutil/trace.go:171","msg":"trace[73752546] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"105.036704ms","start":"2026-05-12T05:39:05.311113Z","end":"2026-05-12T05:39:05.41615Z","steps":["trace[73752546] 'agreement among raft nodes before linearized reading' (duration: 104.988442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:05.416268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.489147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:05.416267Z","caller":"traceutil/trace.go:171","msg":"trace[1233326207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:625; }","duration":"105.545194ms","start":"2026-05-12T05:39:05.31058Z","end":"2026-05-12T05:39:05.416125Z","steps":["trace[1233326207] 'agreement among raft nodes before linearized reading' (duration: 105.085365ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.416315Z","caller":"traceutil/trace.go:171","msg":"trace[1400727491] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:625; }","duration":"163.576641ms","start":"2026-05-12T05:39:05.252727Z","end":"2026-05-12T05:39:05.416304Z","steps":["trace[1400727491] 'agreement among raft nodes before linearized reading' (duration: 162.732947ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:05.975173Z","caller":"traceutil/trace.go:171","msg":"trace[10086628] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"299.106409ms","start":"2026-05-12T05:39:05.675622Z","end":"2026-05-12T05:39:05.974728Z","steps":["trace[10086628] 'process raft request' (duration: 298.945362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:06.555364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.590968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:06.555803Z","caller":"traceutil/trace.go:171","msg":"trace[793581658] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:632; }","duration":"245.287766ms","start":"2026-05-12T05:39:06.310489Z","end":"2026-05-12T05:39:06.555777Z","steps":["trace[793581658] 'range keys from in-memory index tree' (duration: 244.521315ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T05:39:06.954427Z","caller":"traceutil/trace.go:171","msg":"trace[951280845] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"144.785372ms","start":"2026-05-12T05:39:06.809624Z","end":"2026-05-12T05:39:06.954409Z","steps":["trace[951280845] 'read index received' (duration: 144.452119ms)","trace[951280845] 'applied index is now lower than readState.Index' (duration: 332.283µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:39:06.954492Z","caller":"traceutil/trace.go:171","msg":"trace[1101153577] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"170.328432ms","start":"2026-05-12T05:39:06.784136Z","end":"2026-05-12T05:39:06.954464Z","steps":["trace[1101153577] 'process raft request' (duration: 169.929466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:06.954655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.940448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-12T05:39:06.954724Z","caller":"traceutil/trace.go:171","msg":"trace[1923513918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:633; }","duration":"117.045653ms","start":"2026-05-12T05:39:06.837661Z","end":"2026-05-12T05:39:06.954707Z","steps":["trace[1923513918] 'agreement among raft nodes before linearized reading' (duration: 116.927938ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:06.954761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.297783ms","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-05-12T05:39:06.95493Z","caller":"traceutil/trace.go:171","msg":"trace[2087302513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:633; }","duration":"117.654968ms","start":"2026-05-12T05:39:06.837258Z","end":"2026-05-12T05:39:06.954913Z","steps":["trace[2087302513] 'agreement among raft nodes before linearized reading' (duration: 117.273012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:06.954669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.008051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-12T05:39:06.95513Z","caller":"traceutil/trace.go:171","msg":"trace[1791521065] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:633; }","duration":"145.549533ms","start":"2026-05-12T05:39:06.809569Z","end":"2026-05-12T05:39:06.955119Z","steps":["trace[1791521065] 'agreement among raft nodes before linearized reading' (duration: 144.929768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:08.04879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.861842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T05:39:08.048882Z","caller":"traceutil/trace.go:171","msg":"trace[981278179] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"738.012698ms","start":"2026-05-12T05:39:07.310848Z","end":"2026-05-12T05:39:08.048861Z","steps":["trace[981278179] 'range keys from in-memory index tree' (duration: 737.673805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:08.048927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:07.310825Z","time spent":"738.092381ms","remote":"127.0.0.1:36072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-12T05:39:10.184351Z","caller":"traceutil/trace.go:171","msg":"trace[73580398] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"280.071939ms","start":"2026-05-12T05:39:09.904247Z","end":"2026-05-12T05:39:10.184319Z","steps":["trace[73580398] 'process raft request' (duration: 279.8433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:23.760932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.321877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T05:39:23.761037Z","caller":"traceutil/trace.go:171","msg":"trace[203968024] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"651.940274ms","start":"2026-05-12T05:39:23.109079Z","end":"2026-05-12T05:39:23.76102Z","steps":["trace[203968024] 'read index received' (duration: 483.351338ms)","trace[203968024] 'applied index is now lower than readState.Index' (duration: 168.587556ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:39:23.7611Z","caller":"traceutil/trace.go:171","msg":"trace[978214646] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"695.898642ms","start":"2026-05-12T05:39:23.065151Z","end":"2026-05-12T05:39:23.76105Z","steps":["trace[978214646] 'process raft request' (duration: 527.356218ms)","trace[978214646] 'compare' (duration: 167.963375ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T05:39:23.761224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.218266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-12T05:39:23.76126Z","caller":"traceutil/trace.go:171","msg":"trace[1913064146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:788; }","duration":"650.293328ms","start":"2026-05-12T05:39:23.110958Z","end":"2026-05-12T05:39:23.761251Z","steps":["trace[1913064146] 'agreement among raft nodes before linearized reading' (duration: 650.156683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:23.761269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:23.065135Z","time spent":"696.052737ms","remote":"127.0.0.1:36340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T05:39:23.761291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:23.110938Z","time spent":"650.34617ms","remote":"127.0.0.1:36340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-12T05:39:23.761334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.148731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-12T05:39:23.761414Z","caller":"traceutil/trace.go:171","msg":"trace[822188625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:788; }","duration":"652.340738ms","start":"2026-05-12T05:39:23.109055Z","end":"2026-05-12T05:39:23.761395Z","steps":["trace[822188625] 'agreement among raft nodes before linearized reading' (duration: 652.037578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:23.761481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:23.109045Z","time spent":"652.42307ms","remote":"127.0.0.1:36340","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-05-12T05:39:23.761301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.968147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-12T05:39:23.762244Z","caller":"traceutil/trace.go:171","msg":"trace[1030916005] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:788; }","duration":"650.899219ms","start":"2026-05-12T05:39:23.111296Z","end":"2026-05-12T05:39:23.762196Z","steps":["trace[1030916005] 'agreement among raft nodes before linearized reading' (duration: 649.882255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T05:39:23.7624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T05:39:23.111282Z","time spent":"651.027983ms","remote":"127.0.0.1:36340","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-05-12T05:40:19.640946Z","caller":"traceutil/trace.go:171","msg":"trace[569734797] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"201.657393ms","start":"2026-05-12T05:40:19.439263Z","end":"2026-05-12T05:40:19.640921Z","steps":["trace[569734797] 'process raft request' (duration: 189.977343ms)","trace[569734797] 'compare' (duration: 11.580108ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T05:40:20.18509Z","caller":"traceutil/trace.go:171","msg":"trace[421129019] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"109.994204ms","start":"2026-05-12T05:40:20.075072Z","end":"2026-05-12T05:40:20.185066Z","steps":["trace[421129019] 'process raft request' (duration: 104.64748ms)"],"step_count":1}