{"level":"warn","ts":"2026-03-20T10:07:45.743236Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T10:07:45.743435Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-03-20T10:07:45.743549Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-20T10:07:45.743588Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-03-20T10:07:45.743628Z","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-03-20T10:07:45.744466Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-03-20T10:07:45.74459Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-03-20T10:07:45.758506Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"13.649305ms"} {"level":"info","ts":"2026-03-20T10:07:45.80829Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-03-20T10:07:45.808415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-03-20T10:07:45.808445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-03-20T10:07:45.808454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-20T10:07:45.808462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-03-20T10:07:45.808512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-03-20T10:07:45.827942Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-20T10:07:45.838084Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-20T10:07:45.84177Z","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-03-20T10:07:45.847023Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-20T10:07:45.848029Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-20T10:07:45.84826Z","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-03-20T10:07:45.84841Z","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-03-20T10:07:45.848478Z","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-03-20T10:07:45.857333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-03-20T10:07:45.859069Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-03-20T10:07:45.861872Z","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-03-20T10:07:45.862201Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-03-20T10:07:45.862246Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-03-20T10:07:45.862527Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-20T10:07:45.862603Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-20T10:07:46.009206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-03-20T10:07:46.009274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-03-20T10:07:46.009318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-03-20T10:07:46.009338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-03-20T10:07:46.009349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-03-20T10:07:46.009386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-03-20T10:07:46.009399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-03-20T10:07:46.023333Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T10:07:46.023347Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:07:46.023689Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-20T10:07:46.02408Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-20T10:07:46.024194Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-20T10:07:46.026445Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-03-20T10:07:46.023294Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-03-20T10:07:46.029347Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:07:46.029584Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:07:46.029721Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-20T10:07:46.031356Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-20T10:07:48.429711Z","caller":"traceutil/trace.go:171","msg":"trace[1037496909] linearizableReadLoop","detail":"{readStateIndex:50; appliedIndex:48; }","duration":"120.189546ms","start":"2026-03-20T10:07:48.309493Z","end":"2026-03-20T10:07:48.429682Z","steps":["trace[1037496909] 'read index received' (duration: 30.050156ms)","trace[1037496909] 'applied index is now lower than readState.Index' (duration: 90.13829ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:48.429876Z","caller":"traceutil/trace.go:171","msg":"trace[1641350436] transaction","detail":"{read_only:false; response_revision:45; number_of_response:1; }","duration":"330.103668ms","start":"2026-03-20T10:07:48.099702Z","end":"2026-03-20T10:07:48.429806Z","steps":["trace[1641350436] 'process raft request' (duration: 239.745796ms)","trace[1641350436] 'compare' (duration: 90.036529ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:48.42998Z","caller":"traceutil/trace.go:171","msg":"trace[1364299158] transaction","detail":"{read_only:false; response_revision:46; number_of_response:1; }","duration":"329.999397ms","start":"2026-03-20T10:07:48.099945Z","end":"2026-03-20T10:07:48.429944Z","steps":["trace[1364299158] 'process raft request' (duration: 329.691934ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:48.430232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.633729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-20T10:07:48.430389Z","caller":"traceutil/trace.go:171","msg":"trace[177278547] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:46; }","duration":"120.941981ms","start":"2026-03-20T10:07:48.309418Z","end":"2026-03-20T10:07:48.43036Z","steps":["trace[177278547] 'agreement among raft nodes before linearized reading' (duration: 120.557169ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:48.430976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:48.09969Z","time spent":"330.45224ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1120,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:07:48.431087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:48.099936Z","time spent":"330.420709ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":796,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T10:07:48.748635Z","caller":"traceutil/trace.go:171","msg":"trace[345762695] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"120.292777ms","start":"2026-03-20T10:07:48.628304Z","end":"2026-03-20T10:07:48.748597Z","steps":["trace[345762695] 'process raft request' (duration: 24.872371ms)","trace[345762695] 'compare' (duration: 95.079193ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:48.749442Z","caller":"traceutil/trace.go:171","msg":"trace[1719755371] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"119.959634ms","start":"2026-03-20T10:07:48.629451Z","end":"2026-03-20T10:07:48.749411Z","steps":["trace[1719755371] 'process raft request' (duration: 119.042757ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:48.749712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.171542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-20T10:07:48.750164Z","caller":"traceutil/trace.go:171","msg":"trace[2046575127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:65; }","duration":"118.555964ms","start":"2026-03-20T10:07:48.631453Z","end":"2026-03-20T10:07:48.750009Z","steps":["trace[2046575127] 'agreement among raft nodes before linearized reading' (duration: 118.043491ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:07:49.490944Z","caller":"traceutil/trace.go:171","msg":"trace[1614665740] linearizableReadLoop","detail":"{readStateIndex:105; appliedIndex:104; }","duration":"153.541301ms","start":"2026-03-20T10:07:49.337347Z","end":"2026-03-20T10:07:49.490888Z","steps":["trace[1614665740] 'read index received' (duration: 117.279182ms)","trace[1614665740] 'applied index is now lower than readState.Index' (duration: 36.261359ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:49.490981Z","caller":"traceutil/trace.go:171","msg":"trace[2146717699] transaction","detail":"{read_only:false; response_revision:101; number_of_response:1; }","duration":"170.93328ms","start":"2026-03-20T10:07:49.320011Z","end":"2026-03-20T10:07:49.490944Z","steps":["trace[2146717699] 'process raft request' (duration: 134.730432ms)","trace[2146717699] 'compare' (duration: 36.025757ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:07:49.491121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.741432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-03-20T10:07:49.491332Z","caller":"traceutil/trace.go:171","msg":"trace[549826934] range","detail":"{range_begin:/registry/clusterroles/system:certificates.k8s.io:legacy-unknown-approver; range_end:; response_count:0; response_revision:101; }","duration":"153.947024ms","start":"2026-03-20T10:07:49.337308Z","end":"2026-03-20T10:07:49.491255Z","steps":["trace[549826934] 'agreement among raft nodes before linearized reading' (duration: 153.714283ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:07:49.493856Z","caller":"traceutil/trace.go:171","msg":"trace[1016677533] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"153.47924ms","start":"2026-03-20T10:07:49.340346Z","end":"2026-03-20T10:07:49.493825Z","steps":["trace[1016677533] 'process raft request' (duration: 153.352449ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:07:49.981103Z","caller":"traceutil/trace.go:171","msg":"trace[916467980] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"128.5862ms","start":"2026-03-20T10:07:49.85249Z","end":"2026-03-20T10:07:49.981076Z","steps":["trace[916467980] 'process raft request' (duration: 91.95561ms)","trace[916467980] 'compare' (duration: 36.470589ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:07:51.691218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.829907ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:07:51.691485Z","caller":"traceutil/trace.go:171","msg":"trace[517019049] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"149.473403ms","start":"2026-03-20T10:07:51.541984Z","end":"2026-03-20T10:07:51.691458Z","steps":["trace[517019049] 'process raft request' (duration: 37.05953ms)","trace[517019049] 'compare' (duration: 111.596454ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:52.955029Z","caller":"traceutil/trace.go:171","msg":"trace[1655585866] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:252; }","duration":"284.648027ms","start":"2026-03-20T10:07:52.670355Z","end":"2026-03-20T10:07:52.955003Z","steps":["trace[1655585866] 'read index received' (duration: 284.395086ms)","trace[1655585866] 'applied index is now lower than readState.Index' (duration: 251.751µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:52.955193Z","caller":"traceutil/trace.go:171","msg":"trace[1119374560] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"701.078133ms","start":"2026-03-20T10:07:52.254105Z","end":"2026-03-20T10:07:52.955183Z","steps":["trace[1119374560] 'process raft request' (duration: 700.724328ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:52.956271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:52.254082Z","time spent":"701.139566ms","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T10:07:52.956237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.87059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-03-20T10:07:52.956422Z","caller":"traceutil/trace.go:171","msg":"trace[797676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:247; }","duration":"286.06782ms","start":"2026-03-20T10:07:52.670335Z","end":"2026-03-20T10:07:52.956403Z","steps":["trace[797676] 'agreement among raft nodes before linearized reading' (duration: 285.237173ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:52.960895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.336374ms","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-03-20T10:07:52.961Z","caller":"traceutil/trace.go:171","msg":"trace[1618209804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:247; }","duration":"189.097538ms","start":"2026-03-20T10:07:52.771879Z","end":"2026-03-20T10:07:52.960976Z","steps":["trace[1618209804] 'agreement among raft nodes before linearized reading' (duration: 188.197468ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:07:54.874726Z","caller":"traceutil/trace.go:171","msg":"trace[1723391544] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"143.937587ms","start":"2026-03-20T10:07:54.730766Z","end":"2026-03-20T10:07:54.874703Z","steps":["trace[1723391544] 'process raft request' (duration: 142.365939ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:07:54.875278Z","caller":"traceutil/trace.go:171","msg":"trace[2065525157] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"132.47608ms","start":"2026-03-20T10:07:54.742787Z","end":"2026-03-20T10:07:54.875263Z","steps":["trace[2065525157] 'process raft request' (duration: 131.862964ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:54.87553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.623744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:07:54.875592Z","caller":"traceutil/trace.go:171","msg":"trace[782423362] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:300; }","duration":"112.161229ms","start":"2026-03-20T10:07:54.763415Z","end":"2026-03-20T10:07:54.875577Z","steps":["trace[782423362] 'read index received' (duration: 109.730894ms)","trace[782423362] 'applied index is now lower than readState.Index' (duration: 2.009496ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:54.875651Z","caller":"traceutil/trace.go:171","msg":"trace[1949728457] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:296; }","duration":"146.77305ms","start":"2026-03-20T10:07:54.728854Z","end":"2026-03-20T10:07:54.875627Z","steps":["trace[1949728457] 'agreement among raft nodes before linearized reading' (duration: 146.55592ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:07:54.889363Z","caller":"traceutil/trace.go:171","msg":"trace[2061709355] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"117.48948ms","start":"2026-03-20T10:07:54.771844Z","end":"2026-03-20T10:07:54.889333Z","steps":["trace[2061709355] 'process raft request' (duration: 117.278771ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:54.889729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.603559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-03-20T10:07:54.889801Z","caller":"traceutil/trace.go:171","msg":"trace[1764067290] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:299; }","duration":"121.728514ms","start":"2026-03-20T10:07:54.768056Z","end":"2026-03-20T10:07:54.889784Z","steps":["trace[1764067290] 'agreement among raft nodes before linearized reading' (duration: 121.567716ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:55.111332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.569071ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:07:55.111495Z","caller":"traceutil/trace.go:171","msg":"trace[2092739810] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"134.009261ms","start":"2026-03-20T10:07:54.977451Z","end":"2026-03-20T10:07:55.11146Z","steps":["trace[2092739810] 'process raft request' (duration: 30.158127ms)","trace[2092739810] 'compare' (duration: 103.376864ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:55.111981Z","caller":"traceutil/trace.go:171","msg":"trace[1447672167] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:319; }","duration":"119.48431ms","start":"2026-03-20T10:07:54.992471Z","end":"2026-03-20T10:07:55.111955Z","steps":["trace[1447672167] 'read index received' (duration: 15.130185ms)","trace[1447672167] 'applied index is now lower than readState.Index' (duration: 104.352805ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:07:55.112003Z","caller":"traceutil/trace.go:171","msg":"trace[722020848] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"134.293453ms","start":"2026-03-20T10:07:54.97768Z","end":"2026-03-20T10:07:55.111974Z","steps":["trace[722020848] 'process raft request' (duration: 134.096714ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:07:55.112133Z","caller":"traceutil/trace.go:171","msg":"trace[1319635712] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"132.588608ms","start":"2026-03-20T10:07:54.9795Z","end":"2026-03-20T10:07:55.112089Z","steps":["trace[1319635712] 'process raft request' (duration: 132.406411ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:55.112285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.791033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:07:55.112525Z","caller":"traceutil/trace.go:171","msg":"trace[603328288] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:0; response_revision:312; }","duration":"120.030604ms","start":"2026-03-20T10:07:54.992417Z","end":"2026-03-20T10:07:55.112448Z","steps":["trace[603328288] 'agreement among raft nodes before linearized reading' (duration: 119.729281ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.193878Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646842177139807010,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-20T10:07:58.199702Z","caller":"traceutil/trace.go:171","msg":"trace[1641663133] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:360; }","duration":"506.805656ms","start":"2026-03-20T10:07:57.692862Z","end":"2026-03-20T10:07:58.199668Z","steps":["trace[1641663133] 'read index received' (duration: 506.451742ms)","trace[1641663133] 'applied index is now lower than readState.Index' (duration: 352.574µs)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:07:58.200004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.112869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-03-20T10:07:58.20007Z","caller":"traceutil/trace.go:171","msg":"trace[1389781635] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:347; }","duration":"507.239264ms","start":"2026-03-20T10:07:57.692814Z","end":"2026-03-20T10:07:58.200054Z","steps":["trace[1389781635] 'agreement among raft nodes before linearized reading' (duration: 507.076907ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.200082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.011046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-03-20T10:07:58.200116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:57.692795Z","time spent":"507.311027ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-03-20T10:07:58.200165Z","caller":"traceutil/trace.go:171","msg":"trace[14734863] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:347; }","duration":"156.162463ms","start":"2026-03-20T10:07:58.043983Z","end":"2026-03-20T10:07:58.200145Z","steps":["trace[14734863] 'agreement among raft nodes before linearized reading' (duration: 155.945974ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.200185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.599561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-03-20T10:07:58.200182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.842485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-03-20T10:07:58.200276Z","caller":"traceutil/trace.go:171","msg":"trace[977993810] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:347; }","duration":"106.731937ms","start":"2026-03-20T10:07:58.093509Z","end":"2026-03-20T10:07:58.20024Z","steps":["trace[977993810] 'agreement among raft nodes before linearized reading' (duration: 106.55864ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:07:58.200342Z","caller":"traceutil/trace.go:171","msg":"trace[874320202] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:347; }","duration":"356.022802ms","start":"2026-03-20T10:07:57.844276Z","end":"2026-03-20T10:07:58.200299Z","steps":["trace[874320202] 'agreement among raft nodes before linearized reading' (duration: 355.858855ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.200357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.300869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-03-20T10:07:58.200062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.044513ms","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-03-20T10:07:58.200417Z","caller":"traceutil/trace.go:171","msg":"trace[107994812] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:347; }","duration":"407.390592ms","start":"2026-03-20T10:07:57.793012Z","end":"2026-03-20T10:07:58.200403Z","steps":["trace[107994812] 'agreement among raft nodes before linearized reading' (duration: 407.298819ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.200416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:57.844248Z","time spent":"356.153367ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"info","ts":"2026-03-20T10:07:58.200452Z","caller":"traceutil/trace.go:171","msg":"trace[1375276694] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:347; }","duration":"458.514653ms","start":"2026-03-20T10:07:57.741921Z","end":"2026-03-20T10:07:58.200436Z","steps":["trace[1375276694] 'agreement among raft nodes before linearized reading' (duration: 458.000202ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.200464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:57.792993Z","time spent":"407.454205ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-03-20T10:07:58.20052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:57.741891Z","time spent":"458.610197ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-03-20T10:07:58.200589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.643638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-03-20T10:07:58.200616Z","caller":"traceutil/trace.go:171","msg":"trace[180764158] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:347; }","duration":"207.69789ms","start":"2026-03-20T10:07:57.99291Z","end":"2026-03-20T10:07:58.200608Z","steps":["trace[180764158] 'agreement among raft nodes before linearized reading' (duration: 207.644688ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.200697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.429642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-03-20T10:07:58.200727Z","caller":"traceutil/trace.go:171","msg":"trace[1355175629] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:347; }","duration":"257.499645ms","start":"2026-03-20T10:07:57.943217Z","end":"2026-03-20T10:07:58.200717Z","steps":["trace[1355175629] 'agreement among raft nodes before linearized reading' (duration: 257.440603ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.200972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.781942ms","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-03-20T10:07:58.199835Z","caller":"traceutil/trace.go:171","msg":"trace[164089094] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"547.388695ms","start":"2026-03-20T10:07:57.652402Z","end":"2026-03-20T10:07:58.19979Z","steps":["trace[164089094] 'process raft request' (duration: 547.049781ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.201395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:57.652374Z","time spent":"548.920339ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T10:07:58.201933Z","caller":"traceutil/trace.go:171","msg":"trace[942557305] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:347; }","duration":"307.950899ms","start":"2026-03-20T10:07:57.893115Z","end":"2026-03-20T10:07:58.201066Z","steps":["trace[942557305] 'agreement among raft nodes before linearized reading' (duration: 307.164725ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:07:58.202018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:57.893087Z","time spent":"308.908538ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-03-20T10:07:59.198003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.652807ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:07:59.198142Z","caller":"traceutil/trace.go:171","msg":"trace[802491552] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"992.737358ms","start":"2026-03-20T10:07:58.205376Z","end":"2026-03-20T10:07:59.198113Z","steps":["trace[802491552] 'process raft request' (duration: 120.906233ms)","trace[802491552] 'compare' (duration: 871.493521ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:07:59.198225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.20536Z","time spent":"992.828872ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T10:07:59.644564Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.318342027s","expected-duration":"1s"} {"level":"warn","ts":"2026-03-20T10:08:00.065503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.517249ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-20T10:08:00.06577Z","caller":"traceutil/trace.go:171","msg":"trace[14269148] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"1.859355801s","start":"2026-03-20T10:07:58.206381Z","end":"2026-03-20T10:08:00.065736Z","steps":["trace[14269148] 'process raft request' (duration: 1.43850602s)","trace[14269148] 'compare' (duration: 420.385643ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:08:00.065864Z","caller":"traceutil/trace.go:171","msg":"trace[530225829] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"1.857017274s","start":"2026-03-20T10:07:58.20879Z","end":"2026-03-20T10:08:00.065807Z","steps":["trace[530225829] 'process raft request' (duration: 1.856817566s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.065947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.206355Z","time spent":"1.859494977s","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:00.065991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.208775Z","time spent":"1.85715487s","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T10:08:00.066109Z","caller":"traceutil/trace.go:171","msg":"trace[1679486442] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"1.856852847s","start":"2026-03-20T10:07:58.209202Z","end":"2026-03-20T10:08:00.066054Z","steps":["trace[1679486442] 'process raft request' (duration: 1.856480102s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.066311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.209189Z","time spent":"1.857026505s","remote":"127.0.0.1:41794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T10:08:00.067634Z","caller":"traceutil/trace.go:171","msg":"trace[90559021] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"865.372421ms","start":"2026-03-20T10:07:59.20223Z","end":"2026-03-20T10:08:00.067602Z","steps":["trace[90559021] 'process raft request' (duration: 865.325399ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.067791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:59.202199Z","time spent":"865.516157ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T10:08:00.067842Z","caller":"traceutil/trace.go:171","msg":"trace[670471212] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"1.815752214s","start":"2026-03-20T10:07:58.252059Z","end":"2026-03-20T10:08:00.067811Z","steps":["trace[670471212] 'process raft request' (duration: 1.815405611s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.067956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.252043Z","time spent":"1.815852879s","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:00.068024Z","caller":"traceutil/trace.go:171","msg":"trace[1560599657] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:361; }","duration":"1.825418025s","start":"2026-03-20T10:07:58.242593Z","end":"2026-03-20T10:08:00.068011Z","steps":["trace[1560599657] 'read index received' (duration: 83.641832ms)","trace[1560599657] 'applied index is now lower than readState.Index' (duration: 1.741774463s)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:08:00.068046Z","caller":"traceutil/trace.go:171","msg":"trace[305031382] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"1.857569475s","start":"2026-03-20T10:07:58.210428Z","end":"2026-03-20T10:08:00.067997Z","steps":["trace[305031382] 'process raft request' (duration: 1.855308763s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.06822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.210419Z","time spent":"1.857718792s","remote":"127.0.0.1:41546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T10:08:00.068315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.221022ms","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-03-20T10:08:00.068353Z","caller":"traceutil/trace.go:171","msg":"trace[365485436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:354; }","duration":"940.298086ms","start":"2026-03-20T10:07:59.128042Z","end":"2026-03-20T10:08:00.06834Z","steps":["trace[365485436] 'agreement among raft nodes before linearized reading' (duration: 940.227293ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.068343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.775925946s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-03-20T10:08:00.068389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:59.128022Z","time spent":"940.359588ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-20T10:08:00.068432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.408586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-03-20T10:08:00.068479Z","caller":"traceutil/trace.go:171","msg":"trace[1598422076] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:354; }","duration":"558.49651ms","start":"2026-03-20T10:07:59.50997Z","end":"2026-03-20T10:08:00.068467Z","steps":["trace[1598422076] 'agreement among raft nodes before linearized reading' (duration: 558.389615ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.068523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:59.50995Z","time spent":"558.564963ms","remote":"127.0.0.1:41456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4348,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-03-20T10:08:00.068532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.689937ms","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-03-20T10:08:00.068564Z","caller":"traceutil/trace.go:171","msg":"trace[1132561253] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:354; }","duration":"668.787811ms","start":"2026-03-20T10:07:59.399767Z","end":"2026-03-20T10:08:00.068554Z","steps":["trace[1132561253] 'agreement among raft nodes before linearized reading' (duration: 668.727989ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.06859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:59.399732Z","time spent":"668.852023ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-03-20T10:08:00.068402Z","caller":"traceutil/trace.go:171","msg":"trace[1035646055] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.776011299s","start":"2026-03-20T10:07:58.292373Z","end":"2026-03-20T10:08:00.068385Z","steps":["trace[1035646055] 'agreement among raft nodes before linearized reading' (duration: 1.775872474s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.068655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.524327664s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-03-20T10:08:00.068717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.029842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-03-20T10:08:00.068722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.826127404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-03-20T10:08:00.068717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.575031042s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-03-20T10:08:00.068669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.292362Z","time spent":"1.776292661s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":225,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-03-20T10:08:00.068764Z","caller":"traceutil/trace.go:171","msg":"trace[1331931884] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.826209647s","start":"2026-03-20T10:07:58.242544Z","end":"2026-03-20T10:08:00.068753Z","steps":["trace[1331931884] 'agreement among raft nodes before linearized reading' (duration: 1.826131574s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.068727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.62475645s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-03-20T10:08:00.068774Z","caller":"traceutil/trace.go:171","msg":"trace[1307354780] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.575148096s","start":"2026-03-20T10:07:58.493608Z","end":"2026-03-20T10:08:00.068756Z","steps":["trace[1307354780] 'agreement among raft nodes before linearized reading' (duration: 1.575036832s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.068795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.724678204s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-03-20T10:08:00.068824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.493576Z","time spent":"1.575238921s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":215,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-03-20T10:08:00.06872Z","caller":"traceutil/trace.go:171","msg":"trace[793279982] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.524452599s","start":"2026-03-20T10:07:58.544249Z","end":"2026-03-20T10:08:00.068702Z","steps":["trace[793279982] 'agreement among raft nodes before linearized reading' (duration: 1.524326714s)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.068831Z","caller":"traceutil/trace.go:171","msg":"trace[545708644] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.724761498s","start":"2026-03-20T10:07:58.344057Z","end":"2026-03-20T10:08:00.068818Z","steps":["trace[545708644] 'agreement among raft nodes before linearized reading' (duration: 1.724709456s)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.068841Z","caller":"traceutil/trace.go:171","msg":"trace[1656419257] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:354; }","duration":"1.624893075s","start":"2026-03-20T10:07:58.443907Z","end":"2026-03-20T10:08:00.0688Z","steps":["trace[1656419257] 'agreement among raft nodes before linearized reading' (duration: 1.624644845s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.068868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.544219Z","time spent":"1.524639196s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":256,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-03-20T10:08:00.068744Z","caller":"traceutil/trace.go:171","msg":"trace[1513263737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:354; }","duration":"938.116605ms","start":"2026-03-20T10:07:59.130619Z","end":"2026-03-20T10:08:00.068735Z","steps":["trace[1513263737] 'agreement among raft nodes before linearized reading' (duration: 938.068384ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.068899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.443857Z","time spent":"1.62502581s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":219,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-03-20T10:08:00.068869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.34403Z","time spent":"1.724832901s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":217,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-03-20T10:08:00.068735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.67526965s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-03-20T10:08:00.068967Z","caller":"traceutil/trace.go:171","msg":"trace[1288327927] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:354; }","duration":"1.675555671s","start":"2026-03-20T10:07:58.3934Z","end":"2026-03-20T10:08:00.068956Z","steps":["trace[1288327927] 'agreement among raft nodes before linearized reading' (duration: 1.675294791s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.068929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:59.130578Z","time spent":"938.343365ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-20T10:08:00.068799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.242529Z","time spent":"1.826261809s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-03-20T10:08:00.068994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:07:58.393367Z","time spent":"1.675619885s","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-03-20T10:08:00.068911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.951114ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:08:00.078613Z","caller":"traceutil/trace.go:171","msg":"trace[1199532940] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:354; }","duration":"262.464568ms","start":"2026-03-20T10:07:59.814952Z","end":"2026-03-20T10:08:00.077416Z","steps":["trace[1199532940] 'agreement among raft nodes before linearized reading' (duration: 253.940064ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.38628Z","caller":"traceutil/trace.go:171","msg":"trace[1463666604] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"310.446979ms","start":"2026-03-20T10:08:00.075797Z","end":"2026-03-20T10:08:00.386244Z","steps":["trace[1463666604] 'process raft request' (duration: 310.287062ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.386441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.075769Z","time spent":"310.586644ms","remote":"127.0.0.1:41766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:00.393401Z","caller":"traceutil/trace.go:171","msg":"trace[1690408526] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"313.037483ms","start":"2026-03-20T10:08:00.080346Z","end":"2026-03-20T10:08:00.393383Z","steps":["trace[1690408526] 'process raft request' (duration: 312.650877ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.393513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.080341Z","time spent":"313.118307ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T10:08:00.393641Z","caller":"traceutil/trace.go:171","msg":"trace[1922502186] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"316.107537ms","start":"2026-03-20T10:08:00.077465Z","end":"2026-03-20T10:08:00.393573Z","steps":["trace[1922502186] 'process raft request' (duration: 315.372668ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.393397Z","caller":"traceutil/trace.go:171","msg":"trace[111091066] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:368; }","duration":"314.402108ms","start":"2026-03-20T10:08:00.078953Z","end":"2026-03-20T10:08:00.393355Z","steps":["trace[111091066] 'read index received' (duration: 307.2598ms)","trace[111091066] 'applied index is now lower than readState.Index' (duration: 7.141178ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:08:00.393831Z","caller":"traceutil/trace.go:171","msg":"trace[1151927498] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"313.573765ms","start":"2026-03-20T10:08:00.08024Z","end":"2026-03-20T10:08:00.393814Z","steps":["trace[1151927498] 'process raft request' (duration: 312.682799ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.393859Z","caller":"traceutil/trace.go:171","msg":"trace[429659550] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"316.748042ms","start":"2026-03-20T10:08:00.077101Z","end":"2026-03-20T10:08:00.393849Z","steps":["trace[429659550] 'process raft request' (duration: 315.582556ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.393875Z","caller":"traceutil/trace.go:171","msg":"trace[1562969061] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"316.541004ms","start":"2026-03-20T10:08:00.077327Z","end":"2026-03-20T10:08:00.393868Z","steps":["trace[1562969061] 'process raft request' (duration: 315.456091ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.393862Z","caller":"traceutil/trace.go:171","msg":"trace[875463531] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"314.860736ms","start":"2026-03-20T10:08:00.078973Z","end":"2026-03-20T10:08:00.393834Z","steps":["trace[875463531] 'process raft request' (duration: 313.899507ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.393926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.077094Z","time spent":"316.796405ms","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T10:08:00.394005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.078954Z","time spent":"314.96651ms","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2163,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:00.393917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.077317Z","time spent":"316.575566ms","remote":"127.0.0.1:41456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:00.394169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.080233Z","time spent":"313.638987ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:00.394167Z","caller":"traceutil/trace.go:171","msg":"trace[1652444285] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"316.874338ms","start":"2026-03-20T10:08:00.077284Z","end":"2026-03-20T10:08:00.394158Z","steps":["trace[1652444285] 'process raft request' (duration: 315.449291ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.39425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.077276Z","time spent":"316.93401ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T10:08:00.39371Z","caller":"traceutil/trace.go:171","msg":"trace[1415779251] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"316.792244ms","start":"2026-03-20T10:08:00.076901Z","end":"2026-03-20T10:08:00.393693Z","steps":["trace[1415779251] 'process raft request' (duration: 315.648848ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.39446Z","caller":"traceutil/trace.go:171","msg":"trace[769257076] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"312.968339ms","start":"2026-03-20T10:08:00.081482Z","end":"2026-03-20T10:08:00.39445Z","steps":["trace[769257076] 'process raft request' (duration: 311.579114ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.394451Z","caller":"traceutil/trace.go:171","msg":"trace[434934142] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"312.109655ms","start":"2026-03-20T10:08:00.082332Z","end":"2026-03-20T10:08:00.394441Z","steps":["trace[434934142] 'process raft request' (duration: 310.828984ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.394509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.081468Z","time spent":"313.016403ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:00.394519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.082327Z","time spent":"312.164888ms","remote":"127.0.0.1:41632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:00.394647Z","caller":"traceutil/trace.go:171","msg":"trace[409509126] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"314.099427ms","start":"2026-03-20T10:08:00.080539Z","end":"2026-03-20T10:08:00.394639Z","steps":["trace[409509126] 'process raft request' (duration: 312.489782ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.394656Z","caller":"traceutil/trace.go:171","msg":"trace[1511982678] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"313.093705ms","start":"2026-03-20T10:08:00.081551Z","end":"2026-03-20T10:08:00.394644Z","steps":["trace[1511982678] 'process raft request' (duration: 311.543722ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.394729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.081544Z","time spent":"313.159178ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:00.394788Z","caller":"traceutil/trace.go:171","msg":"trace[1838605538] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"312.258692ms","start":"2026-03-20T10:08:00.082522Z","end":"2026-03-20T10:08:00.39478Z","steps":["trace[1838605538] 'process raft request' (duration: 310.704538ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.394813Z","caller":"traceutil/trace.go:171","msg":"trace[80574488] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"312.413769ms","start":"2026-03-20T10:08:00.082389Z","end":"2026-03-20T10:08:00.394803Z","steps":["trace[80574488] 'process raft request' (duration: 310.798173ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.394887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.082377Z","time spent":"312.482421ms","remote":"127.0.0.1:41632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:00.393842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.077455Z","time spent":"316.334166ms","remote":"127.0.0.1:41806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T10:08:00.394836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.082514Z","time spent":"312.298794ms","remote":"127.0.0.1:41520","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1251,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:00.395305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.325995ms","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-03-20T10:08:00.395336Z","caller":"traceutil/trace.go:171","msg":"trace[1346286502] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"312.561114ms","start":"2026-03-20T10:08:00.082759Z","end":"2026-03-20T10:08:00.39532Z","steps":["trace[1346286502] 'process raft request' (duration: 310.507741ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.394684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.080529Z","time spent":"314.140478ms","remote":"127.0.0.1:41446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-20T10:08:00.395358Z","caller":"traceutil/trace.go:171","msg":"trace[1259887733] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"312.522573ms","start":"2026-03-20T10:08:00.082809Z","end":"2026-03-20T10:08:00.395332Z","steps":["trace[1259887733] 'process raft request' (duration: 310.504671ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:00.395385Z","caller":"traceutil/trace.go:171","msg":"trace[175139493] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:372; }","duration":"316.465391ms","start":"2026-03-20T10:08:00.0789Z","end":"2026-03-20T10:08:00.395366Z","steps":["trace[175139493] 'agreement among raft nodes before linearized reading' (duration: 314.552724ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.395417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.082747Z","time spent":"312.629987ms","remote":"127.0.0.1:41456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4781,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:00.39544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.078888Z","time spent":"316.542055ms","remote":"127.0.0.1:41470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":229,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-03-20T10:08:00.39445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.076879Z","time spent":"317.542324ms","remote":"127.0.0.1:41370","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T10:08:00.39548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.082799Z","time spent":"312.620626ms","remote":"127.0.0.1:41448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4355,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:00.395649Z","caller":"traceutil/trace.go:171","msg":"trace[1642765115] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"312.257352ms","start":"2026-03-20T10:08:00.082255Z","end":"2026-03-20T10:08:00.394512Z","steps":["trace[1642765115] 'process raft request' (duration: 310.866345ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:00.395839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:00.082244Z","time spent":"313.537003ms","remote":"127.0.0.1:41632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:25.727966Z","caller":"traceutil/trace.go:171","msg":"trace[1413599779] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"122.359707ms","start":"2026-03-20T10:08:25.605558Z","end":"2026-03-20T10:08:25.727918Z","steps":["trace[1413599779] 'process raft request' (duration: 121.967454ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:26.192254Z","caller":"traceutil/trace.go:171","msg":"trace[1340357464] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"189.473961ms","start":"2026-03-20T10:08:26.002746Z","end":"2026-03-20T10:08:26.19222Z","steps":["trace[1340357464] 'process raft request' (duration: 147.1887ms)","trace[1340357464] 'compare' (duration: 41.93352ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:08:27.016476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.587295ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:08:27.016631Z","caller":"traceutil/trace.go:171","msg":"trace[174582113] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:561; }","duration":"138.830682ms","start":"2026-03-20T10:08:26.877781Z","end":"2026-03-20T10:08:27.016612Z","steps":["trace[174582113] 'range keys from in-memory index tree' (duration: 138.545704ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:27.036219Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646842177139807401,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-20T10:08:27.062441Z","caller":"traceutil/trace.go:171","msg":"trace[198585630] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"528.101403ms","start":"2026-03-20T10:08:26.534319Z","end":"2026-03-20T10:08:27.06242Z","steps":["trace[198585630] 'process raft request' (duration: 527.963489ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:27.062576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:26.534277Z","time spent":"528.228077ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:27.068471Z","caller":"traceutil/trace.go:171","msg":"trace[982961518] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:584; }","duration":"533.273497ms","start":"2026-03-20T10:08:26.535173Z","end":"2026-03-20T10:08:27.068446Z","steps":["trace[982961518] 'read index received' (duration: 527.239046ms)","trace[982961518] 'applied index is now lower than readState.Index' (duration: 6.033711ms)"],"step_count":2} {"level":"warn","ts":"2026-03-20T10:08:27.068772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.862178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:08:27.0686Z","caller":"traceutil/trace.go:171","msg":"trace[393632870] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"472.247837ms","start":"2026-03-20T10:08:26.59634Z","end":"2026-03-20T10:08:27.068587Z","steps":["trace[393632870] 'process raft request' (duration: 471.965719ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:27.068845Z","caller":"traceutil/trace.go:171","msg":"trace[1119861941] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:563; }","duration":"275.010861ms","start":"2026-03-20T10:08:26.793816Z","end":"2026-03-20T10:08:27.068827Z","steps":["trace[1119861941] 'agreement among raft nodes before linearized reading' (duration: 274.817956ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:27.068843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.274607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-20T10:08:27.068787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.591456ms","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-03-20T10:08:27.068896Z","caller":"traceutil/trace.go:171","msg":"trace[146572515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:563; }","duration":"135.3659ms","start":"2026-03-20T10:08:26.933511Z","end":"2026-03-20T10:08:27.068877Z","steps":["trace[146572515] 'agreement among raft nodes before linearized reading' (duration: 135.277607ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:27.068911Z","caller":"traceutil/trace.go:171","msg":"trace[1651134778] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:563; }","duration":"533.745701ms","start":"2026-03-20T10:08:26.535154Z","end":"2026-03-20T10:08:27.068899Z","steps":["trace[1651134778] 'agreement among raft nodes before linearized reading' (duration: 533.478483ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:27.068938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:26.535145Z","time spent":"533.784362ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-20T10:08:27.069133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:26.596316Z","time spent":"472.552157ms","remote":"127.0.0.1:41340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-20T10:08:31.569218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.836671ms","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-03-20T10:08:31.569302Z","caller":"traceutil/trace.go:171","msg":"trace[1529183087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:613; }","duration":"464.991095ms","start":"2026-03-20T10:08:31.104293Z","end":"2026-03-20T10:08:31.569284Z","steps":["trace[1529183087] 'range keys from in-memory index tree' (duration: 464.400289ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:31.569338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:31.104251Z","time spent":"465.080407ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-20T10:08:31.569526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.639646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-03-20T10:08:31.569604Z","caller":"traceutil/trace.go:171","msg":"trace[1791630990] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"463.781571ms","start":"2026-03-20T10:08:31.105805Z","end":"2026-03-20T10:08:31.569586Z","steps":["trace[1791630990] 'range keys from in-memory index tree' (duration: 463.42302ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:31.569645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:31.105762Z","time spent":"463.868523ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-20T10:08:34.003648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.846909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-m7h5f\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-03-20T10:08:34.00374Z","caller":"traceutil/trace.go:171","msg":"trace[1287085254] range","detail":"{range_begin:/registry/pods/kube-system/cilium-m7h5f; range_end:; response_count:1; response_revision:625; }","duration":"103.988154ms","start":"2026-03-20T10:08:33.899719Z","end":"2026-03-20T10:08:34.003707Z","steps":["trace[1287085254] 'range keys from in-memory index tree' (duration: 103.656134ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:34.163461Z","caller":"traceutil/trace.go:171","msg":"trace[850693269] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"146.711119ms","start":"2026-03-20T10:08:34.016725Z","end":"2026-03-20T10:08:34.163436Z","steps":["trace[850693269] 'process raft request' (duration: 146.553754ms)"],"step_count":1} {"level":"info","ts":"2026-03-20T10:08:34.881746Z","caller":"traceutil/trace.go:171","msg":"trace[270839627] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"309.070173ms","start":"2026-03-20T10:08:34.572651Z","end":"2026-03-20T10:08:34.881721Z","steps":["trace[270839627] 'read index received' (duration: 308.884908ms)","trace[270839627] 'applied index is now lower than readState.Index' (duration: 183.685µs)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:08:34.881885Z","caller":"traceutil/trace.go:171","msg":"trace[374058037] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"580.656119ms","start":"2026-03-20T10:08:34.301202Z","end":"2026-03-20T10:08:34.881858Z","steps":["trace[374058037] 'process raft request' (duration: 580.351971ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:34.881988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.31304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-03-20T10:08:34.882039Z","caller":"traceutil/trace.go:171","msg":"trace[584681377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"309.423673ms","start":"2026-03-20T10:08:34.572601Z","end":"2026-03-20T10:08:34.882025Z","steps":["trace[584681377] 'agreement among raft nodes before linearized reading' (duration: 309.216737ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:34.882048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:34.30118Z","time spent":"580.769432ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:34.882083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:34.57258Z","time spent":"309.494984ms","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-03-20T10:08:36.306615Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646842177139807567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-20T10:08:36.807097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646842177139807567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-20T10:08:37.032283Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.438680322s","expected-duration":"1s"} {"level":"info","ts":"2026-03-20T10:08:37.032908Z","caller":"traceutil/trace.go:171","msg":"trace[983870684] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.43935452s","start":"2026-03-20T10:08:35.593517Z","end":"2026-03-20T10:08:37.032872Z","steps":["trace[983870684] 'process raft request' (duration: 1.439025541s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:37.03318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:35.593505Z","time spent":"1.439503684s","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-20T10:08:37.200863Z","caller":"traceutil/trace.go:171","msg":"trace[1039714182] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.605059042s","start":"2026-03-20T10:08:35.595757Z","end":"2026-03-20T10:08:37.200816Z","steps":["trace[1039714182] 'process raft request' (duration: 1.580417334s)","trace[1039714182] 'compare' (duration: 24.33628ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:08:37.201023Z","caller":"traceutil/trace.go:171","msg":"trace[984821192] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:652; }","duration":"1.395155137s","start":"2026-03-20T10:08:35.805829Z","end":"2026-03-20T10:08:37.200984Z","steps":["trace[984821192] 'read index received' (duration: 1.226701309s)","trace[984821192] 'applied index is now lower than readState.Index' (duration: 168.451358ms)"],"step_count":2} {"level":"info","ts":"2026-03-20T10:08:37.201087Z","caller":"traceutil/trace.go:171","msg":"trace[1062304438] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.159974213s","start":"2026-03-20T10:08:36.041093Z","end":"2026-03-20T10:08:37.201067Z","steps":["trace[1062304438] 'process raft request' (duration: 1.159633264s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:37.201076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:35.595715Z","time spent":"1.605252378s","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:37.201179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:36.041059Z","time spent":"1.160077566s","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-20T10:08:37.201363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.395503026s","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":"warn","ts":"2026-03-20T10:08:37.201376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.290812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-03-20T10:08:37.201395Z","caller":"traceutil/trace.go:171","msg":"trace[272139830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:631; }","duration":"1.395608719s","start":"2026-03-20T10:08:35.805777Z","end":"2026-03-20T10:08:37.201386Z","steps":["trace[272139830] 'agreement among raft nodes before linearized reading' (duration: 1.395407333s)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:37.201435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:35.805759Z","time spent":"1.395668781s","remote":"127.0.0.1:41536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-03-20T10:08:37.201431Z","caller":"traceutil/trace.go:171","msg":"trace[1579314558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"261.391775ms","start":"2026-03-20T10:08:36.94002Z","end":"2026-03-20T10:08:37.201412Z","steps":["trace[1579314558] 'agreement among raft nodes before linearized reading' (duration: 261.20615ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:37.201419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.614953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-20T10:08:37.201541Z","caller":"traceutil/trace.go:171","msg":"trace[32626672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"268.798878ms","start":"2026-03-20T10:08:36.932716Z","end":"2026-03-20T10:08:37.201515Z","steps":["trace[32626672] 'agreement among raft nodes before linearized reading' (duration: 268.544731ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:37.201504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.067817ms","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-03-20T10:08:37.201653Z","caller":"traceutil/trace.go:171","msg":"trace[1736397910] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:631; }","duration":"314.283513ms","start":"2026-03-20T10:08:36.887339Z","end":"2026-03-20T10:08:37.201623Z","steps":["trace[1736397910] 'agreement among raft nodes before linearized reading' (duration: 313.890113ms)"],"step_count":1} {"level":"warn","ts":"2026-03-20T10:08:37.201719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-20T10:08:36.887313Z","time spent":"314.392306ms","remote":"127.0.0.1:41536","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-03-20T10:10:02.714731Z","caller":"traceutil/trace.go:171","msg":"trace[714536187] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"164.136865ms","start":"2026-03-20T10:10:02.550562Z","end":"2026-03-20T10:10:02.714699Z","steps":["trace[714536187] 'process raft request' (duration: 163.963413ms)"],"step_count":1}