{"level":"warn","ts":"2026-02-12T16:48:25.07978Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-12T16:48:25.079881Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.143: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.143:2380","--initial-cluster=instance=https://199.19.213.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.143:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-12T16:48:25.07996Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-12T16:48:25.079969Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-02-12T16:48:25.079985Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-12T16:48:25.080595Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"]} {"level":"info","ts":"2026-02-12T16:48:25.080669Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.143:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-12T16:48:25.086918Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.047388ms"} {"level":"info","ts":"2026-02-12T16:48:25.107695Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e5bed6df0e44a0b1","cluster-id":"4e2f0a715964d622"} {"level":"info","ts":"2026-02-12T16:48:25.107787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=()"} {"level":"info","ts":"2026-02-12T16:48:25.107809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became follower at term 0"} {"level":"info","ts":"2026-02-12T16:48:25.107833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e5bed6df0e44a0b1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-12T16:48:25.107842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became follower at term 1"} {"level":"info","ts":"2026-02-12T16:48:25.107877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"warn","ts":"2026-02-12T16:48:25.143846Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-12T16:48:25.151254Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-12T16:48:25.160996Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-02-12T16:48:25.163235Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e5bed6df0e44a0b1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-12T16:48:25.16364Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e5bed6df0e44a0b1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-12T16:48:25.163757Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-12T16:48:25.163776Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-12T16:48:25.163784Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-02-12T16:48:25.165444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 switched to configuration voters=(16554905533765951665)"} {"level":"info","ts":"2026-02-12T16:48:25.16564Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","added-peer-id":"e5bed6df0e44a0b1","added-peer-peer-urls":["https://199.19.213.143:2380"]} {"level":"info","ts":"2026-02-12T16:48:25.181098Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-02-12T16:48:25.185463Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-02-12T16:48:25.185559Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.143:2380"} {"level":"info","ts":"2026-02-12T16:48:25.186582Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e5bed6df0e44a0b1","initial-advertise-peer-urls":["https://199.19.213.143:2380"],"listen-peer-urls":["https://199.19.213.143:2380"],"advertise-client-urls":["https://199.19.213.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-12T16:48:25.186616Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-12T16:48:25.708727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 is starting a new election at term 1"} {"level":"info","ts":"2026-02-12T16:48:25.708845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-12T16:48:25.70888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 received MsgPreVoteResp from e5bed6df0e44a0b1 at term 1"} {"level":"info","ts":"2026-02-12T16:48:25.708947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became candidate at term 2"} {"level":"info","ts":"2026-02-12T16:48:25.708986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 received MsgVoteResp from e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-02-12T16:48:25.70901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e5bed6df0e44a0b1 became leader at term 2"} {"level":"info","ts":"2026-02-12T16:48:25.709031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e5bed6df0e44a0b1 elected leader e5bed6df0e44a0b1 at term 2"} {"level":"info","ts":"2026-02-12T16:48:25.713338Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T16:48:25.714466Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e5bed6df0e44a0b1","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.143:2379]}","request-path":"/0/members/e5bed6df0e44a0b1/attributes","cluster-id":"4e2f0a715964d622","publish-timeout":"7s"} {"level":"info","ts":"2026-02-12T16:48:25.715575Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4e2f0a715964d622","local-member-id":"e5bed6df0e44a0b1","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T16:48:25.715643Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T16:48:25.715723Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T16:48:25.715836Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T16:48:25.715854Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T16:48:25.717687Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-12T16:48:25.717775Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-12T16:48:25.723283Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-12T16:48:25.729209Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.143:2379"} {"level":"warn","ts":"2026-02-12T16:48:31.257463Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.125232813s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-12T16:48:31.609784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477241773s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T16:48:31.609917Z","caller":"traceutil/trace.go:171","msg":"trace[2139850479] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"1.651795683s","start":"2026-02-12T16:48:29.958109Z","end":"2026-02-12T16:48:31.609905Z","steps":["trace[2139850479] 'process raft request' (duration: 1.651741473s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:31.609959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:48:29.958086Z","time spent":"1.651857634s","remote":"127.0.0.1:36090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":985,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T16:48:31.610131Z","caller":"traceutil/trace.go:171","msg":"trace[296648649] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"1.771824226s","start":"2026-02-12T16:48:29.838301Z","end":"2026-02-12T16:48:31.610125Z","steps":["trace[296648649] 'process raft request' (duration: 293.904228ms)","trace[296648649] 'compare' (duration: 1.476997231s)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:48:31.610158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:48:29.838284Z","time spent":"1.771858206s","remote":"127.0.0.1:36246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T16:48:31.610211Z","caller":"traceutil/trace.go:171","msg":"trace[413046521] linearizableReadLoop","detail":"{readStateIndex:248; appliedIndex:247; }","duration":"1.771711204s","start":"2026-02-12T16:48:29.838495Z","end":"2026-02-12T16:48:31.610207Z","steps":["trace[413046521] 'read index received' (duration: 293.719915ms)","trace[413046521] 'applied index is now lower than readState.Index' (duration: 1.477990759s)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:48:31.610439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.771811454s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:48:31.610463Z","caller":"traceutil/trace.go:171","msg":"trace[920082137] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:0; response_revision:241; }","duration":"1.771984477s","start":"2026-02-12T16:48:29.838473Z","end":"2026-02-12T16:48:31.610458Z","steps":["trace[920082137] 'agreement among raft nodes before linearized reading' (duration: 1.771819275s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:31.610479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:48:29.838464Z","time spent":"1.772011247s","remote":"127.0.0.1:36170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-02-12T16:48:31.610625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.332192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:48:31.610753Z","caller":"traceutil/trace.go:171","msg":"trace[887261346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:241; }","duration":"970.535854ms","start":"2026-02-12T16:48:30.640197Z","end":"2026-02-12T16:48:31.610733Z","steps":["trace[887261346] 'agreement among raft nodes before linearized reading' (duration: 970.344812ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:31.610861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:48:30.640174Z","time spent":"970.673944ms","remote":"127.0.0.1:36246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-12T16:48:31.950125Z","caller":"traceutil/trace.go:171","msg":"trace[55043795] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"325.951659ms","start":"2026-02-12T16:48:31.624152Z","end":"2026-02-12T16:48:31.950103Z","steps":["trace[55043795] 'process raft request' (duration: 325.913329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:31.950769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:48:31.624146Z","time spent":"326.569975ms","remote":"127.0.0.1:36246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T16:48:31.950605Z","caller":"traceutil/trace.go:171","msg":"trace[1901913619] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"328.651081ms","start":"2026-02-12T16:48:31.621944Z","end":"2026-02-12T16:48:31.950595Z","steps":["trace[1901913619] 'process raft request' (duration: 322.896886ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:31.951313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:48:31.621931Z","time spent":"329.359516ms","remote":"127.0.0.1:36170","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T16:48:31.951515Z","caller":"traceutil/trace.go:171","msg":"trace[1281798780] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"328.60576ms","start":"2026-02-12T16:48:31.6229Z","end":"2026-02-12T16:48:31.951505Z","steps":["trace[1281798780] 'process raft request' (duration: 327.116758ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:31.951554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:48:31.622894Z","time spent":"328.64297ms","remote":"127.0.0.1:36304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-12T16:48:35.128621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.386998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-12T16:48:35.128681Z","caller":"traceutil/trace.go:171","msg":"trace[1256393172] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:330; }","duration":"172.495689ms","start":"2026-02-12T16:48:34.956174Z","end":"2026-02-12T16:48:35.12867Z","steps":["trace[1256393172] 'range keys from in-memory index tree' (duration: 172.281488ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:36.617629Z","caller":"traceutil/trace.go:171","msg":"trace[117829236] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"103.427151ms","start":"2026-02-12T16:48:36.514185Z","end":"2026-02-12T16:48:36.617612Z","steps":["trace[117829236] 'process raft request' (duration: 103.029598ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:36.781044Z","caller":"traceutil/trace.go:171","msg":"trace[530694169] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"146.284872ms","start":"2026-02-12T16:48:36.634733Z","end":"2026-02-12T16:48:36.781017Z","steps":["trace[530694169] 'process raft request' (duration: 98.655248ms)","trace[530694169] 'compare' (duration: 47.261044ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:36.7813Z","caller":"traceutil/trace.go:171","msg":"trace[516108775] linearizableReadLoop","detail":"{readStateIndex:359; appliedIndex:357; }","duration":"124.568409ms","start":"2026-02-12T16:48:36.65656Z","end":"2026-02-12T16:48:36.781129Z","steps":["trace[516108775] 'read index received' (duration: 58.222349ms)","trace[516108775] 'applied index is now lower than readState.Index' (duration: 66.34472ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:48:36.78224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.661341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-12T16:48:36.782294Z","caller":"traceutil/trace.go:171","msg":"trace[785350695] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:348; }","duration":"125.758153ms","start":"2026-02-12T16:48:36.656522Z","end":"2026-02-12T16:48:36.78228Z","steps":["trace[785350695] 'agreement among raft nodes before linearized reading' (duration: 125.612759ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:36.784062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.515859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"} {"level":"info","ts":"2026-02-12T16:48:36.784295Z","caller":"traceutil/trace.go:171","msg":"trace[1436445142] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:348; }","duration":"119.771406ms","start":"2026-02-12T16:48:36.664509Z","end":"2026-02-12T16:48:36.78428Z","steps":["trace[1436445142] 'agreement among raft nodes before linearized reading' (duration: 119.478557ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:36.955843Z","caller":"traceutil/trace.go:171","msg":"trace[418438382] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:361; }","duration":"148.350344ms","start":"2026-02-12T16:48:36.807476Z","end":"2026-02-12T16:48:36.955826Z","steps":["trace[418438382] 'read index received' (duration: 103.204285ms)","trace[418438382] 'applied index is now lower than readState.Index' (duration: 45.145249ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:36.956017Z","caller":"traceutil/trace.go:171","msg":"trace[302092512] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"165.324348ms","start":"2026-02-12T16:48:36.790681Z","end":"2026-02-12T16:48:36.956005Z","steps":["trace[302092512] 'process raft request' (duration: 119.945691ms)","trace[302092512] 'compare' (duration: 44.931974ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:36.956218Z","caller":"traceutil/trace.go:171","msg":"trace[345911194] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"164.670718ms","start":"2026-02-12T16:48:36.791539Z","end":"2026-02-12T16:48:36.95621Z","steps":["trace[345911194] 'process raft request' (duration: 164.112361ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:36.956438Z","caller":"traceutil/trace.go:171","msg":"trace[104983224] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"163.015129ms","start":"2026-02-12T16:48:36.793413Z","end":"2026-02-12T16:48:36.956428Z","steps":["trace[104983224] 'process raft request' (duration: 162.273007ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:36.956588Z","caller":"traceutil/trace.go:171","msg":"trace[397621838] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"149.228451ms","start":"2026-02-12T16:48:36.807351Z","end":"2026-02-12T16:48:36.95658Z","steps":["trace[397621838] 'process raft request' (duration: 148.440476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:36.956724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.236851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-12T16:48:36.956792Z","caller":"traceutil/trace.go:171","msg":"trace[1382462571] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:353; }","duration":"149.345045ms","start":"2026-02-12T16:48:36.807409Z","end":"2026-02-12T16:48:36.956754Z","steps":["trace[1382462571] 'agreement among raft nodes before linearized reading' (duration: 149.269892ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:36.956923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.587776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-12T16:48:36.956956Z","caller":"traceutil/trace.go:171","msg":"trace[1801426760] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:353; }","duration":"100.644657ms","start":"2026-02-12T16:48:36.856304Z","end":"2026-02-12T16:48:36.956948Z","steps":["trace[1801426760] 'agreement among raft nodes before linearized reading' (duration: 100.591616ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.228207Z","caller":"traceutil/trace.go:171","msg":"trace[1903933461] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"256.683057ms","start":"2026-02-12T16:48:36.971499Z","end":"2026-02-12T16:48:37.228182Z","steps":["trace[1903933461] 'process raft request' (duration: 227.027166ms)","trace[1903933461] 'compare' (duration: 28.60303ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:37.228829Z","caller":"traceutil/trace.go:171","msg":"trace[2026324000] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"253.05238ms","start":"2026-02-12T16:48:36.975764Z","end":"2026-02-12T16:48:37.228816Z","steps":["trace[2026324000] 'process raft request' (duration: 252.381139ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.229458Z","caller":"traceutil/trace.go:171","msg":"trace[1617344507] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"253.567555ms","start":"2026-02-12T16:48:36.975874Z","end":"2026-02-12T16:48:37.229442Z","steps":["trace[1617344507] 'process raft request' (duration: 252.871635ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.229871Z","caller":"traceutil/trace.go:171","msg":"trace[378641106] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"252.7638ms","start":"2026-02-12T16:48:36.977096Z","end":"2026-02-12T16:48:37.22986Z","steps":["trace[378641106] 'process raft request' (duration: 252.156743ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.229732Z","caller":"traceutil/trace.go:171","msg":"trace[978678061] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:365; }","duration":"222.947798ms","start":"2026-02-12T16:48:37.006769Z","end":"2026-02-12T16:48:37.229717Z","steps":["trace[978678061] 'read index received' (duration: 2.567565ms)","trace[978678061] 'applied index is now lower than readState.Index' (duration: 220.379323ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:48:37.23022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.432952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-12T16:48:37.230281Z","caller":"traceutil/trace.go:171","msg":"trace[555737401] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:358; }","duration":"223.537935ms","start":"2026-02-12T16:48:37.006732Z","end":"2026-02-12T16:48:37.23027Z","steps":["trace[555737401] 'agreement among raft nodes before linearized reading' (duration: 223.35805ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.243878Z","caller":"traceutil/trace.go:171","msg":"trace[1504730915] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"232.453997ms","start":"2026-02-12T16:48:37.0114Z","end":"2026-02-12T16:48:37.243854Z","steps":["trace[1504730915] 'process raft request' (duration: 232.302003ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.40092Z","caller":"traceutil/trace.go:171","msg":"trace[544497623] linearizableReadLoop","detail":"{readStateIndex:378; appliedIndex:371; }","duration":"151.757506ms","start":"2026-02-12T16:48:37.249146Z","end":"2026-02-12T16:48:37.400903Z","steps":["trace[544497623] 'read index received' (duration: 107.325011ms)","trace[544497623] 'applied index is now lower than readState.Index' (duration: 44.431835ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:37.401409Z","caller":"traceutil/trace.go:171","msg":"trace[770694796] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"162.853612ms","start":"2026-02-12T16:48:37.23854Z","end":"2026-02-12T16:48:37.401393Z","steps":["trace[770694796] 'process raft request' (duration: 117.923013ms)","trace[770694796] 'compare' (duration: 44.134956ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:37.401967Z","caller":"traceutil/trace.go:171","msg":"trace[1605825317] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"161.265335ms","start":"2026-02-12T16:48:37.240668Z","end":"2026-02-12T16:48:37.401933Z","steps":["trace[1605825317] 'process raft request' (duration: 160.132492ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.402468Z","caller":"traceutil/trace.go:171","msg":"trace[436543289] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"153.442626ms","start":"2026-02-12T16:48:37.249011Z","end":"2026-02-12T16:48:37.402454Z","steps":["trace[436543289] 'process raft request' (duration: 151.87157ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:37.402947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.784976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-12T16:48:37.408615Z","caller":"traceutil/trace.go:171","msg":"trace[77764992] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:366; }","duration":"159.475924ms","start":"2026-02-12T16:48:37.249122Z","end":"2026-02-12T16:48:37.408598Z","steps":["trace[77764992] 'agreement among raft nodes before linearized reading' (duration: 153.768196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:37.403405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.149217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:48:37.404014Z","caller":"traceutil/trace.go:171","msg":"trace[302070052] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"165.359096ms","start":"2026-02-12T16:48:37.238635Z","end":"2026-02-12T16:48:37.403994Z","steps":["trace[302070052] 'process raft request' (duration: 162.07638ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.404187Z","caller":"traceutil/trace.go:171","msg":"trace[1669250217] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"164.747638ms","start":"2026-02-12T16:48:37.239424Z","end":"2026-02-12T16:48:37.404172Z","steps":["trace[1669250217] 'process raft request' (duration: 161.322448ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.402Z","caller":"traceutil/trace.go:171","msg":"trace[770023269] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"160.632248ms","start":"2026-02-12T16:48:37.241354Z","end":"2026-02-12T16:48:37.401986Z","steps":["trace[770023269] 'process raft request' (duration: 159.494924ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.404372Z","caller":"traceutil/trace.go:171","msg":"trace[2113239452] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"163.724137ms","start":"2026-02-12T16:48:37.240632Z","end":"2026-02-12T16:48:37.404356Z","steps":["trace[2113239452] 'process raft request' (duration: 160.141113ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.409197Z","caller":"traceutil/trace.go:171","msg":"trace[547209143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:366; }","duration":"127.026971ms","start":"2026-02-12T16:48:37.282158Z","end":"2026-02-12T16:48:37.409185Z","steps":["trace[547209143] 'agreement among raft nodes before linearized reading' (duration: 121.192749ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.621039Z","caller":"traceutil/trace.go:171","msg":"trace[1740812529] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"123.300301ms","start":"2026-02-12T16:48:37.497724Z","end":"2026-02-12T16:48:37.621024Z","steps":["trace[1740812529] 'process raft request' (duration: 123.26109ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.621478Z","caller":"traceutil/trace.go:171","msg":"trace[1661051137] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"201.058305ms","start":"2026-02-12T16:48:37.420409Z","end":"2026-02-12T16:48:37.621467Z","steps":["trace[1661051137] 'process raft request' (duration: 200.213661ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.621582Z","caller":"traceutil/trace.go:171","msg":"trace[204379932] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"203.355042ms","start":"2026-02-12T16:48:37.417318Z","end":"2026-02-12T16:48:37.620673Z","steps":["trace[204379932] 'process raft request' (duration: 164.505881ms)","trace[204379932] 'compare' (duration: 38.696207ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:37.621943Z","caller":"traceutil/trace.go:171","msg":"trace[735731817] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"199.958912ms","start":"2026-02-12T16:48:37.421973Z","end":"2026-02-12T16:48:37.621932Z","steps":["trace[735731817] 'process raft request' (duration: 198.897551ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.622084Z","caller":"traceutil/trace.go:171","msg":"trace[145361661] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:379; }","duration":"201.56969ms","start":"2026-02-12T16:48:37.420502Z","end":"2026-02-12T16:48:37.622071Z","steps":["trace[145361661] 'read index received' (duration: 70.987194ms)","trace[145361661] 'applied index is now lower than readState.Index' (duration: 130.580976ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:48:37.622706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.186237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7237"} {"level":"info","ts":"2026-02-12T16:48:37.623464Z","caller":"traceutil/trace.go:171","msg":"trace[183413102] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:373; }","duration":"202.967792ms","start":"2026-02-12T16:48:37.420484Z","end":"2026-02-12T16:48:37.623452Z","steps":["trace[183413102] 'agreement among raft nodes before linearized reading' (duration: 202.168308ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.622186Z","caller":"traceutil/trace.go:171","msg":"trace[1626243083] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"200.091996ms","start":"2026-02-12T16:48:37.422085Z","end":"2026-02-12T16:48:37.622177Z","steps":["trace[1626243083] 'process raft request' (duration: 198.834309ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:37.622947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.394724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-02-12T16:48:37.62439Z","caller":"traceutil/trace.go:171","msg":"trace[1417432368] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:373; }","duration":"203.690292ms","start":"2026-02-12T16:48:37.42053Z","end":"2026-02-12T16:48:37.62422Z","steps":["trace[1417432368] 'agreement among raft nodes before linearized reading' (duration: 202.354772ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:37.623073Z","caller":"traceutil/trace.go:171","msg":"trace[1852834840] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"200.068045ms","start":"2026-02-12T16:48:37.422994Z","end":"2026-02-12T16:48:37.623062Z","steps":["trace[1852834840] 'process raft request' (duration: 197.956224ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:37.784557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.90936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T16:48:37.785683Z","caller":"traceutil/trace.go:171","msg":"trace[2131460329] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:384; }","duration":"123.037083ms","start":"2026-02-12T16:48:37.662627Z","end":"2026-02-12T16:48:37.785665Z","steps":["trace[2131460329] 'agreement among raft nodes before linearized reading' (duration: 121.889759ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:46.433302Z","caller":"traceutil/trace.go:171","msg":"trace[1683511712] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"121.213257ms","start":"2026-02-12T16:48:46.312035Z","end":"2026-02-12T16:48:46.433248Z","steps":["trace[1683511712] 'process raft request' (duration: 120.95566ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:47.102289Z","caller":"traceutil/trace.go:171","msg":"trace[1086910268] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"126.144961ms","start":"2026-02-12T16:48:46.97612Z","end":"2026-02-12T16:48:47.102265Z","steps":["trace[1086910268] 'process raft request' (duration: 125.68968ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:47.449011Z","caller":"traceutil/trace.go:171","msg":"trace[1285382788] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:447; }","duration":"102.224262ms","start":"2026-02-12T16:48:47.346772Z","end":"2026-02-12T16:48:47.448996Z","steps":["trace[1285382788] 'read index received' (duration: 102.14641ms)","trace[1285382788] 'applied index is now lower than readState.Index' (duration: 77.142µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:47.449088Z","caller":"traceutil/trace.go:171","msg":"trace[2127859877] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"102.544621ms","start":"2026-02-12T16:48:47.346539Z","end":"2026-02-12T16:48:47.449083Z","steps":["trace[2127859877] 'process raft request' (duration: 102.377286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:47.449304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.519591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-77cccfdc44\" ","response":"range_response_count:1 size:3788"} {"level":"info","ts":"2026-02-12T16:48:47.449326Z","caller":"traceutil/trace.go:171","msg":"trace[757097087] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-77cccfdc44; range_end:; response_count:1; response_revision:433; }","duration":"102.581552ms","start":"2026-02-12T16:48:47.346738Z","end":"2026-02-12T16:48:47.44932Z","steps":["trace[757097087] 'agreement among raft nodes before linearized reading' (duration: 102.51548ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:47.449407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.597933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4173"} {"level":"info","ts":"2026-02-12T16:48:47.44942Z","caller":"traceutil/trace.go:171","msg":"trace[1521887301] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:433; }","duration":"102.622963ms","start":"2026-02-12T16:48:47.346793Z","end":"2026-02-12T16:48:47.449416Z","steps":["trace[1521887301] 'agreement among raft nodes before linearized reading' (duration: 102.597183ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:58.73242Z","caller":"traceutil/trace.go:171","msg":"trace[2058652282] linearizableReadLoop","detail":"{readStateIndex:498; appliedIndex:496; }","duration":"135.086041ms","start":"2026-02-12T16:48:58.597308Z","end":"2026-02-12T16:48:58.732394Z","steps":["trace[2058652282] 'read index received' (duration: 706.646µs)","trace[2058652282] 'applied index is now lower than readState.Index' (duration: 134.378155ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:48:58.73258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.241315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12665"} {"level":"info","ts":"2026-02-12T16:48:58.732618Z","caller":"traceutil/trace.go:171","msg":"trace[1392315028] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:480; }","duration":"135.309576ms","start":"2026-02-12T16:48:58.597296Z","end":"2026-02-12T16:48:58.732605Z","steps":["trace[1392315028] 'agreement among raft nodes before linearized reading' (duration: 135.195424ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:58.732599Z","caller":"traceutil/trace.go:171","msg":"trace[1635920611] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"136.095376ms","start":"2026-02-12T16:48:58.596463Z","end":"2026-02-12T16:48:58.732558Z","steps":["trace[1635920611] 'process raft request' (duration: 102.004508ms)","trace[1635920611] 'compare' (duration: 33.798981ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:59.578619Z","caller":"traceutil/trace.go:171","msg":"trace[1928831636] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"108.421946ms","start":"2026-02-12T16:48:59.470154Z","end":"2026-02-12T16:48:59.578576Z","steps":["trace[1928831636] 'process raft request' (duration: 107.982286ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:48:59.876528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.094581ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-12T16:48:59.876616Z","caller":"traceutil/trace.go:171","msg":"trace[1071353075] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"165.569196ms","start":"2026-02-12T16:48:59.711034Z","end":"2026-02-12T16:48:59.876603Z","steps":["trace[1071353075] 'process raft request' (duration: 30.350202ms)","trace[1071353075] 'compare' (duration: 134.988729ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:48:59.886163Z","caller":"traceutil/trace.go:171","msg":"trace[1463984042] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"157.477208ms","start":"2026-02-12T16:48:59.728667Z","end":"2026-02-12T16:48:59.886145Z","steps":["trace[1463984042] 'process raft request' (duration: 157.431747ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:59.886571Z","caller":"traceutil/trace.go:171","msg":"trace[54745092] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"163.817076ms","start":"2026-02-12T16:48:59.722747Z","end":"2026-02-12T16:48:59.886564Z","steps":["trace[54745092] 'process raft request' (duration: 163.099279ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:59.886657Z","caller":"traceutil/trace.go:171","msg":"trace[491879071] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"163.738094ms","start":"2026-02-12T16:48:59.722913Z","end":"2026-02-12T16:48:59.886651Z","steps":["trace[491879071] 'process raft request' (duration: 163.016908ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:59.886954Z","caller":"traceutil/trace.go:171","msg":"trace[1331009721] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"163.953489ms","start":"2026-02-12T16:48:59.722993Z","end":"2026-02-12T16:48:59.886947Z","steps":["trace[1331009721] 'process raft request' (duration: 162.970166ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:59.887287Z","caller":"traceutil/trace.go:171","msg":"trace[648329563] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"163.699902ms","start":"2026-02-12T16:48:59.723581Z","end":"2026-02-12T16:48:59.887281Z","steps":["trace[648329563] 'process raft request' (duration: 162.412452ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:59.887364Z","caller":"traceutil/trace.go:171","msg":"trace[1458199284] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"163.555489ms","start":"2026-02-12T16:48:59.723803Z","end":"2026-02-12T16:48:59.887359Z","steps":["trace[1458199284] 'process raft request' (duration: 162.221658ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:48:59.940709Z","caller":"traceutil/trace.go:171","msg":"trace[1133556040] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"190.47161ms","start":"2026-02-12T16:48:59.750215Z","end":"2026-02-12T16:48:59.940687Z","steps":["trace[1133556040] 'process raft request' (duration: 187.538981ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:02.192357Z","caller":"traceutil/trace.go:171","msg":"trace[1969018279] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"104.562535ms","start":"2026-02-12T16:49:02.087768Z","end":"2026-02-12T16:49:02.192331Z","steps":["trace[1969018279] 'process raft request' (duration: 104.237438ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:02.967861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.17252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T16:49:02.967919Z","caller":"traceutil/trace.go:171","msg":"trace[735476411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:522; }","duration":"214.274032ms","start":"2026-02-12T16:49:02.75363Z","end":"2026-02-12T16:49:02.967904Z","steps":["trace[735476411] 'range keys from in-memory index tree' (duration: 214.068757ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:02.968578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.727249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T16:49:02.968646Z","caller":"traceutil/trace.go:171","msg":"trace[681936740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:522; }","duration":"355.83945ms","start":"2026-02-12T16:49:02.612792Z","end":"2026-02-12T16:49:02.968632Z","steps":["trace[681936740] 'range keys from in-memory index tree' (duration: 355.629906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:02.968695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:02.612776Z","time spent":"355.912993ms","remote":"127.0.0.1:36246","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-02-12T16:49:09.892769Z","caller":"traceutil/trace.go:171","msg":"trace[1558964866] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:583; }","duration":"139.334182ms","start":"2026-02-12T16:49:09.753418Z","end":"2026-02-12T16:49:09.892752Z","steps":["trace[1558964866] 'read index received' (duration: 139.21691ms)","trace[1558964866] 'applied index is now lower than readState.Index' (duration: 116.412µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:09.892957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.517356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-l2gw6\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-12T16:49:09.892984Z","caller":"traceutil/trace.go:171","msg":"trace[59795246] range","detail":"{range_begin:/registry/pods/kube-system/cilium-l2gw6; range_end:; response_count:1; response_revision:563; }","duration":"139.589228ms","start":"2026-02-12T16:49:09.753388Z","end":"2026-02-12T16:49:09.892977Z","steps":["trace[59795246] 'agreement among raft nodes before linearized reading' (duration: 139.436285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:10.392801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.833651ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T16:49:10.392882Z","caller":"traceutil/trace.go:171","msg":"trace[1561667625] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"498.224658ms","start":"2026-02-12T16:49:09.894645Z","end":"2026-02-12T16:49:10.39287Z","steps":["trace[1561667625] 'process raft request' (duration: 279.265694ms)","trace[1561667625] 'compare' (duration: 218.608037ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:10.392921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:09.894631Z","time spent":"498.269109ms","remote":"127.0.0.1:36028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T16:49:10.420371Z","caller":"traceutil/trace.go:171","msg":"trace[1020674744] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"517.970415ms","start":"2026-02-12T16:49:09.902391Z","end":"2026-02-12T16:49:10.420362Z","steps":["trace[1020674744] 'process raft request' (duration: 517.595197ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:10.420468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:09.902383Z","time spent":"518.025686ms","remote":"127.0.0.1:36166","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T16:49:10.420148Z","caller":"traceutil/trace.go:171","msg":"trace[1564577204] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:584; }","duration":"327.520886ms","start":"2026-02-12T16:49:10.092611Z","end":"2026-02-12T16:49:10.420132Z","steps":["trace[1564577204] 'read index received' (duration: 81.374576ms)","trace[1564577204] 'applied index is now lower than readState.Index' (duration: 246.14568ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:10.42076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.083086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-12T16:49:10.420787Z","caller":"traceutil/trace.go:171","msg":"trace[1545870287] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:565; }","duration":"194.140547ms","start":"2026-02-12T16:49:10.226638Z","end":"2026-02-12T16:49:10.420779Z","steps":["trace[1545870287] 'agreement among raft nodes before linearized reading' (duration: 194.057965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:10.421077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.470387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:49:10.421102Z","caller":"traceutil/trace.go:171","msg":"trace[1465314854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"328.524087ms","start":"2026-02-12T16:49:10.092572Z","end":"2026-02-12T16:49:10.421096Z","steps":["trace[1465314854] 'agreement among raft nodes before linearized reading' (duration: 328.103869ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:10.421119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:10.092556Z","time spent":"328.559309ms","remote":"127.0.0.1:36022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T16:49:10.930579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11579207996185254101,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-12T16:49:11.684453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.749154ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T16:49:11.684528Z","caller":"traceutil/trace.go:171","msg":"trace[668985937] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:586; }","duration":"1.254142482s","start":"2026-02-12T16:49:10.430374Z","end":"2026-02-12T16:49:11.684516Z","steps":["trace[668985937] 'read index received' (duration: 589.208254ms)","trace[668985937] 'applied index is now lower than readState.Index' (duration: 664.933368ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:11.684687Z","caller":"traceutil/trace.go:171","msg":"trace[649494765] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"1.254517681s","start":"2026-02-12T16:49:10.430159Z","end":"2026-02-12T16:49:11.684677Z","steps":["trace[649494765] 'process raft request' (duration: 589.482361ms)","trace[649494765] 'compare' (duration: 664.577881ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:11.684728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:10.430147Z","time spent":"1.254558332s","remote":"127.0.0.1:36246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T16:49:11.68488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.254501849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-02-12T16:49:11.684899Z","caller":"traceutil/trace.go:171","msg":"trace[410357121] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:566; }","duration":"1.25452037s","start":"2026-02-12T16:49:10.430372Z","end":"2026-02-12T16:49:11.684892Z","steps":["trace[410357121] 'agreement among raft nodes before linearized reading' (duration: 1.254480149s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:11.684917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:10.430351Z","time spent":"1.254561741s","remote":"127.0.0.1:36252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-02-12T16:49:11.68505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.254629332s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-12T16:49:11.685079Z","caller":"traceutil/trace.go:171","msg":"trace[101720717] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:566; }","duration":"1.254667093s","start":"2026-02-12T16:49:10.430407Z","end":"2026-02-12T16:49:11.685074Z","steps":["trace[101720717] 'agreement among raft nodes before linearized reading' (duration: 1.254587721s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:11.685107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:10.430404Z","time spent":"1.254699354s","remote":"127.0.0.1:36246","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-02-12T16:49:11.685277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.970496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:49:11.685307Z","caller":"traceutil/trace.go:171","msg":"trace[1195809368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"592.023856ms","start":"2026-02-12T16:49:11.093277Z","end":"2026-02-12T16:49:11.685301Z","steps":["trace[1195809368] 'agreement among raft nodes before linearized reading' (duration: 591.983625ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:11.685325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:11.093261Z","time spent":"592.058347ms","remote":"127.0.0.1:36008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T16:49:11.68543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"637.479572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-12T16:49:11.685451Z","caller":"traceutil/trace.go:171","msg":"trace[1534468150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:566; }","duration":"637.521923ms","start":"2026-02-12T16:49:11.047924Z","end":"2026-02-12T16:49:11.685446Z","steps":["trace[1534468150] 'agreement among raft nodes before linearized reading' (duration: 637.470202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:11.685467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:11.047914Z","time spent":"637.549994ms","remote":"127.0.0.1:36246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-12T16:49:11.685565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.378386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-12T16:49:11.685588Z","caller":"traceutil/trace.go:171","msg":"trace[1797970761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:566; }","duration":"642.432146ms","start":"2026-02-12T16:49:11.043151Z","end":"2026-02-12T16:49:11.685583Z","steps":["trace[1797970761] 'agreement among raft nodes before linearized reading' (duration: 642.379945ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:11.685603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:11.043132Z","time spent":"642.467517ms","remote":"127.0.0.1:36246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-12T16:49:11.890602Z","caller":"traceutil/trace.go:171","msg":"trace[1858617050] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"198.043294ms","start":"2026-02-12T16:49:11.692532Z","end":"2026-02-12T16:49:11.890575Z","steps":["trace[1858617050] 'process raft request' (duration: 197.946292ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:11.891074Z","caller":"traceutil/trace.go:171","msg":"trace[591407113] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"199.560215ms","start":"2026-02-12T16:49:11.691496Z","end":"2026-02-12T16:49:11.891057Z","steps":["trace[591407113] 'process raft request' (duration: 176.983011ms)","trace[591407113] 'compare' (duration: 21.8946ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:12.889658Z","caller":"traceutil/trace.go:171","msg":"trace[1991532921] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"113.28065ms","start":"2026-02-12T16:49:12.776358Z","end":"2026-02-12T16:49:12.889639Z","steps":["trace[1991532921] 'process raft request' (duration: 113.167238ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:13.927182Z","caller":"traceutil/trace.go:171","msg":"trace[664722989] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"144.063536ms","start":"2026-02-12T16:49:13.783104Z","end":"2026-02-12T16:49:13.927167Z","steps":["trace[664722989] 'process raft request' (duration: 143.856212ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:15.314434Z","caller":"traceutil/trace.go:171","msg":"trace[1173564466] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"139.922451ms","start":"2026-02-12T16:49:15.174496Z","end":"2026-02-12T16:49:15.314419Z","steps":["trace[1173564466] 'process raft request' (duration: 139.828779ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:15.623355Z","caller":"traceutil/trace.go:171","msg":"trace[232725749] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"134.432109ms","start":"2026-02-12T16:49:15.488903Z","end":"2026-02-12T16:49:15.623335Z","steps":["trace[232725749] 'process raft request' (duration: 126.961598ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:15.62354Z","caller":"traceutil/trace.go:171","msg":"trace[2115039025] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"133.093942ms","start":"2026-02-12T16:49:15.49043Z","end":"2026-02-12T16:49:15.623524Z","steps":["trace[2115039025] 'process raft request' (duration: 132.845317ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:18.121949Z","caller":"traceutil/trace.go:171","msg":"trace[1908199397] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"152.212438ms","start":"2026-02-12T16:49:17.96972Z","end":"2026-02-12T16:49:18.121932Z","steps":["trace[1908199397] 'read index received' (duration: 92.766772ms)","trace[1908199397] 'applied index is now lower than readState.Index' (duration: 59.445116ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:18.122097Z","caller":"traceutil/trace.go:171","msg":"trace[1641051372] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"167.271349ms","start":"2026-02-12T16:49:17.954819Z","end":"2026-02-12T16:49:18.12209Z","steps":["trace[1641051372] 'process raft request' (duration: 107.721341ms)","trace[1641051372] 'compare' (duration: 59.321974ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:18.122257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.524404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-02-12T16:49:18.122287Z","caller":"traceutil/trace.go:171","msg":"trace[730178941] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"152.579276ms","start":"2026-02-12T16:49:17.969701Z","end":"2026-02-12T16:49:18.12228Z","steps":["trace[730178941] 'agreement among raft nodes before linearized reading' (duration: 152.489684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:18.122411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.663397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T16:49:18.122429Z","caller":"traceutil/trace.go:171","msg":"trace[365386022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:635; }","duration":"152.689757ms","start":"2026-02-12T16:49:17.969735Z","end":"2026-02-12T16:49:18.122425Z","steps":["trace[365386022] 'agreement among raft nodes before linearized reading' (duration: 152.647317ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:18.570134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.553543ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-12T16:49:18.570216Z","caller":"traceutil/trace.go:171","msg":"trace[772065042] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"238.155183ms","start":"2026-02-12T16:49:18.332048Z","end":"2026-02-12T16:49:18.570203Z","steps":["trace[772065042] 'process raft request' (duration: 58.454837ms)","trace[772065042] 'compare' (duration: 179.38418ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:18.638139Z","caller":"traceutil/trace.go:171","msg":"trace[783691795] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"304.151649ms","start":"2026-02-12T16:49:18.333965Z","end":"2026-02-12T16:49:18.638117Z","steps":["trace[783691795] 'process raft request' (duration: 303.611339ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:18.639782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:49:18.333863Z","time spent":"304.340633ms","remote":"127.0.0.1:36040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T16:49:18.640514Z","caller":"traceutil/trace.go:171","msg":"trace[676251929] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:662; }","duration":"269.007714ms","start":"2026-02-12T16:49:18.371491Z","end":"2026-02-12T16:49:18.640499Z","steps":["trace[676251929] 'read index received' (duration: 19.018967ms)","trace[676251929] 'applied index is now lower than readState.Index' (duration: 249.986877ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:18.640887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.387642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-12T16:49:18.641087Z","caller":"traceutil/trace.go:171","msg":"trace[1150040607] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:641; }","duration":"269.510824ms","start":"2026-02-12T16:49:18.371441Z","end":"2026-02-12T16:49:18.640952Z","steps":["trace[1150040607] 'agreement among raft nodes before linearized reading' (duration: 269.156157ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:19.015971Z","caller":"traceutil/trace.go:171","msg":"trace[633880607] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"133.988019ms","start":"2026-02-12T16:49:18.881963Z","end":"2026-02-12T16:49:19.015951Z","steps":["trace[633880607] 'process raft request' (duration: 133.764025ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:19.169655Z","caller":"traceutil/trace.go:171","msg":"trace[584767881] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"171.391455ms","start":"2026-02-12T16:49:18.998237Z","end":"2026-02-12T16:49:19.169628Z","steps":["trace[584767881] 'process raft request' (duration: 171.238112ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:19.170133Z","caller":"traceutil/trace.go:171","msg":"trace[165055942] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"204.136613ms","start":"2026-02-12T16:49:18.965962Z","end":"2026-02-12T16:49:19.170098Z","steps":["trace[165055942] 'process raft request' (duration: 151.346337ms)","trace[165055942] 'compare' (duration: 51.802197ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:19.469087Z","caller":"traceutil/trace.go:171","msg":"trace[294882806] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"134.658813ms","start":"2026-02-12T16:49:19.334411Z","end":"2026-02-12T16:49:19.46907Z","steps":["trace[294882806] 'process raft request' (duration: 134.271406ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:19.635352Z","caller":"traceutil/trace.go:171","msg":"trace[463883561] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"122.405892ms","start":"2026-02-12T16:49:19.512931Z","end":"2026-02-12T16:49:19.635337Z","steps":["trace[463883561] 'read index received' (duration: 84.353446ms)","trace[463883561] 'applied index is now lower than readState.Index' (duration: 38.051926ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:19.63543Z","caller":"traceutil/trace.go:171","msg":"trace[407240465] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"245.962767ms","start":"2026-02-12T16:49:19.389461Z","end":"2026-02-12T16:49:19.635424Z","steps":["trace[407240465] 'process raft request' (duration: 207.88039ms)","trace[407240465] 'compare' (duration: 37.783521ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:19.635788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.841731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-12T16:49:19.635813Z","caller":"traceutil/trace.go:171","msg":"trace[1409152463] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:651; }","duration":"122.903982ms","start":"2026-02-12T16:49:19.512902Z","end":"2026-02-12T16:49:19.635806Z","steps":["trace[1409152463] 'agreement among raft nodes before linearized reading' (duration: 122.769049ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:20.250564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.011418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:49:20.250618Z","caller":"traceutil/trace.go:171","msg":"trace[560517983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:657; }","duration":"156.103329ms","start":"2026-02-12T16:49:20.094503Z","end":"2026-02-12T16:49:20.250607Z","steps":["trace[560517983] 'range keys from in-memory index tree' (duration: 155.963677ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:20.250775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.638687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-12T16:49:20.250793Z","caller":"traceutil/trace.go:171","msg":"trace[1410009231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:657; }","duration":"122.656458ms","start":"2026-02-12T16:49:20.128132Z","end":"2026-02-12T16:49:20.250789Z","steps":["trace[1410009231] 'range keys from in-memory index tree' (duration: 122.546496ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:20.250877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.386688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T16:49:20.250894Z","caller":"traceutil/trace.go:171","msg":"trace[542256637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:657; }","duration":"110.439139ms","start":"2026-02-12T16:49:20.140451Z","end":"2026-02-12T16:49:20.25089Z","steps":["trace[542256637] 'range keys from in-memory index tree' (duration: 110.318997ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:22.180652Z","caller":"traceutil/trace.go:171","msg":"trace[156932231] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"102.278547ms","start":"2026-02-12T16:49:22.07835Z","end":"2026-02-12T16:49:22.180629Z","steps":["trace[156932231] 'process raft request' (duration: 101.87409ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:22.189674Z","caller":"traceutil/trace.go:171","msg":"trace[1651399559] transaction","detail":"{read_only:false; number_of_response:0; response_revision:668; }","duration":"109.563937ms","start":"2026-02-12T16:49:22.080083Z","end":"2026-02-12T16:49:22.189647Z","steps":["trace[1651399559] 'process raft request' (duration: 108.411495ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:22.477064Z","caller":"traceutil/trace.go:171","msg":"trace[1501553064] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"120.506456ms","start":"2026-02-12T16:49:22.356539Z","end":"2026-02-12T16:49:22.477045Z","steps":["trace[1501553064] 'process raft request' (duration: 120.393023ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:22.484447Z","caller":"traceutil/trace.go:171","msg":"trace[1374932543] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"127.664912ms","start":"2026-02-12T16:49:22.356766Z","end":"2026-02-12T16:49:22.484431Z","steps":["trace[1374932543] 'process raft request' (duration: 127.56336ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:23.11983Z","caller":"traceutil/trace.go:171","msg":"trace[1729868472] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"242.883322ms","start":"2026-02-12T16:49:22.876923Z","end":"2026-02-12T16:49:23.119807Z","steps":["trace[1729868472] 'process raft request' (duration: 242.750069ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:24.695996Z","caller":"traceutil/trace.go:171","msg":"trace[866135777] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"172.4695ms","start":"2026-02-12T16:49:24.523502Z","end":"2026-02-12T16:49:24.695972Z","steps":["trace[866135777] 'process raft request' (duration: 171.508472ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:25.03339Z","caller":"traceutil/trace.go:171","msg":"trace[241833920] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"229.738994ms","start":"2026-02-12T16:49:24.803633Z","end":"2026-02-12T16:49:25.033372Z","steps":["trace[241833920] 'process raft request' (duration: 182.736074ms)","trace[241833920] 'compare' (duration: 46.775526ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:25.03862Z","caller":"traceutil/trace.go:171","msg":"trace[1146737104] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"118.816243ms","start":"2026-02-12T16:49:24.919782Z","end":"2026-02-12T16:49:25.038598Z","steps":["trace[1146737104] 'process raft request' (duration: 118.775492ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:25.04035Z","caller":"traceutil/trace.go:171","msg":"trace[1170609097] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"236.511531ms","start":"2026-02-12T16:49:24.803822Z","end":"2026-02-12T16:49:25.040334Z","steps":["trace[1170609097] 'process raft request' (duration: 234.616785ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:25.040524Z","caller":"traceutil/trace.go:171","msg":"trace[1461466093] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"236.813397ms","start":"2026-02-12T16:49:24.803701Z","end":"2026-02-12T16:49:25.040515Z","steps":["trace[1461466093] 'process raft request' (duration: 234.30614ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:25.040862Z","caller":"traceutil/trace.go:171","msg":"trace[380024995] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"236.939489ms","start":"2026-02-12T16:49:24.803914Z","end":"2026-02-12T16:49:25.040853Z","steps":["trace[380024995] 'process raft request' (duration: 234.609835ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:25.043487Z","caller":"traceutil/trace.go:171","msg":"trace[318836998] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"239.594308ms","start":"2026-02-12T16:49:24.803884Z","end":"2026-02-12T16:49:25.043479Z","steps":["trace[318836998] 'process raft request' (duration: 234.606585ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:25.210581Z","caller":"traceutil/trace.go:171","msg":"trace[341490964] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"130.811105ms","start":"2026-02-12T16:49:25.079752Z","end":"2026-02-12T16:49:25.210564Z","steps":["trace[341490964] 'process raft request' (duration: 91.204064ms)","trace[341490964] 'compare' (duration: 39.490919ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:25.329033Z","caller":"traceutil/trace.go:171","msg":"trace[1011629216] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"111.722988ms","start":"2026-02-12T16:49:25.217294Z","end":"2026-02-12T16:49:25.329017Z","steps":["trace[1011629216] 'process raft request' (duration: 98.146854ms)","trace[1011629216] 'compare' (duration: 13.226278ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:25.329406Z","caller":"traceutil/trace.go:171","msg":"trace[1365655051] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"110.21922ms","start":"2026-02-12T16:49:25.219179Z","end":"2026-02-12T16:49:25.329398Z","steps":["trace[1365655051] 'process raft request' (duration: 109.66551ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:25.489446Z","caller":"traceutil/trace.go:171","msg":"trace[1182171142] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"111.696338ms","start":"2026-02-12T16:49:25.377728Z","end":"2026-02-12T16:49:25.489425Z","steps":["trace[1182171142] 'process raft request' (duration: 108.381206ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:26.284838Z","caller":"traceutil/trace.go:171","msg":"trace[1348346717] linearizableReadLoop","detail":"{readStateIndex:728; appliedIndex:727; }","duration":"186.186802ms","start":"2026-02-12T16:49:26.098631Z","end":"2026-02-12T16:49:26.284818Z","steps":["trace[1348346717] 'read index received' (duration: 174.806811ms)","trace[1348346717] 'applied index is now lower than readState.Index' (duration: 11.379281ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:26.284925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.274174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:49:26.284958Z","caller":"traceutil/trace.go:171","msg":"trace[77346757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:702; }","duration":"186.347225ms","start":"2026-02-12T16:49:26.0986Z","end":"2026-02-12T16:49:26.284947Z","steps":["trace[77346757] 'agreement among raft nodes before linearized reading' (duration: 186.277813ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:26.285127Z","caller":"traceutil/trace.go:171","msg":"trace[700683034] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"207.134531ms","start":"2026-02-12T16:49:26.077986Z","end":"2026-02-12T16:49:26.28512Z","steps":["trace[700683034] 'process raft request' (duration: 195.447014ms)","trace[700683034] 'compare' (duration: 11.153607ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:26.555579Z","caller":"traceutil/trace.go:171","msg":"trace[1852921115] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"245.413691ms","start":"2026-02-12T16:49:26.310147Z","end":"2026-02-12T16:49:26.55556Z","steps":["trace[1852921115] 'process raft request' (duration: 189.726658ms)","trace[1852921115] 'compare' (duration: 55.607271ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:49:26.601526Z","caller":"traceutil/trace.go:171","msg":"trace[777910912] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"217.101445ms","start":"2026-02-12T16:49:26.384409Z","end":"2026-02-12T16:49:26.60151Z","steps":["trace[777910912] 'process raft request' (duration: 216.873371ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:38.242414Z","caller":"traceutil/trace.go:171","msg":"trace[1147651698] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"100.768967ms","start":"2026-02-12T16:49:38.141628Z","end":"2026-02-12T16:49:38.242397Z","steps":["trace[1147651698] 'process raft request' (duration: 99.80478ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:39.565924Z","caller":"traceutil/trace.go:171","msg":"trace[997723753] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"119.143003ms","start":"2026-02-12T16:49:39.446758Z","end":"2026-02-12T16:49:39.565901Z","steps":["trace[997723753] 'process raft request' (duration: 119.007931ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:45.538578Z","caller":"traceutil/trace.go:171","msg":"trace[1180552572] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"132.374715ms","start":"2026-02-12T16:49:45.406184Z","end":"2026-02-12T16:49:45.538559Z","steps":["trace[1180552572] 'process raft request' (duration: 132.250454ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:46.998742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.830319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-12T16:49:46.998817Z","caller":"traceutil/trace.go:171","msg":"trace[970239109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:813; }","duration":"117.9498ms","start":"2026-02-12T16:49:46.880852Z","end":"2026-02-12T16:49:46.998802Z","steps":["trace[970239109] 'range keys from in-memory index tree' (duration: 117.670886ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:49.948214Z","caller":"traceutil/trace.go:171","msg":"trace[1029576032] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"125.021634ms","start":"2026-02-12T16:49:49.823169Z","end":"2026-02-12T16:49:49.948191Z","steps":["trace[1029576032] 'process raft request' (duration: 124.795591ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:51.165673Z","caller":"traceutil/trace.go:171","msg":"trace[534013902] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"117.481173ms","start":"2026-02-12T16:49:51.048177Z","end":"2026-02-12T16:49:51.165658Z","steps":["trace[534013902] 'process raft request' (duration: 117.227699ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:52.269831Z","caller":"traceutil/trace.go:171","msg":"trace[817209552] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:859; }","duration":"176.760295ms","start":"2026-02-12T16:49:52.09305Z","end":"2026-02-12T16:49:52.26981Z","steps":["trace[817209552] 'read index received' (duration: 176.632863ms)","trace[817209552] 'applied index is now lower than readState.Index' (duration: 126.552µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:49:52.269942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.872777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:49:52.269965Z","caller":"traceutil/trace.go:171","msg":"trace[1596776243] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:827; }","duration":"176.932828ms","start":"2026-02-12T16:49:52.093024Z","end":"2026-02-12T16:49:52.269957Z","steps":["trace[1596776243] 'agreement among raft nodes before linearized reading' (duration: 176.857647ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:52.270079Z","caller":"traceutil/trace.go:171","msg":"trace[840735413] transaction","detail":"{read_only:false; response_revision:827; number_of_response:1; }","duration":"205.973615ms","start":"2026-02-12T16:49:52.064087Z","end":"2026-02-12T16:49:52.27006Z","steps":["trace[840735413] 'process raft request' (duration: 205.604399ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:49:52.655637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.19627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:49:52.655715Z","caller":"traceutil/trace.go:171","msg":"trace[391159726] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:829; }","duration":"103.287322ms","start":"2026-02-12T16:49:52.552409Z","end":"2026-02-12T16:49:52.655697Z","steps":["trace[391159726] 'count revisions from in-memory index tree' (duration: 103.112059ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:49:58.474385Z","caller":"traceutil/trace.go:171","msg":"trace[211174226] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"122.39376ms","start":"2026-02-12T16:49:58.351977Z","end":"2026-02-12T16:49:58.474371Z","steps":["trace[211174226] 'process raft request' (duration: 121.920243ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:06.769831Z","caller":"traceutil/trace.go:171","msg":"trace[1407677535] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"117.153853ms","start":"2026-02-12T16:50:06.652652Z","end":"2026-02-12T16:50:06.769806Z","steps":["trace[1407677535] 'process raft request' (duration: 115.065353ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:10.777188Z","caller":"traceutil/trace.go:171","msg":"trace[984245124] linearizableReadLoop","detail":"{readStateIndex:915; appliedIndex:914; }","duration":"105.135311ms","start":"2026-02-12T16:50:10.672008Z","end":"2026-02-12T16:50:10.777144Z","steps":["trace[984245124] 'read index received' (duration: 104.917027ms)","trace[984245124] 'applied index is now lower than readState.Index' (duration: 217.244µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:50:10.777305Z","caller":"traceutil/trace.go:171","msg":"trace[903331326] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"119.827495ms","start":"2026-02-12T16:50:10.657468Z","end":"2026-02-12T16:50:10.777295Z","steps":["trace[903331326] 'process raft request' (duration: 119.537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:10.777533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.510736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T16:50:10.777576Z","caller":"traceutil/trace.go:171","msg":"trace[117950847] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:878; }","duration":"105.583096ms","start":"2026-02-12T16:50:10.671983Z","end":"2026-02-12T16:50:10.777566Z","steps":["trace[117950847] 'agreement among raft nodes before linearized reading' (duration: 105.483345ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:11.071362Z","caller":"traceutil/trace.go:171","msg":"trace[1718797609] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"284.295285ms","start":"2026-02-12T16:50:10.787052Z","end":"2026-02-12T16:50:11.071347Z","steps":["trace[1718797609] 'process raft request' (duration: 279.932314ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:19.801472Z","caller":"traceutil/trace.go:171","msg":"trace[1793849139] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"143.554395ms","start":"2026-02-12T16:50:19.657897Z","end":"2026-02-12T16:50:19.801452Z","steps":["trace[1793849139] 'process raft request' (duration: 93.324158ms)","trace[1793849139] 'compare' (duration: 50.121046ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:50:25.116387Z","caller":"traceutil/trace.go:171","msg":"trace[1156930500] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"168.423238ms","start":"2026-02-12T16:50:24.94795Z","end":"2026-02-12T16:50:25.116373Z","steps":["trace[1156930500] 'process raft request' (duration: 168.012043ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:25.116153Z","caller":"traceutil/trace.go:171","msg":"trace[1108728933] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"136.98741ms","start":"2026-02-12T16:50:24.979145Z","end":"2026-02-12T16:50:25.116132Z","steps":["trace[1108728933] 'read index received' (duration: 136.735497ms)","trace[1108728933] 'applied index is now lower than readState.Index' (duration: 251.003µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:50:25.118144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.991667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T16:50:25.118232Z","caller":"traceutil/trace.go:171","msg":"trace[604408004] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:916; }","duration":"139.121308ms","start":"2026-02-12T16:50:24.979095Z","end":"2026-02-12T16:50:25.118217Z","steps":["trace[604408004] 'agreement among raft nodes before linearized reading' (duration: 137.939802ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:25.251871Z","caller":"traceutil/trace.go:171","msg":"trace[1724231307] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"129.743286ms","start":"2026-02-12T16:50:25.122105Z","end":"2026-02-12T16:50:25.251848Z","steps":["trace[1724231307] 'process raft request' (duration: 73.311606ms)","trace[1724231307] 'compare' (duration: 56.285678ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:50:35.926026Z","caller":"traceutil/trace.go:171","msg":"trace[1033312850] transaction","detail":"{read_only:false; response_revision:981; number_of_response:1; }","duration":"153.622211ms","start":"2026-02-12T16:50:35.772377Z","end":"2026-02-12T16:50:35.925999Z","steps":["trace[1033312850] 'process raft request' (duration: 153.475539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:37.505749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.753624ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T16:50:37.506181Z","caller":"traceutil/trace.go:171","msg":"trace[1639970106] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"133.184795ms","start":"2026-02-12T16:50:37.372983Z","end":"2026-02-12T16:50:37.506168Z","steps":["trace[1639970106] 'process raft request' (duration: 19.943505ms)","trace[1639970106] 'compare' (duration: 112.649403ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:50:39.647883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.87906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T16:50:39.648103Z","caller":"traceutil/trace.go:171","msg":"trace[1834102388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:988; }","duration":"138.134333ms","start":"2026-02-12T16:50:39.509952Z","end":"2026-02-12T16:50:39.648086Z","steps":["trace[1834102388] 'range keys from in-memory index tree' (duration: 137.80307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:39.64835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.989213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T16:50:39.648427Z","caller":"traceutil/trace.go:171","msg":"trace[1806280593] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:988; }","duration":"111.086534ms","start":"2026-02-12T16:50:39.53733Z","end":"2026-02-12T16:50:39.648416Z","steps":["trace[1806280593] 'range keys from in-memory index tree' (duration: 110.882271ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:39.846776Z","caller":"traceutil/trace.go:171","msg":"trace[1939058074] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"193.028282ms","start":"2026-02-12T16:50:39.653726Z","end":"2026-02-12T16:50:39.846754Z","steps":["trace[1939058074] 'process raft request' (duration: 192.993512ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:39.847461Z","caller":"traceutil/trace.go:171","msg":"trace[270264327] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"193.978563ms","start":"2026-02-12T16:50:39.653468Z","end":"2026-02-12T16:50:39.847447Z","steps":["trace[270264327] 'process raft request' (duration: 193.033111ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:39.848439Z","caller":"traceutil/trace.go:171","msg":"trace[1293957390] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"194.858484ms","start":"2026-02-12T16:50:39.653563Z","end":"2026-02-12T16:50:39.848421Z","steps":["trace[1293957390] 'process raft request' (duration: 193.109743ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:39.906086Z","caller":"traceutil/trace.go:171","msg":"trace[1081713488] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"121.235087ms","start":"2026-02-12T16:50:39.784833Z","end":"2026-02-12T16:50:39.906068Z","steps":["trace[1081713488] 'process raft request' (duration: 111.053313ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:47.064708Z","caller":"traceutil/trace.go:171","msg":"trace[252235225] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"114.425877ms","start":"2026-02-12T16:50:46.950244Z","end":"2026-02-12T16:50:47.06467Z","steps":["trace[252235225] 'process raft request' (duration: 114.160124ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:49.04951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.682943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:50:49.049564Z","caller":"traceutil/trace.go:171","msg":"trace[935405044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1021; }","duration":"956.766684ms","start":"2026-02-12T16:50:48.092785Z","end":"2026-02-12T16:50:49.049552Z","steps":["trace[935405044] 'range keys from in-memory index tree' (duration: 956.636993ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:49.049586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:50:48.092775Z","time spent":"956.806424ms","remote":"127.0.0.1:36008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-12T16:50:49.049709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.518266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T16:50:49.04973Z","caller":"traceutil/trace.go:171","msg":"trace[982780340] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:1021; }","duration":"837.575458ms","start":"2026-02-12T16:50:48.212148Z","end":"2026-02-12T16:50:49.049723Z","steps":["trace[982780340] 'count revisions from in-memory index tree' (duration: 837.427245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:49.049744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:50:48.212129Z","time spent":"837.610888ms","remote":"127.0.0.1:44062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"info","ts":"2026-02-12T16:50:50.047528Z","caller":"traceutil/trace.go:171","msg":"trace[173768813] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1066; }","duration":"410.434984ms","start":"2026-02-12T16:50:49.637074Z","end":"2026-02-12T16:50:50.047509Z","steps":["trace[173768813] 'read index received' (duration: 410.278462ms)","trace[173768813] 'applied index is now lower than readState.Index' (duration: 155.932µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:50:50.049847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.127014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T16:50:50.049886Z","caller":"traceutil/trace.go:171","msg":"trace[1259752184] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1022; }","duration":"128.211026ms","start":"2026-02-12T16:50:49.921665Z","end":"2026-02-12T16:50:50.049876Z","steps":["trace[1259752184] 'agreement among raft nodes before linearized reading' (duration: 128.087274ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:50.050607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.879288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-12T16:50:50.050645Z","caller":"traceutil/trace.go:171","msg":"trace[1724396709] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1022; }","duration":"119.948428ms","start":"2026-02-12T16:50:49.930687Z","end":"2026-02-12T16:50:50.050636Z","steps":["trace[1724396709] 'agreement among raft nodes before linearized reading' (duration: 119.857437ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:50.051122Z","caller":"traceutil/trace.go:171","msg":"trace[1869142989] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"526.184533ms","start":"2026-02-12T16:50:49.524929Z","end":"2026-02-12T16:50:50.051114Z","steps":["trace[1869142989] 'process raft request' (duration: 522.48479ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:50.05119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:50:49.524914Z","time spent":"526.235704ms","remote":"127.0.0.1:36246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T16:50:50.051908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.810604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.143\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-12T16:50:50.051936Z","caller":"traceutil/trace.go:171","msg":"trace[1819277386] range","detail":"{range_begin:/registry/masterleases/199.19.213.143; range_end:; response_count:1; response_revision:1022; }","duration":"414.899606ms","start":"2026-02-12T16:50:49.637029Z","end":"2026-02-12T16:50:50.051929Z","steps":["trace[1819277386] 'agreement among raft nodes before linearized reading' (duration: 410.619606ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:50.051957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T16:50:49.636994Z","time spent":"414.957646ms","remote":"127.0.0.1:36028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.143\" "} {"level":"info","ts":"2026-02-12T16:50:51.308096Z","caller":"traceutil/trace.go:171","msg":"trace[781934676] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"114.370766ms","start":"2026-02-12T16:50:51.1937Z","end":"2026-02-12T16:50:51.308071Z","steps":["trace[781934676] 'process raft request' (duration: 113.436695ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:52.248127Z","caller":"traceutil/trace.go:171","msg":"trace[761419208] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"100.667051ms","start":"2026-02-12T16:50:52.147445Z","end":"2026-02-12T16:50:52.248112Z","steps":["trace[761419208] 'process raft request' (duration: 100.410808ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:56.440686Z","caller":"traceutil/trace.go:171","msg":"trace[814631572] linearizableReadLoop","detail":"{readStateIndex:1094; appliedIndex:1093; }","duration":"145.33121ms","start":"2026-02-12T16:50:56.29534Z","end":"2026-02-12T16:50:56.440671Z","steps":["trace[814631572] 'read index received' (duration: 135.78374ms)","trace[814631572] 'applied index is now lower than readState.Index' (duration: 9.54671ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:50:56.44093Z","caller":"traceutil/trace.go:171","msg":"trace[577155014] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"144.53089ms","start":"2026-02-12T16:50:56.296372Z","end":"2026-02-12T16:50:56.440902Z","steps":["trace[577155014] 'process raft request' (duration: 144.386639ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:50:56.441182Z","caller":"traceutil/trace.go:171","msg":"trace[248048637] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"146.010937ms","start":"2026-02-12T16:50:56.295162Z","end":"2026-02-12T16:50:56.441173Z","steps":["trace[248048637] 'process raft request' (duration: 135.947832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:56.44149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.630029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"info","ts":"2026-02-12T16:50:56.441537Z","caller":"traceutil/trace.go:171","msg":"trace[1047234813] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:1047; }","duration":"136.75404ms","start":"2026-02-12T16:50:56.304772Z","end":"2026-02-12T16:50:56.441526Z","steps":["trace[1047234813] 'agreement among raft nodes before linearized reading' (duration: 136.617739ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:50:56.441704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.359542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cluster-admin\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-02-12T16:50:56.441739Z","caller":"traceutil/trace.go:171","msg":"trace[1357814907] range","detail":"{range_begin:/registry/clusterroles/cluster-admin; range_end:; response_count:1; response_revision:1047; }","duration":"146.405663ms","start":"2026-02-12T16:50:56.295325Z","end":"2026-02-12T16:50:56.44173Z","steps":["trace[1357814907] 'agreement among raft nodes before linearized reading' (duration: 146.345312ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:06.774013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.35084ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T16:51:06.774198Z","caller":"traceutil/trace.go:171","msg":"trace[1975146047] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1125; }","duration":"154.806039ms","start":"2026-02-12T16:51:06.619335Z","end":"2026-02-12T16:51:06.774141Z","steps":["trace[1975146047] 'read index received' (duration: 12.180836ms)","trace[1975146047] 'applied index is now lower than readState.Index' (duration: 142.623493ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:51:06.774474Z","caller":"traceutil/trace.go:171","msg":"trace[1896434547] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"215.045801ms","start":"2026-02-12T16:51:06.559408Z","end":"2026-02-12T16:51:06.774453Z","steps":["trace[1896434547] 'process raft request' (duration: 72.149046ms)","trace[1896434547] 'compare' (duration: 142.222108ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:51:06.774816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.474456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:public-info-viewer\" ","response":"range_response_count:1 size:783"} {"level":"warn","ts":"2026-02-12T16:51:06.775387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.514496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:node-proxier\" ","response":"range_response_count:1 size:699"} {"level":"info","ts":"2026-02-12T16:51:06.775498Z","caller":"traceutil/trace.go:171","msg":"trace[1673899881] range","detail":"{range_begin:/registry/clusterrolebindings/system:node-proxier; range_end:; response_count:1; response_revision:1076; }","duration":"129.622877ms","start":"2026-02-12T16:51:06.645858Z","end":"2026-02-12T16:51:06.775481Z","steps":["trace[1673899881] 'agreement among raft nodes before linearized reading' (duration: 129.483195ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:51:06.785304Z","caller":"traceutil/trace.go:171","msg":"trace[2087611578] range","detail":"{range_begin:/registry/clusterrolebindings/system:public-info-viewer; range_end:; response_count:1; response_revision:1076; }","duration":"155.581936ms","start":"2026-02-12T16:51:06.619286Z","end":"2026-02-12T16:51:06.774868Z","steps":["trace[2087611578] 'agreement among raft nodes before linearized reading' (duration: 155.474855ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:10.893948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.220002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-12T16:51:10.894023Z","caller":"traceutil/trace.go:171","msg":"trace[2019318561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1087; }","duration":"104.322623ms","start":"2026-02-12T16:51:10.789685Z","end":"2026-02-12T16:51:10.894008Z","steps":["trace[2019318561] 'range keys from in-memory index tree' (duration: 104.09031ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:10.894719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.405982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6534"} {"level":"info","ts":"2026-02-12T16:51:10.894762Z","caller":"traceutil/trace.go:171","msg":"trace[1872395894] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:1087; }","duration":"112.478052ms","start":"2026-02-12T16:51:10.782274Z","end":"2026-02-12T16:51:10.894752Z","steps":["trace[1872395894] 'range keys from in-memory index tree' (duration: 112.343571ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:51:14.414677Z","caller":"traceutil/trace.go:171","msg":"trace[1774970460] linearizableReadLoop","detail":"{readStateIndex:1146; appliedIndex:1145; }","duration":"178.705633ms","start":"2026-02-12T16:51:14.235958Z","end":"2026-02-12T16:51:14.414664Z","steps":["trace[1774970460] 'read index received' (duration: 178.591752ms)","trace[1774970460] 'applied index is now lower than readState.Index' (duration: 113.371µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:51:14.414862Z","caller":"traceutil/trace.go:171","msg":"trace[1315333187] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"181.222611ms","start":"2026-02-12T16:51:14.233631Z","end":"2026-02-12T16:51:14.414854Z","steps":["trace[1315333187] 'process raft request' (duration: 180.953638ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:14.415005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.032836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-bnbdr\" ","response":"range_response_count:1 size:4415"} {"level":"info","ts":"2026-02-12T16:51:14.41503Z","caller":"traceutil/trace.go:171","msg":"trace[1961631667] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-bnbdr; range_end:; response_count:1; response_revision:1095; }","duration":"179.078237ms","start":"2026-02-12T16:51:14.235946Z","end":"2026-02-12T16:51:14.415024Z","steps":["trace[1961631667] 'agreement among raft nodes before linearized reading' (duration: 179.024506ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:14.415186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.481137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/\" range_end:\"/registry/pods/local-path-storage0\" limit:500 ","response":"range_response_count:1 size:3890"} {"level":"info","ts":"2026-02-12T16:51:14.415211Z","caller":"traceutil/trace.go:171","msg":"trace[1832572654] range","detail":"{range_begin:/registry/pods/local-path-storage/; range_end:/registry/pods/local-path-storage0; response_count:1; response_revision:1095; }","duration":"120.530519ms","start":"2026-02-12T16:51:14.294673Z","end":"2026-02-12T16:51:14.415204Z","steps":["trace[1832572654] 'agreement among raft nodes before linearized reading' (duration: 120.447907ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:51:14.547906Z","caller":"traceutil/trace.go:171","msg":"trace[1865982210] linearizableReadLoop","detail":"{readStateIndex:1148; appliedIndex:1146; }","duration":"124.980087ms","start":"2026-02-12T16:51:14.422914Z","end":"2026-02-12T16:51:14.547894Z","steps":["trace[1865982210] 'read index received' (duration: 86.240173ms)","trace[1865982210] 'applied index is now lower than readState.Index' (duration: 38.739254ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:51:14.548058Z","caller":"traceutil/trace.go:171","msg":"trace[1334104005] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"128.441175ms","start":"2026-02-12T16:51:14.41961Z","end":"2026-02-12T16:51:14.548051Z","steps":["trace[1334104005] 'process raft request' (duration: 89.53529ms)","trace[1334104005] 'compare' (duration: 38.658693ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:51:14.54815Z","caller":"traceutil/trace.go:171","msg":"trace[370429825] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"128.384174ms","start":"2026-02-12T16:51:14.419761Z","end":"2026-02-12T16:51:14.548145Z","steps":["trace[370429825] 'process raft request' (duration: 128.108421ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:14.548244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.317351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-bnbdr\" ","response":"range_response_count:1 size:4415"} {"level":"info","ts":"2026-02-12T16:51:14.548267Z","caller":"traceutil/trace.go:171","msg":"trace[1851670964] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-bnbdr; range_end:; response_count:1; response_revision:1097; }","duration":"125.361492ms","start":"2026-02-12T16:51:14.4229Z","end":"2026-02-12T16:51:14.548262Z","steps":["trace[1851670964] 'agreement among raft nodes before linearized reading' (duration: 125.307011ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:14.988589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.51224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/kube-proxy\" ","response":"range_response_count:1 size:450"} {"level":"info","ts":"2026-02-12T16:51:14.98866Z","caller":"traceutil/trace.go:171","msg":"trace[954560997] range","detail":"{range_begin:/registry/rolebindings/kube-system/kube-proxy; range_end:; response_count:1; response_revision:1098; }","duration":"122.595341ms","start":"2026-02-12T16:51:14.866049Z","end":"2026-02-12T16:51:14.988645Z","steps":["trace[954560997] 'range keys from in-memory index tree' (duration: 122.418818ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:51:15.029191Z","caller":"traceutil/trace.go:171","msg":"trace[204819146] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1149; }","duration":"147.726515ms","start":"2026-02-12T16:51:14.881411Z","end":"2026-02-12T16:51:15.029138Z","steps":["trace[204819146] 'read index received' (duration: 51.186639ms)","trace[204819146] 'applied index is now lower than readState.Index' (duration: 96.538366ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T16:51:15.029439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.980937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/\" range_end:\"/registry/serviceaccounts/local-path-storage0\" limit:500 ","response":"range_response_count:2 size:1083"} {"level":"info","ts":"2026-02-12T16:51:15.029505Z","caller":"traceutil/trace.go:171","msg":"trace[421347529] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/; range_end:/registry/serviceaccounts/local-path-storage0; response_count:2; response_revision:1098; }","duration":"148.078648ms","start":"2026-02-12T16:51:14.881408Z","end":"2026-02-12T16:51:15.029487Z","steps":["trace[421347529] 'agreement among raft nodes before linearized reading' (duration: 147.848906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:15.029719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.262088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/cilium-config-agent\" ","response":"range_response_count:1 size:790"} {"level":"info","ts":"2026-02-12T16:51:15.029963Z","caller":"traceutil/trace.go:171","msg":"trace[251050259] range","detail":"{range_begin:/registry/rolebindings/kube-system/cilium-config-agent; range_end:; response_count:1; response_revision:1098; }","duration":"134.431909ms","start":"2026-02-12T16:51:14.895406Z","end":"2026-02-12T16:51:15.029838Z","steps":["trace[251050259] 'agreement among raft nodes before linearized reading' (duration: 134.053415ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:15.030474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.60534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-02-12T16:51:15.031302Z","caller":"traceutil/trace.go:171","msg":"trace[1856232941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1098; }","duration":"112.445788ms","start":"2026-02-12T16:51:14.918837Z","end":"2026-02-12T16:51:15.031283Z","steps":["trace[1856232941] 'agreement among raft nodes before linearized reading' (duration: 111.570449ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:15.03053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.289358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/local-path-storage/\" range_end:\"/registry/services/specs/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T16:51:15.032019Z","caller":"traceutil/trace.go:171","msg":"trace[1415093904] range","detail":"{range_begin:/registry/services/specs/local-path-storage/; range_end:/registry/services/specs/local-path-storage0; response_count:0; response_revision:1098; }","duration":"125.776755ms","start":"2026-02-12T16:51:14.906223Z","end":"2026-02-12T16:51:15.032Z","steps":["trace[1415093904] 'agreement among raft nodes before linearized reading' (duration: 124.287198ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T16:51:18.908485Z","caller":"traceutil/trace.go:171","msg":"trace[2020421619] linearizableReadLoop","detail":"{readStateIndex:1161; appliedIndex:1160; }","duration":"101.247216ms","start":"2026-02-12T16:51:18.807215Z","end":"2026-02-12T16:51:18.908462Z","steps":["trace[2020421619] 'read index received' (duration: 101.074764ms)","trace[2020421619] 'applied index is now lower than readState.Index' (duration: 171.732µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T16:51:18.908587Z","caller":"traceutil/trace.go:171","msg":"trace[492119047] transaction","detail":"{read_only:false; response_revision:1109; number_of_response:1; }","duration":"102.348409ms","start":"2026-02-12T16:51:18.806227Z","end":"2026-02-12T16:51:18.908575Z","steps":["trace[492119047] 'process raft request' (duration: 102.116376ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T16:51:18.908746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.51362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-12T16:51:18.908776Z","caller":"traceutil/trace.go:171","msg":"trace[553310851] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:1109; }","duration":"101.56786ms","start":"2026-02-12T16:51:18.807199Z","end":"2026-02-12T16:51:18.908767Z","steps":["trace[553310851] 'agreement among raft nodes before linearized reading' (duration: 101.487069ms)"],"step_count":1}