{"level":"warn","ts":"2026-06-11T01:53:27.686255Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T01:53:27.686397Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19: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.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-06-11T01:53:27.68649Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-11T01:53:27.68651Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-11T01:53:27.686535Z","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-06-11T01:53:27.687678Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-06-11T01:53:27.687793Z","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.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-06-11T01:53:27.692673Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.583005ms"} {"level":"info","ts":"2026-06-11T01:53:27.703657Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-06-11T01:53:27.703757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-06-11T01:53:27.703787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-06-11T01:53:27.703806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-11T01:53:27.703817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-06-11T01:53:27.703859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-06-11T01:53:27.718273Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-11T01:53:27.721785Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-11T01:53:27.724358Z","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-06-11T01:53:27.727092Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-11T01:53:27.728353Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-11T01:53:27.728708Z","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-06-11T01:53:27.728873Z","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-06-11T01:53:27.728916Z","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-06-11T01:53:27.729529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-06-11T01:53:27.72983Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-06-11T01:53:27.734472Z","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-06-11T01:53:27.734758Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-11T01:53:27.734804Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-11T01:53:27.73543Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-11T01:53:27.735479Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-06-11T01:53:28.205147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-06-11T01:53:28.205302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-11T01:53:28.205344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-06-11T01:53:28.205413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-06-11T01:53:28.205474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-11T01:53:28.205518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-06-11T01:53:28.20555Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-06-11T01:53:28.206544Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T01:53:28.207772Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-06-11T01:53:28.207786Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T01:53:28.20785Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-11T01:53:28.208112Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-11T01:53:28.208171Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-11T01:53:28.208402Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T01:53:28.208622Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T01:53:28.208701Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-11T01:53:28.210442Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-11T01:53:28.217072Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-06-11T01:53:31.294219Z","caller":"traceutil/trace.go:171","msg":"trace[94283435] transaction","detail":"{read_only:false; response_revision:130; number_of_response:1; }","duration":"389.034094ms","start":"2026-06-11T01:53:30.905153Z","end":"2026-06-11T01:53:31.294187Z","steps":["trace[94283435] 'process raft request' (duration: 386.91263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:31.294825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:30.905137Z","time spent":"389.192688ms","remote":"127.0.0.1:38824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1127,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T01:53:32.773373Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151665836464612,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T01:53:33.196792Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.236029355s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-11T01:53:34.655629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.925496816s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:113"} {"level":"warn","ts":"2026-06-11T01:53:34.655636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.730086781s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:53:34.655754Z","caller":"traceutil/trace.go:171","msg":"trace[458512732] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:192; }","duration":"2.925710514s","start":"2026-06-11T01:53:31.730014Z","end":"2026-06-11T01:53:34.655724Z","steps":["trace[458512732] 'range keys from in-memory index tree' (duration: 2.925379224s)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:34.655793Z","caller":"traceutil/trace.go:171","msg":"trace[474191298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:192; }","duration":"2.730294089s","start":"2026-06-11T01:53:31.925476Z","end":"2026-06-11T01:53:34.65577Z","steps":["trace[474191298] 'range keys from in-memory index tree' (duration: 2.729992983s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:34.655801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:31.729992Z","time spent":"2.925798021s","remote":"127.0.0.1:38590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":136,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-11T01:53:34.655835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:31.925454Z","time spent":"2.730372786s","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T01:53:34.656703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459352807s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-11T01:53:34.656811Z","caller":"traceutil/trace.go:171","msg":"trace[418911741] linearizableReadLoop","detail":"{readStateIndex:197; appliedIndex:196; }","duration":"2.3839392s","start":"2026-06-11T01:53:32.272859Z","end":"2026-06-11T01:53:34.656798Z","steps":["trace[418911741] 'read index received' (duration: 924.215431ms)","trace[418911741] 'applied index is now lower than readState.Index' (duration: 1.459722379s)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:53:34.657035Z","caller":"traceutil/trace.go:171","msg":"trace[466058538] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"2.69638555s","start":"2026-06-11T01:53:31.960624Z","end":"2026-06-11T01:53:34.657009Z","steps":["trace[466058538] 'process raft request' (duration: 1.236466484s)","trace[466058538] 'compare' (duration: 1.458421815s)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:53:34.657079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.384199533s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:53:34.65718Z","caller":"traceutil/trace.go:171","msg":"trace[1540925420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:193; }","duration":"2.384350246s","start":"2026-06-11T01:53:32.272806Z","end":"2026-06-11T01:53:34.657156Z","steps":["trace[1540925420] 'agreement among raft nodes before linearized reading' (duration: 2.384154559s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:34.657324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:32.272778Z","time spent":"2.384533662s","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T01:53:34.658044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:31.960594Z","time spent":"2.696518581s","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T01:53:34.788097Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.591067468s","expected-duration":"1s"} {"level":"info","ts":"2026-06-11T01:53:34.801939Z","caller":"traceutil/trace.go:171","msg":"trace[1885642945] linearizableReadLoop","detail":"{readStateIndex:198; appliedIndex:197; }","duration":"145.037898ms","start":"2026-06-11T01:53:34.656858Z","end":"2026-06-11T01:53:34.801896Z","steps":["trace[1885642945] 'read index received' (duration: 131.509314ms)","trace[1885642945] 'applied index is now lower than readState.Index' (duration: 13.524534ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:53:34.801989Z","caller":"traceutil/trace.go:171","msg":"trace[2027138219] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"140.25638ms","start":"2026-06-11T01:53:34.661702Z","end":"2026-06-11T01:53:34.801958Z","steps":["trace[2027138219] 'process raft request' (duration: 140.204875ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:34.802032Z","caller":"traceutil/trace.go:171","msg":"trace[1670743725] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"140.49624ms","start":"2026-06-11T01:53:34.66149Z","end":"2026-06-11T01:53:34.801986Z","steps":["trace[1670743725] 'process raft request' (duration: 140.304373ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:34.802123Z","caller":"traceutil/trace.go:171","msg":"trace[97261398] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"140.488399ms","start":"2026-06-11T01:53:34.661612Z","end":"2026-06-11T01:53:34.8021Z","steps":["trace[97261398] 'process raft request' (duration: 140.225366ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:34.802182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.353415552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:53:34.802219Z","caller":"traceutil/trace.go:171","msg":"trace[468807166] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:198; }","duration":"1.353509011s","start":"2026-06-11T01:53:33.448699Z","end":"2026-06-11T01:53:34.802208Z","steps":["trace[468807166] 'agreement among raft nodes before linearized reading' (duration: 1.353329785s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:34.802252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:33.448679Z","time spent":"1.353564445s","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-11T01:53:34.802372Z","caller":"traceutil/trace.go:171","msg":"trace[268143500] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"1.919301039s","start":"2026-06-11T01:53:32.883056Z","end":"2026-06-11T01:53:34.802357Z","steps":["trace[268143500] 'process raft request' (duration: 1.90536412s)","trace[268143500] 'compare' (duration: 13.065464ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:53:34.802413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.124631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-11T01:53:34.802446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:32.883028Z","time spent":"1.919372885s","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T01:53:34.802459Z","caller":"traceutil/trace.go:171","msg":"trace[1968303519] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:198; }","duration":"650.207158ms","start":"2026-06-11T01:53:34.15224Z","end":"2026-06-11T01:53:34.802447Z","steps":["trace[1968303519] 'agreement among raft nodes before linearized reading' (duration: 650.140182ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:34.802484Z","caller":"traceutil/trace.go:171","msg":"trace[370391040] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"144.219086ms","start":"2026-06-11T01:53:34.658253Z","end":"2026-06-11T01:53:34.802472Z","steps":["trace[370391040] 'process raft request' (duration: 143.47058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:34.802495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:34.152196Z","time spent":"650.291846ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T01:53:35.356284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.300869ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T01:53:35.356459Z","caller":"traceutil/trace.go:171","msg":"trace[424242785] linearizableReadLoop","detail":"{readStateIndex:237; appliedIndex:236; }","duration":"192.597109ms","start":"2026-06-11T01:53:35.163836Z","end":"2026-06-11T01:53:35.356433Z","steps":["trace[424242785] 'read index received' (duration: 86.852001ms)","trace[424242785] 'applied index is now lower than readState.Index' (duration: 105.743008ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:53:35.356514Z","caller":"traceutil/trace.go:171","msg":"trace[1203724216] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"227.715417ms","start":"2026-06-11T01:53:35.12876Z","end":"2026-06-11T01:53:35.356476Z","steps":["trace[1203724216] 'process raft request' (duration: 121.909834ms)","trace[1203724216] 'compare' (duration: 105.162347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:53:35.356824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.9523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cronjob-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:53:35.356997Z","caller":"traceutil/trace.go:171","msg":"trace[653170154] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cronjob-controller; range_end:; response_count:0; response_revision:231; }","duration":"193.142096ms","start":"2026-06-11T01:53:35.1638Z","end":"2026-06-11T01:53:35.356942Z","steps":["trace[653170154] 'agreement among raft nodes before linearized reading' (duration: 192.735321ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:35.503602Z","caller":"traceutil/trace.go:171","msg":"trace[1968370282] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"100.591725ms","start":"2026-06-11T01:53:35.402983Z","end":"2026-06-11T01:53:35.503575Z","steps":["trace[1968370282] 'process raft request' (duration: 97.467671ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:35.652596Z","caller":"traceutil/trace.go:171","msg":"trace[1776038561] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"144.764638ms","start":"2026-06-11T01:53:35.507798Z","end":"2026-06-11T01:53:35.652562Z","steps":["trace[1776038561] 'process raft request' (duration: 139.145075ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:35.652956Z","caller":"traceutil/trace.go:171","msg":"trace[1916842181] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"130.678493ms","start":"2026-06-11T01:53:35.522253Z","end":"2026-06-11T01:53:35.652932Z","steps":["trace[1916842181] 'process raft request' (duration: 129.904034ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:35.893173Z","caller":"traceutil/trace.go:171","msg":"trace[871343723] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"138.906953ms","start":"2026-06-11T01:53:35.754233Z","end":"2026-06-11T01:53:35.89314Z","steps":["trace[871343723] 'process raft request' (duration: 82.699757ms)","trace[871343723] 'compare' (duration: 56.047802ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:53:35.895668Z","caller":"traceutil/trace.go:171","msg":"trace[462124526] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"132.497231ms","start":"2026-06-11T01:53:35.763147Z","end":"2026-06-11T01:53:35.895644Z","steps":["trace[462124526] 'process raft request' (duration: 132.413344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:37.182313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.727465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T01:53:37.182517Z","caller":"traceutil/trace.go:171","msg":"trace[1327365987] linearizableReadLoop","detail":"{readStateIndex:331; appliedIndex:327; }","duration":"319.592035ms","start":"2026-06-11T01:53:36.86291Z","end":"2026-06-11T01:53:37.182502Z","steps":["trace[1327365987] 'read index received' (duration: 107.668882ms)","trace[1327365987] 'applied index is now lower than readState.Index' (duration: 211.922273ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:53:37.182595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.692174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:53:37.182617Z","caller":"traceutil/trace.go:171","msg":"trace[2076737276] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:320; }","duration":"319.743228ms","start":"2026-06-11T01:53:36.862865Z","end":"2026-06-11T01:53:37.182608Z","steps":["trace[2076737276] 'agreement among raft nodes before linearized reading' (duration: 319.676752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:37.182645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:36.862844Z","time spent":"319.794483ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"info","ts":"2026-06-11T01:53:37.182924Z","caller":"traceutil/trace.go:171","msg":"trace[1791295454] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"346.436642ms","start":"2026-06-11T01:53:36.836477Z","end":"2026-06-11T01:53:37.182914Z","steps":["trace[1791295454] 'process raft request' (duration: 133.999494ms)","trace[1791295454] 'compare' (duration: 211.597164ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:53:37.182969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:36.836466Z","time spent":"346.481326ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:37.183064Z","caller":"traceutil/trace.go:171","msg":"trace[1941301994] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"346.538451ms","start":"2026-06-11T01:53:36.836517Z","end":"2026-06-11T01:53:37.183056Z","steps":["trace[1941301994] 'process raft request' (duration: 345.882674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:37.183101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:36.836498Z","time spent":"346.585105ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:37.1832Z","caller":"traceutil/trace.go:171","msg":"trace[231908672] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"346.561923ms","start":"2026-06-11T01:53:36.836631Z","end":"2026-06-11T01:53:37.183193Z","steps":["trace[231908672] 'process raft request' (duration: 345.808547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:37.183243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:36.836624Z","time spent":"346.596296ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:37.183334Z","caller":"traceutil/trace.go:171","msg":"trace[639960599] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"346.665482ms","start":"2026-06-11T01:53:36.836662Z","end":"2026-06-11T01:53:37.183327Z","steps":["trace[639960599] 'process raft request' (duration: 345.808957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:37.183374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:36.836643Z","time spent":"346.709646ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:37.601891Z","caller":"traceutil/trace.go:171","msg":"trace[243875441] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"138.27768ms","start":"2026-06-11T01:53:37.463592Z","end":"2026-06-11T01:53:37.601869Z","steps":["trace[243875441] 'process raft request' (duration: 137.288033ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:37.896522Z","caller":"traceutil/trace.go:171","msg":"trace[735213006] linearizableReadLoop","detail":"{readStateIndex:335; appliedIndex:334; }","duration":"183.596357ms","start":"2026-06-11T01:53:37.712907Z","end":"2026-06-11T01:53:37.896503Z","steps":["trace[735213006] 'read index received' (duration: 183.432023ms)","trace[735213006] 'applied index is now lower than readState.Index' (duration: 163.804µs)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:53:37.896633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.707817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-11T01:53:37.896655Z","caller":"traceutil/trace.go:171","msg":"trace[1448771110] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:324; }","duration":"183.770032ms","start":"2026-06-11T01:53:37.712877Z","end":"2026-06-11T01:53:37.896647Z","steps":["trace[1448771110] 'agreement among raft nodes before linearized reading' (duration: 183.706506ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:37.896619Z","caller":"traceutil/trace.go:171","msg":"trace[1652879258] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"217.056789ms","start":"2026-06-11T01:53:37.679509Z","end":"2026-06-11T01:53:37.896566Z","steps":["trace[1652879258] 'process raft request' (duration: 216.884324ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:38.128625Z","caller":"traceutil/trace.go:171","msg":"trace[1265453534] linearizableReadLoop","detail":"{readStateIndex:337; appliedIndex:336; }","duration":"164.477822ms","start":"2026-06-11T01:53:37.96412Z","end":"2026-06-11T01:53:38.128598Z","steps":["trace[1265453534] 'read index received' (duration: 163.696904ms)","trace[1265453534] 'applied index is now lower than readState.Index' (duration: 779.848µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:53:38.128733Z","caller":"traceutil/trace.go:171","msg":"trace[1124516189] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"165.414396ms","start":"2026-06-11T01:53:37.963293Z","end":"2026-06-11T01:53:38.128707Z","steps":["trace[1124516189] 'process raft request' (duration: 164.54839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:38.128973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.640097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-11T01:53:38.129037Z","caller":"traceutil/trace.go:171","msg":"trace[524552577] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:326; }","duration":"164.931973ms","start":"2026-06-11T01:53:37.964085Z","end":"2026-06-11T01:53:38.129017Z","steps":["trace[524552577] 'agreement among raft nodes before linearized reading' (duration: 164.612864ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:39.333474Z","caller":"traceutil/trace.go:171","msg":"trace[660765862] transaction","detail":"{read_only:false; response_revision:341; number_of_response:1; }","duration":"159.731614ms","start":"2026-06-11T01:53:39.173718Z","end":"2026-06-11T01:53:39.33345Z","steps":["trace[660765862] 'process raft request' (duration: 159.535677ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:39.412685Z","caller":"traceutil/trace.go:171","msg":"trace[158856710] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:351; }","duration":"224.758911ms","start":"2026-06-11T01:53:39.187896Z","end":"2026-06-11T01:53:39.412655Z","steps":["trace[158856710] 'read index received' (duration: 145.505698ms)","trace[158856710] 'applied index is now lower than readState.Index' (duration: 79.251803ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:53:39.412814Z","caller":"traceutil/trace.go:171","msg":"trace[256918914] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"238.975445ms","start":"2026-06-11T01:53:39.173827Z","end":"2026-06-11T01:53:39.412803Z","steps":["trace[256918914] 'process raft request' (duration: 238.665038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:39.413108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.076228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-11T01:53:39.413234Z","caller":"traceutil/trace.go:171","msg":"trace[892343781] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:342; }","duration":"225.357184ms","start":"2026-06-11T01:53:39.187854Z","end":"2026-06-11T01:53:39.413211Z","steps":["trace[892343781] 'agreement among raft nodes before linearized reading' (duration: 225.028685ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:39.527232Z","caller":"traceutil/trace.go:171","msg":"trace[1007266072] linearizableReadLoop","detail":"{readStateIndex:356; appliedIndex:353; }","duration":"114.442148ms","start":"2026-06-11T01:53:39.412763Z","end":"2026-06-11T01:53:39.527205Z","steps":["trace[1007266072] 'read index received' (duration: 114.063494ms)","trace[1007266072] 'applied index is now lower than readState.Index' (duration: 377.514µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:53:39.527315Z","caller":"traceutil/trace.go:171","msg":"trace[999432949] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"189.258528ms","start":"2026-06-11T01:53:39.338022Z","end":"2026-06-11T01:53:39.527281Z","steps":["trace[999432949] 'process raft request' (duration: 189.020707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:39.527394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.430831ms","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-06-11T01:53:39.527424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.221479ms","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-06-11T01:53:39.527467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.344045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-11T01:53:39.527546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.524326ms","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-06-11T01:53:39.527547Z","caller":"traceutil/trace.go:171","msg":"trace[1068341379] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"189.773964ms","start":"2026-06-11T01:53:39.337761Z","end":"2026-06-11T01:53:39.527535Z","steps":["trace[1068341379] 'process raft request' (duration: 189.126357ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:39.527549Z","caller":"traceutil/trace.go:171","msg":"trace[270247044] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:345; }","duration":"164.395465ms","start":"2026-06-11T01:53:39.363123Z","end":"2026-06-11T01:53:39.527519Z","steps":["trace[270247044] 'agreement among raft nodes before linearized reading' (duration: 164.114611ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:39.527576Z","caller":"traceutil/trace.go:171","msg":"trace[271958431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:345; }","duration":"339.598523ms","start":"2026-06-11T01:53:39.18797Z","end":"2026-06-11T01:53:39.527569Z","steps":["trace[271958431] 'agreement among raft nodes before linearized reading' (duration: 339.539868ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:39.527572Z","caller":"traceutil/trace.go:171","msg":"trace[1799161877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:345; }","duration":"326.281399ms","start":"2026-06-11T01:53:39.201266Z","end":"2026-06-11T01:53:39.527548Z","steps":["trace[1799161877] 'agreement among raft nodes before linearized reading' (duration: 326.109894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:39.527612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:39.187947Z","time spent":"339.657728ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T01:53:39.527618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:39.201222Z","time spent":"326.388838ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-11T01:53:39.527429Z","caller":"traceutil/trace.go:171","msg":"trace[1792170459] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:345; }","duration":"213.506187ms","start":"2026-06-11T01:53:39.313911Z","end":"2026-06-11T01:53:39.527417Z","steps":["trace[1792170459] 'agreement among raft nodes before linearized reading' (duration: 213.41987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:39.527907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.91054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T01:53:39.527979Z","caller":"traceutil/trace.go:171","msg":"trace[1938598843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:346; }","duration":"339.994918ms","start":"2026-06-11T01:53:39.18797Z","end":"2026-06-11T01:53:39.527965Z","steps":["trace[1938598843] 'agreement among raft nodes before linearized reading' (duration: 339.851295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:39.527958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.072969ms","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-06-11T01:53:39.528008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.353245ms","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-06-11T01:53:39.528007Z","caller":"traceutil/trace.go:171","msg":"trace[699427496] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"188.854962ms","start":"2026-06-11T01:53:39.339128Z","end":"2026-06-11T01:53:39.527983Z","steps":["trace[699427496] 'process raft request' (duration: 188.02974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:39.527885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.981215ms","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-06-11T01:53:39.528043Z","caller":"traceutil/trace.go:171","msg":"trace[146397213] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:346; }","duration":"315.401869ms","start":"2026-06-11T01:53:39.212631Z","end":"2026-06-11T01:53:39.528033Z","steps":["trace[146397213] 'agreement among raft nodes before linearized reading' (duration: 315.339933ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:39.528039Z","caller":"traceutil/trace.go:171","msg":"trace[1625009716] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:346; }","duration":"264.235463ms","start":"2026-06-11T01:53:39.263783Z","end":"2026-06-11T01:53:39.528018Z","steps":["trace[1625009716] 'agreement among raft nodes before linearized reading' (duration: 264.018344ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:39.528056Z","caller":"traceutil/trace.go:171","msg":"trace[2079396949] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:346; }","duration":"115.222596ms","start":"2026-06-11T01:53:39.412823Z","end":"2026-06-11T01:53:39.528046Z","steps":["trace[2079396949] 'agreement among raft nodes before linearized reading' (duration: 114.963753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:39.528071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:39.212624Z","time spent":"315.440792ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"info","ts":"2026-06-11T01:53:39.528125Z","caller":"traceutil/trace.go:171","msg":"trace[1008207672] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"110.710779ms","start":"2026-06-11T01:53:39.417394Z","end":"2026-06-11T01:53:39.528105Z","steps":["trace[1008207672] 'process raft request' (duration: 110.26806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:39.528013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:39.187943Z","time spent":"340.061324ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T01:53:42.091527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.62015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:53:42.091649Z","caller":"traceutil/trace.go:171","msg":"trace[233384678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:399; }","duration":"397.781634ms","start":"2026-06-11T01:53:41.693842Z","end":"2026-06-11T01:53:42.091623Z","steps":["trace[233384678] 'range keys from in-memory index tree' (duration: 397.568126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:42.091632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.198394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-11T01:53:42.091732Z","caller":"traceutil/trace.go:171","msg":"trace[1629736988] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:399; }","duration":"363.361528ms","start":"2026-06-11T01:53:41.728347Z","end":"2026-06-11T01:53:42.091709Z","steps":["trace[1629736988] 'range keys from in-memory index tree' (duration: 362.964754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:42.091736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:41.693837Z","time spent":"397.883423ms","remote":"127.0.0.1:38526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T01:53:42.091527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.925032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-mkrc6\" ","response":"range_response_count:1 size:4462"} {"level":"warn","ts":"2026-06-11T01:53:42.091799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:41.728326Z","time spent":"363.459097ms","remote":"127.0.0.1:38556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"info","ts":"2026-06-11T01:53:42.091861Z","caller":"traceutil/trace.go:171","msg":"trace[1771424659] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-mkrc6; range_end:; response_count:1; response_revision:399; }","duration":"402.305885ms","start":"2026-06-11T01:53:41.689532Z","end":"2026-06-11T01:53:42.091837Z","steps":["trace[1771424659] 'range keys from in-memory index tree' (duration: 401.759196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:42.092001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:41.689509Z","time spent":"402.437097ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4485,"request content":"key:\"/registry/pods/kube-system/kube-proxy-mkrc6\" "} {"level":"info","ts":"2026-06-11T01:53:42.51083Z","caller":"traceutil/trace.go:171","msg":"trace[1771471790] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"410.084666ms","start":"2026-06-11T01:53:42.100726Z","end":"2026-06-11T01:53:42.510811Z","steps":["trace[1771471790] 'process raft request' (duration: 409.898479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:42.511601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:42.100702Z","time spent":"410.189935ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:42.518095Z","caller":"traceutil/trace.go:171","msg":"trace[2130022370] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"234.47257ms","start":"2026-06-11T01:53:42.283589Z","end":"2026-06-11T01:53:42.518062Z","steps":["trace[2130022370] 'process raft request' (duration: 234.35579ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:45.911166Z","caller":"traceutil/trace.go:171","msg":"trace[1313259006] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:420; }","duration":"339.331029ms","start":"2026-06-11T01:53:45.571811Z","end":"2026-06-11T01:53:45.911142Z","steps":["trace[1313259006] 'read index received' (duration: 339.087531ms)","trace[1313259006] 'applied index is now lower than readState.Index' (duration: 242.437µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:53:45.911235Z","caller":"traceutil/trace.go:171","msg":"trace[585673466] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"652.577949ms","start":"2026-06-11T01:53:45.258624Z","end":"2026-06-11T01:53:45.911202Z","steps":["trace[585673466] 'process raft request' (duration: 652.297759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:45.911341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.514142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-11T01:53:45.911385Z","caller":"traceutil/trace.go:171","msg":"trace[661034339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:408; }","duration":"339.614748ms","start":"2026-06-11T01:53:45.571758Z","end":"2026-06-11T01:53:45.911373Z","steps":["trace[661034339] 'agreement among raft nodes before linearized reading' (duration: 339.520171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:45.911403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:45.258599Z","time spent":"652.709718ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6946,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:53:45.911423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:45.571736Z","time spent":"339.678593ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-11T01:53:45.911535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.216701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T01:53:45.911576Z","caller":"traceutil/trace.go:171","msg":"trace[989450712] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:408; }","duration":"294.286817ms","start":"2026-06-11T01:53:45.617279Z","end":"2026-06-11T01:53:45.911566Z","steps":["trace[989450712] 'agreement among raft nodes before linearized reading' (duration: 294.218381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:45.911561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.014702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-11T01:53:45.91159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.810383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-11T01:53:45.911571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.643888ms","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-06-11T01:53:45.911654Z","caller":"traceutil/trace.go:171","msg":"trace[999258659] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:408; }","duration":"214.910891ms","start":"2026-06-11T01:53:45.696724Z","end":"2026-06-11T01:53:45.911635Z","steps":["trace[999258659] 'agreement among raft nodes before linearized reading' (duration: 214.813274ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:45.91167Z","caller":"traceutil/trace.go:171","msg":"trace[845068691] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:408; }","duration":"303.788029ms","start":"2026-06-11T01:53:45.607862Z","end":"2026-06-11T01:53:45.91165Z","steps":["trace[845068691] 'agreement among raft nodes before linearized reading' (duration: 303.588694ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:45.911641Z","caller":"traceutil/trace.go:171","msg":"trace[1693453485] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:408; }","duration":"240.13443ms","start":"2026-06-11T01:53:45.671482Z","end":"2026-06-11T01:53:45.911616Z","steps":["trace[1693453485] 'agreement among raft nodes before linearized reading' (duration: 240.00177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:45.911717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:45.607836Z","time spent":"303.872644ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T01:53:46.472561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.740033ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T01:53:46.47265Z","caller":"traceutil/trace.go:171","msg":"trace[1179955157] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"556.302045ms","start":"2026-06-11T01:53:45.91633Z","end":"2026-06-11T01:53:46.472632Z","steps":["trace[1179955157] 'process raft request' (duration: 393.42371ms)","trace[1179955157] 'compare' (duration: 162.63876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:53:46.472695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:45.916316Z","time spent":"556.357854ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:46.544562Z","caller":"traceutil/trace.go:171","msg":"trace[1236006479] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"627.622407ms","start":"2026-06-11T01:53:45.916912Z","end":"2026-06-11T01:53:46.544535Z","steps":["trace[1236006479] 'process raft request' (duration: 627.543651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:46.544737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:45.916889Z","time spent":"627.759692ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:46.544563Z","caller":"traceutil/trace.go:171","msg":"trace[1154264588] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"628.198479ms","start":"2026-06-11T01:53:45.916336Z","end":"2026-06-11T01:53:46.544534Z","steps":["trace[1154264588] 'process raft request' (duration: 628.01261ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:53:46.544819Z","caller":"traceutil/trace.go:171","msg":"trace[1249763665] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"623.020522ms","start":"2026-06-11T01:53:45.921779Z","end":"2026-06-11T01:53:46.5448Z","steps":["trace[1249763665] 'process raft request' (duration: 622.911619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:46.544899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:45.916317Z","time spent":"628.514812ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:46.544903Z","caller":"traceutil/trace.go:171","msg":"trace[228781445] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"627.828509ms","start":"2026-06-11T01:53:45.917031Z","end":"2026-06-11T01:53:46.544859Z","steps":["trace[228781445] 'process raft request' (duration: 627.466761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:53:46.544943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:45.92177Z","time spent":"623.106788ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:53:46.545067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:53:45.916991Z","time spent":"627.985155ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:53:52.610782Z","caller":"traceutil/trace.go:171","msg":"trace[1658081169] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"104.39414ms","start":"2026-06-11T01:53:52.506346Z","end":"2026-06-11T01:53:52.61074Z","steps":["trace[1658081169] 'process raft request' (duration: 104.111344ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:05.085063Z","caller":"traceutil/trace.go:171","msg":"trace[117212736] linearizableReadLoop","detail":"{readStateIndex:504; appliedIndex:503; }","duration":"373.978356ms","start":"2026-06-11T01:54:04.711062Z","end":"2026-06-11T01:54:05.08504Z","steps":["trace[117212736] 'read index received' (duration: 373.86446ms)","trace[117212736] 'applied index is now lower than readState.Index' (duration: 113.056µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:54:05.085381Z","caller":"traceutil/trace.go:171","msg":"trace[1221178654] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"374.461813ms","start":"2026-06-11T01:54:04.710907Z","end":"2026-06-11T01:54:05.085369Z","steps":["trace[1221178654] 'process raft request' (duration: 373.945567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:05.085479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:04.710883Z","time spent":"374.532ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:54:05.085757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.663238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-11T01:54:05.085796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.90186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T01:54:05.085837Z","caller":"traceutil/trace.go:171","msg":"trace[1449570338] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:485; }","duration":"373.959789ms","start":"2026-06-11T01:54:04.711864Z","end":"2026-06-11T01:54:05.085824Z","steps":["trace[1449570338] 'agreement among raft nodes before linearized reading' (duration: 373.881111ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:05.085835Z","caller":"traceutil/trace.go:171","msg":"trace[886489083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:485; }","duration":"374.780345ms","start":"2026-06-11T01:54:04.711037Z","end":"2026-06-11T01:54:05.085817Z","steps":["trace[886489083] 'agreement among raft nodes before linearized reading' (duration: 374.615609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:05.085866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:04.711854Z","time spent":"374.005177ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T01:54:05.085879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:04.711026Z","time spent":"374.845004ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T01:54:05.086001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.876938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-11T01:54:05.086033Z","caller":"traceutil/trace.go:171","msg":"trace[209784986] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:485; }","duration":"371.921887ms","start":"2026-06-11T01:54:04.714103Z","end":"2026-06-11T01:54:05.086025Z","steps":["trace[209784986] 'agreement among raft nodes before linearized reading' (duration: 371.871598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:05.086059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:04.714097Z","time spent":"371.956516ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-11T01:54:06.187485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.719135ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T01:54:06.187585Z","caller":"traceutil/trace.go:171","msg":"trace[1932497964] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"1.098045663s","start":"2026-06-11T01:54:05.089521Z","end":"2026-06-11T01:54:06.187567Z","steps":["trace[1932497964] 'process raft request' (duration: 232.162493ms)","trace[1932497964] 'compare' (duration: 865.625487ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:54:06.187643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:05.089497Z","time spent":"1.098119802s","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:54:06.189486Z","caller":"traceutil/trace.go:171","msg":"trace[1921924251] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"1.099228125s","start":"2026-06-11T01:54:05.090243Z","end":"2026-06-11T01:54:06.189471Z","steps":["trace[1921924251] 'process raft request' (duration: 1.099116468s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:06.189587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:05.090229Z","time spent":"1.099306114s","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:54:06.189666Z","caller":"traceutil/trace.go:171","msg":"trace[2094357408] linearizableReadLoop","detail":"{readStateIndex:507; appliedIndex:505; }","duration":"493.286274ms","start":"2026-06-11T01:54:05.69636Z","end":"2026-06-11T01:54:06.189647Z","steps":["trace[2094357408] 'read index received' (duration: 492.958181ms)","trace[2094357408] 'applied index is now lower than readState.Index' (duration: 326.703µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:54:06.189729Z","caller":"traceutil/trace.go:171","msg":"trace[1834357707] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"1.099418201s","start":"2026-06-11T01:54:05.090284Z","end":"2026-06-11T01:54:06.189702Z","steps":["trace[1834357707] 'process raft request' (duration: 1.099151737s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:06.189761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.393381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:54:06.189899Z","caller":"traceutil/trace.go:171","msg":"trace[1002630415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:488; }","duration":"493.567967ms","start":"2026-06-11T01:54:05.696315Z","end":"2026-06-11T01:54:06.189883Z","steps":["trace[1002630415] 'agreement among raft nodes before linearized reading' (duration: 493.408441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:06.189944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:05.696294Z","time spent":"493.640486ms","remote":"127.0.0.1:38514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T01:54:06.189935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:05.090266Z","time spent":"1.099538258s","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:54:11.093658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.334809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"info","ts":"2026-06-11T01:54:11.093744Z","caller":"traceutil/trace.go:171","msg":"trace[901575035] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:498; }","duration":"552.474506ms","start":"2026-06-11T01:54:10.541251Z","end":"2026-06-11T01:54:11.093726Z","steps":["trace[901575035] 'range keys from in-memory index tree' (duration: 552.200511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:11.093787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:10.541232Z","time spent":"552.545635ms","remote":"127.0.0.1:38614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12692,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"info","ts":"2026-06-11T01:54:11.603547Z","caller":"traceutil/trace.go:171","msg":"trace[11533213] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"494.570181ms","start":"2026-06-11T01:54:11.108957Z","end":"2026-06-11T01:54:11.603528Z","steps":["trace[11533213] 'process raft request' (duration: 494.458063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:11.603676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:11.108946Z","time spent":"494.65977ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:54:11.971545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.056007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-11T01:54:11.971634Z","caller":"traceutil/trace.go:171","msg":"trace[938803561] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:499; }","duration":"241.186004ms","start":"2026-06-11T01:54:11.730428Z","end":"2026-06-11T01:54:11.971614Z","steps":["trace[938803561] 'range keys from in-memory index tree' (duration: 240.964787ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:11.971639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.967297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:54:11.971713Z","caller":"traceutil/trace.go:171","msg":"trace[2042517979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:499; }","duration":"275.097685ms","start":"2026-06-11T01:54:11.696598Z","end":"2026-06-11T01:54:11.971696Z","steps":["trace[2042517979] 'range keys from in-memory index tree' (duration: 274.77487ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:12.179912Z","caller":"traceutil/trace.go:171","msg":"trace[1238438574] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"123.938723ms","start":"2026-06-11T01:54:12.055946Z","end":"2026-06-11T01:54:12.179885Z","steps":["trace[1238438574] 'process raft request' (duration: 109.978229ms)","trace[1238438574] 'compare' (duration: 13.834416ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:54:15.393632Z","caller":"traceutil/trace.go:171","msg":"trace[2106914252] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"417.589423ms","start":"2026-06-11T01:54:14.976018Z","end":"2026-06-11T01:54:15.393607Z","steps":["trace[2106914252] 'process raft request' (duration: 417.466785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:15.393777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:14.976001Z","time spent":"417.712322ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T01:54:15.403107Z","caller":"traceutil/trace.go:171","msg":"trace[1350133570] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"420.232941ms","start":"2026-06-11T01:54:14.982861Z","end":"2026-06-11T01:54:15.403094Z","steps":["trace[1350133570] 'process raft request' (duration: 420.039274ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:15.403225Z","caller":"traceutil/trace.go:171","msg":"trace[524046892] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"413.037519ms","start":"2026-06-11T01:54:14.990172Z","end":"2026-06-11T01:54:15.40321Z","steps":["trace[524046892] 'process raft request' (duration: 412.806212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:15.403267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:14.982855Z","time spent":"420.33373ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T01:54:15.403307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:14.990161Z","time spent":"413.105657ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T01:54:15.403388Z","caller":"traceutil/trace.go:171","msg":"trace[897689615] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"410.911897ms","start":"2026-06-11T01:54:14.992466Z","end":"2026-06-11T01:54:15.403378Z","steps":["trace[897689615] 'process raft request' (duration: 410.702229ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:15.403389Z","caller":"traceutil/trace.go:171","msg":"trace[794602278] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"408.636987ms","start":"2026-06-11T01:54:14.994743Z","end":"2026-06-11T01:54:15.40338Z","steps":["trace[794602278] 'process raft request' (duration: 408.479609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:15.403429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:14.992433Z","time spent":"410.979516ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T01:54:15.40344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:14.994733Z","time spent":"408.685136ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T01:54:15.403516Z","caller":"traceutil/trace.go:171","msg":"trace[2009082837] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"408.076175ms","start":"2026-06-11T01:54:14.995433Z","end":"2026-06-11T01:54:15.403509Z","steps":["trace[2009082837] 'process raft request' (duration: 407.885508ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:15.403526Z","caller":"traceutil/trace.go:171","msg":"trace[231112418] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"402.287882ms","start":"2026-06-11T01:54:15.001227Z","end":"2026-06-11T01:54:15.403515Z","steps":["trace[231112418] 'process raft request' (duration: 402.164424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:15.403554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:14.995404Z","time spent":"408.134054ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T01:54:15.403563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:15.001217Z","time spent":"402.328482ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T01:54:15.403482Z","caller":"traceutil/trace.go:171","msg":"trace[1823050505] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"410.950196ms","start":"2026-06-11T01:54:14.992376Z","end":"2026-06-11T01:54:15.403326Z","steps":["trace[1823050505] 'process raft request' (duration: 410.742629ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:15.403709Z","caller":"traceutil/trace.go:171","msg":"trace[892849365] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"396.004491ms","start":"2026-06-11T01:54:15.007696Z","end":"2026-06-11T01:54:15.403701Z","steps":["trace[892849365] 'process raft request' (duration: 395.760784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:15.403751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:15.007672Z","time spent":"396.0605ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T01:54:15.403796Z","caller":"traceutil/trace.go:171","msg":"trace[397132284] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"231.100835ms","start":"2026-06-11T01:54:15.172678Z","end":"2026-06-11T01:54:15.403779Z","steps":["trace[397132284] 'process raft request' (duration: 231.011296ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:15.40307Z","caller":"traceutil/trace.go:171","msg":"trace[1844160561] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"420.27715ms","start":"2026-06-11T01:54:14.982763Z","end":"2026-06-11T01:54:15.40304Z","steps":["trace[1844160561] 'process raft request' (duration: 420.001123ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:15.403828Z","caller":"traceutil/trace.go:171","msg":"trace[86029589] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"371.149529ms","start":"2026-06-11T01:54:15.032651Z","end":"2026-06-11T01:54:15.4038Z","steps":["trace[86029589] 'process raft request' (duration: 370.877612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:15.403817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:14.992367Z","time spent":"411.314442ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T01:54:15.403918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:15.032632Z","time spent":"371.246508ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T01:54:15.40404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:14.982729Z","time spent":"421.13252ms","remote":"127.0.0.1:38570","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T01:54:21.844107Z","caller":"traceutil/trace.go:171","msg":"trace[1472407180] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"173.141592ms","start":"2026-06-11T01:54:21.670942Z","end":"2026-06-11T01:54:21.844084Z","steps":["trace[1472407180] 'read index received' (duration: 172.357865ms)","trace[1472407180] 'applied index is now lower than readState.Index' (duration: 782.817µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:54:21.844163Z","caller":"traceutil/trace.go:171","msg":"trace[561413859] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"373.435471ms","start":"2026-06-11T01:54:21.470707Z","end":"2026-06-11T01:54:21.844142Z","steps":["trace[561413859] 'process raft request' (duration: 372.814244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:21.844314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:21.47068Z","time spent":"373.555161ms","remote":"127.0.0.1:38614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:54:21.84436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.41585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T01:54:21.844515Z","caller":"traceutil/trace.go:171","msg":"trace[331907988] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"173.61173ms","start":"2026-06-11T01:54:21.670892Z","end":"2026-06-11T01:54:21.844504Z","steps":["trace[331907988] 'agreement among raft nodes before linearized reading' (duration: 173.348461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:21.844563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.782525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-11T01:54:21.844659Z","caller":"traceutil/trace.go:171","msg":"trace[1060035584] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:648; }","duration":"113.983584ms","start":"2026-06-11T01:54:21.730655Z","end":"2026-06-11T01:54:21.844639Z","steps":["trace[1060035584] 'agreement among raft nodes before linearized reading' (duration: 113.751445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:22.219603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.81532ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-11T01:54:22.219795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:21.845496Z","time spent":"374.295667ms","remote":"127.0.0.1:38556","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-11T01:54:22.243126Z","caller":"traceutil/trace.go:171","msg":"trace[1425922290] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"337.476595ms","start":"2026-06-11T01:54:21.90562Z","end":"2026-06-11T01:54:22.243101Z","steps":["trace[1425922290] 'process raft request' (duration: 337.432905ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:22.243218Z","caller":"traceutil/trace.go:171","msg":"trace[762411221] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"382.550742ms","start":"2026-06-11T01:54:21.860659Z","end":"2026-06-11T01:54:22.24321Z","steps":["trace[762411221] 'process raft request' (duration: 382.321822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:22.243308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:21.905592Z","time spent":"337.628045ms","remote":"127.0.0.1:38970","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-11T01:54:22.243163Z","caller":"traceutil/trace.go:171","msg":"trace[2073100470] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"392.512311ms","start":"2026-06-11T01:54:21.850631Z","end":"2026-06-11T01:54:22.243143Z","steps":["trace[2073100470] 'process raft request' (duration: 392.101942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:22.24334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:21.860628Z","time spent":"382.614791ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:54:22.24344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:21.850604Z","time spent":"392.7544ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:54:22.786081Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151665836465504,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T01:54:23.264352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.633028ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T01:54:23.264712Z","caller":"traceutil/trace.go:171","msg":"trace[60705171] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"984.597703ms","start":"2026-06-11T01:54:22.280081Z","end":"2026-06-11T01:54:23.264679Z","steps":["trace[60705171] 'process raft request' (duration: 615.443936ms)","trace[60705171] 'compare' (duration: 368.455758ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:54:23.264899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:22.280064Z","time spent":"984.723911ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:54:23.265582Z","caller":"traceutil/trace.go:171","msg":"trace[1450373018] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:677; }","duration":"979.832757ms","start":"2026-06-11T01:54:22.285716Z","end":"2026-06-11T01:54:23.265549Z","steps":["trace[1450373018] 'read index received' (duration: 609.836801ms)","trace[1450373018] 'applied index is now lower than readState.Index' (duration: 369.994586ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:54:23.265643Z","caller":"traceutil/trace.go:171","msg":"trace[50567782] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"597.288378ms","start":"2026-06-11T01:54:22.668322Z","end":"2026-06-11T01:54:23.26561Z","steps":["trace[50567782] 'process raft request' (duration: 596.4445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:23.265888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.850879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-11T01:54:23.265938Z","caller":"traceutil/trace.go:171","msg":"trace[1731308925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"943.95352ms","start":"2026-06-11T01:54:22.321969Z","end":"2026-06-11T01:54:23.265923Z","steps":["trace[1731308925] 'agreement among raft nodes before linearized reading' (duration: 943.77389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:23.26591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.170846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-11T01:54:23.265992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:22.321944Z","time spent":"944.03853ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T01:54:23.266005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:22.668288Z","time spent":"597.399228ms","remote":"127.0.0.1:38614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-11T01:54:23.266014Z","caller":"traceutil/trace.go:171","msg":"trace[1546785382] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:654; }","duration":"980.323807ms","start":"2026-06-11T01:54:22.285664Z","end":"2026-06-11T01:54:23.265988Z","steps":["trace[1546785382] 'agreement among raft nodes before linearized reading' (duration: 980.041847ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:23.266071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:22.285645Z","time spent":"980.417216ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-11T01:54:23.265965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.206208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:54:23.266212Z","caller":"traceutil/trace.go:171","msg":"trace[1635962213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"569.554189ms","start":"2026-06-11T01:54:22.696631Z","end":"2026-06-11T01:54:23.266185Z","steps":["trace[1635962213] 'agreement among raft nodes before linearized reading' (duration: 569.173068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:23.266621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:22.696609Z","time spent":"569.996497ms","remote":"127.0.0.1:38514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T01:54:38.817862Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151665836465823,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-11T01:54:39.019117Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.123418972s","expected-duration":"1s"} {"level":"info","ts":"2026-06-11T01:54:39.019638Z","caller":"traceutil/trace.go:171","msg":"trace[2120511641] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"702.713485ms","start":"2026-06-11T01:54:38.316898Z","end":"2026-06-11T01:54:39.019611Z","steps":["trace[2120511641] 'read index received' (duration: 702.36063ms)","trace[2120511641] 'applied index is now lower than readState.Index' (duration: 351.635µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:54:39.019777Z","caller":"traceutil/trace.go:171","msg":"trace[659221106] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"1.124181033s","start":"2026-06-11T01:54:37.895569Z","end":"2026-06-11T01:54:39.01975Z","steps":["trace[659221106] 'process raft request' (duration: 1.123771047s)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:39.019939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:37.895539Z","time spent":"1.124315805s","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:54:39.020025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.093301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T01:54:39.020132Z","caller":"traceutil/trace.go:171","msg":"trace[1026437235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:815; }","duration":"703.254593ms","start":"2026-06-11T01:54:38.316857Z","end":"2026-06-11T01:54:39.020111Z","steps":["trace[1026437235] 'agreement among raft nodes before linearized reading' (duration: 702.959678ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:39.020183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:38.316838Z","time spent":"703.335425ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-11T01:54:39.020174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.952734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T01:54:39.020284Z","caller":"traceutil/trace.go:171","msg":"trace[1320180429] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:815; }","duration":"304.107756ms","start":"2026-06-11T01:54:38.716155Z","end":"2026-06-11T01:54:39.020262Z","steps":["trace[1320180429] 'agreement among raft nodes before linearized reading' (duration: 303.872072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:39.020347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:38.716136Z","time spent":"304.196258ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-11T01:54:39.020453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.165248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-11T01:54:39.020589Z","caller":"traceutil/trace.go:171","msg":"trace[1939017519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:815; }","duration":"324.380642ms","start":"2026-06-11T01:54:38.696122Z","end":"2026-06-11T01:54:39.020503Z","steps":["trace[1939017519] 'agreement among raft nodes before linearized reading' (duration: 323.886484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:39.02066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:38.696103Z","time spent":"324.540235ms","remote":"127.0.0.1:38514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-11T01:54:53.383656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.319363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-11T01:54:53.383774Z","caller":"traceutil/trace.go:171","msg":"trace[2046548635] linearizableReadLoop","detail":"{readStateIndex:1007; appliedIndex:1006; }","duration":"353.791352ms","start":"2026-06-11T01:54:53.029955Z","end":"2026-06-11T01:54:53.383747Z","steps":["trace[2046548635] 'read index received' (duration: 237.260423ms)","trace[2046548635] 'applied index is now lower than readState.Index' (duration: 116.529599ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:54:53.383872Z","caller":"traceutil/trace.go:171","msg":"trace[1570948988] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"364.597587ms","start":"2026-06-11T01:54:53.019263Z","end":"2026-06-11T01:54:53.383861Z","steps":["trace[1570948988] 'process raft request' (duration: 247.969945ms)","trace[1570948988] 'compare' (duration: 116.209801ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:54:53.383934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:53.019229Z","time spent":"364.678529ms","remote":"127.0.0.1:38602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":816,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-11T01:54:53.384085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.73332ms","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-06-11T01:54:53.384147Z","caller":"traceutil/trace.go:171","msg":"trace[534641857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:974; }","duration":"220.794292ms","start":"2026-06-11T01:54:53.163332Z","end":"2026-06-11T01:54:53.384126Z","steps":["trace[534641857] 'agreement among raft nodes before linearized reading' (duration: 220.635998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:53.384197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.226233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/local-path-storage/local-path-config\" ","response":"range_response_count:1 size:1464"} {"level":"warn","ts":"2026-06-11T01:54:53.384237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.291909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T01:54:53.38429Z","caller":"traceutil/trace.go:171","msg":"trace[1478318219] range","detail":"{range_begin:/registry/configmaps/local-path-storage/local-path-config; range_end:; response_count:1; response_revision:974; }","duration":"354.344517ms","start":"2026-06-11T01:54:53.029922Z","end":"2026-06-11T01:54:53.384267Z","steps":["trace[1478318219] 'agreement among raft nodes before linearized reading' (duration: 354.149911ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:54:53.384305Z","caller":"traceutil/trace.go:171","msg":"trace[895739970] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:974; }","duration":"216.423262ms","start":"2026-06-11T01:54:53.167866Z","end":"2026-06-11T01:54:53.384289Z","steps":["trace[895739970] 'agreement among raft nodes before linearized reading' (duration: 216.214497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:54:53.384325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:54:53.029908Z","time spent":"354.409139ms","remote":"127.0.0.1:38618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1487,"request content":"key:\"/registry/configmaps/local-path-storage/local-path-config\" "} {"level":"info","ts":"2026-06-11T01:54:54.120902Z","caller":"traceutil/trace.go:171","msg":"trace[483559695] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"152.615324ms","start":"2026-06-11T01:54:53.967876Z","end":"2026-06-11T01:54:54.120492Z","steps":["trace[483559695] 'process raft request' (duration: 152.47053ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:55:32.569667Z","caller":"traceutil/trace.go:171","msg":"trace[1654138904] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"244.905428ms","start":"2026-06-11T01:55:32.324735Z","end":"2026-06-11T01:55:32.569641Z","steps":["trace[1654138904] 'process raft request' (duration: 244.73661ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:55:33.746344Z","caller":"traceutil/trace.go:171","msg":"trace[2058157116] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"100.163369ms","start":"2026-06-11T01:55:33.646164Z","end":"2026-06-11T01:55:33.746327Z","steps":["trace[2058157116] 'process raft request' (duration: 49.860284ms)","trace[2058157116] 'compare' (duration: 50.139977ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:55:33.984309Z","caller":"traceutil/trace.go:171","msg":"trace[795921856] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"234.471097ms","start":"2026-06-11T01:55:33.749808Z","end":"2026-06-11T01:55:33.984279Z","steps":["trace[795921856] 'process raft request' (duration: 233.635675ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:55:33.984656Z","caller":"traceutil/trace.go:171","msg":"trace[601949691] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"233.890218ms","start":"2026-06-11T01:55:33.750747Z","end":"2026-06-11T01:55:33.984638Z","steps":["trace[601949691] 'process raft request' (duration: 233.787953ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:55:50.620525Z","caller":"traceutil/trace.go:171","msg":"trace[1133057526] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1224; }","duration":"485.77932ms","start":"2026-06-11T01:55:50.134722Z","end":"2026-06-11T01:55:50.620501Z","steps":["trace[1133057526] 'read index received' (duration: 485.650412ms)","trace[1133057526] 'applied index is now lower than readState.Index' (duration: 127.837µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:55:50.620581Z","caller":"traceutil/trace.go:171","msg":"trace[492176117] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"543.525753ms","start":"2026-06-11T01:55:50.077033Z","end":"2026-06-11T01:55:50.620559Z","steps":["trace[492176117] 'process raft request' (duration: 543.313921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:55:50.620693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.953119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T01:55:50.620738Z","caller":"traceutil/trace.go:171","msg":"trace[580936123] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1180; }","duration":"486.047825ms","start":"2026-06-11T01:55:50.134678Z","end":"2026-06-11T01:55:50.620725Z","steps":["trace[580936123] 'agreement among raft nodes before linearized reading' (duration: 485.95305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:55:50.620792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:55:50.134662Z","time spent":"486.117289ms","remote":"127.0.0.1:38692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":3,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-06-11T01:55:50.620707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:55:50.077011Z","time spent":"543.619829ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:55:50.621164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.425939ms","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-06-11T01:55:50.621246Z","caller":"traceutil/trace.go:171","msg":"trace[1241741741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1180; }","duration":"483.531374ms","start":"2026-06-11T01:55:50.137697Z","end":"2026-06-11T01:55:50.621228Z","steps":["trace[1241741741] 'agreement among raft nodes before linearized reading' (duration: 483.301051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:55:50.621293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:55:50.13769Z","time spent":"483.593118ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-11T01:56:10.026548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.882585ms","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-06-11T01:56:10.026615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.928846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T01:56:10.026649Z","caller":"traceutil/trace.go:171","msg":"trace[1093615442] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1242; }","duration":"159.045586ms","start":"2026-06-11T01:56:09.867583Z","end":"2026-06-11T01:56:10.026628Z","steps":["trace[1093615442] 'range keys from in-memory index tree' (duration: 158.644042ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:10.026701Z","caller":"traceutil/trace.go:171","msg":"trace[538680367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1242; }","duration":"168.053954ms","start":"2026-06-11T01:56:09.858625Z","end":"2026-06-11T01:56:10.026679Z","steps":["trace[538680367] 'range keys from in-memory index tree' (duration: 167.682041ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:10.182977Z","caller":"traceutil/trace.go:171","msg":"trace[895282805] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"150.617101ms","start":"2026-06-11T01:56:10.032332Z","end":"2026-06-11T01:56:10.182949Z","steps":["trace[895282805] 'process raft request' (duration: 150.43082ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:10.215948Z","caller":"traceutil/trace.go:171","msg":"trace[624210698] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"183.530983ms","start":"2026-06-11T01:56:10.032399Z","end":"2026-06-11T01:56:10.21593Z","steps":["trace[624210698] 'process raft request' (duration: 183.49674ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:10.216104Z","caller":"traceutil/trace.go:171","msg":"trace[294572291] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"183.597267ms","start":"2026-06-11T01:56:10.032381Z","end":"2026-06-11T01:56:10.215979Z","steps":["trace[294572291] 'process raft request' (duration: 183.417316ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:16.384021Z","caller":"traceutil/trace.go:171","msg":"trace[587940261] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1322; }","duration":"146.68818ms","start":"2026-06-11T01:56:16.237296Z","end":"2026-06-11T01:56:16.383985Z","steps":["trace[587940261] 'read index received' (duration: 8.027651ms)","trace[587940261] 'applied index is now lower than readState.Index' (duration: 138.658829ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:56:16.384241Z","caller":"traceutil/trace.go:171","msg":"trace[1630500785] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"168.994121ms","start":"2026-06-11T01:56:16.215176Z","end":"2026-06-11T01:56:16.38417Z","steps":["trace[1630500785] 'process raft request' (duration: 97.276878ms)","trace[1630500785] 'compare' (duration: 71.370632ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:56:16.38441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.098926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-11T01:56:16.384471Z","caller":"traceutil/trace.go:171","msg":"trace[370883148] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1273; }","duration":"147.206443ms","start":"2026-06-11T01:56:16.237251Z","end":"2026-06-11T01:56:16.384457Z","steps":["trace[370883148] 'agreement among raft nodes before linearized reading' (duration: 146.975198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:16.384528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.539248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-11T01:56:16.384601Z","caller":"traceutil/trace.go:171","msg":"trace[1809829826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1273; }","duration":"145.647436ms","start":"2026-06-11T01:56:16.238934Z","end":"2026-06-11T01:56:16.384582Z","steps":["trace[1809829826] 'agreement among raft nodes before linearized reading' (duration: 145.311994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:19.530782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.960187ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-11T01:56:19.530889Z","caller":"traceutil/trace.go:171","msg":"trace[456626073] linearizableReadLoop","detail":"{readStateIndex:1339; appliedIndex:1338; }","duration":"307.327806ms","start":"2026-06-11T01:56:19.223543Z","end":"2026-06-11T01:56:19.530871Z","steps":["trace[456626073] 'read index received' (duration: 12.129054ms)","trace[456626073] 'applied index is now lower than readState.Index' (duration: 295.197202ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:56:19.530925Z","caller":"traceutil/trace.go:171","msg":"trace[2066972264] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"480.486342ms","start":"2026-06-11T01:56:19.050409Z","end":"2026-06-11T01:56:19.530895Z","steps":["trace[2066972264] 'process raft request' (duration: 185.326192ms)","trace[2066972264] 'compare' (duration: 294.588873ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:56:19.531062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.523509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-600ec978-a2c5-475a-b9ea-1cfbc01b6193\" ","response":"range_response_count:1 size:3578"} {"level":"info","ts":"2026-06-11T01:56:19.5311Z","caller":"traceutil/trace.go:171","msg":"trace[2115705429] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-600ec978-a2c5-475a-b9ea-1cfbc01b6193; range_end:; response_count:1; response_revision:1287; }","duration":"307.596953ms","start":"2026-06-11T01:56:19.223489Z","end":"2026-06-11T01:56:19.531086Z","steps":["trace[2115705429] 'agreement among raft nodes before linearized reading' (duration: 307.429612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:19.531127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:56:19.050393Z","time spent":"480.624271ms","remote":"127.0.0.1:38742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-11T01:56:19.531136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-11T01:56:19.223469Z","time spent":"307.658107ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3601,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-600ec978-a2c5-475a-b9ea-1cfbc01b6193\" "} {"level":"warn","ts":"2026-06-11T01:56:19.899255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.972214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-11T01:56:19.899363Z","caller":"traceutil/trace.go:171","msg":"trace[362504830] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1288; }","duration":"153.151025ms","start":"2026-06-11T01:56:19.746186Z","end":"2026-06-11T01:56:19.899337Z","steps":["trace[362504830] 'count revisions from in-memory index tree' (duration: 152.885228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:20.514358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.58477ms","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-06-11T01:56:20.514402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.423217ms","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-06-11T01:56:20.514483Z","caller":"traceutil/trace.go:171","msg":"trace[759798949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1289; }","duration":"108.803834ms","start":"2026-06-11T01:56:20.405651Z","end":"2026-06-11T01:56:20.514455Z","steps":["trace[759798949] 'range keys from in-memory index tree' (duration: 108.311773ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:20.514506Z","caller":"traceutil/trace.go:171","msg":"trace[1366288108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1289; }","duration":"110.591467ms","start":"2026-06-11T01:56:20.403885Z","end":"2026-06-11T01:56:20.514476Z","steps":["trace[1366288108] 'range keys from in-memory index tree' (duration: 110.108247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:20.51764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.227802ms","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-06-11T01:56:20.517768Z","caller":"traceutil/trace.go:171","msg":"trace[290358196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1289; }","duration":"248.414204ms","start":"2026-06-11T01:56:20.269326Z","end":"2026-06-11T01:56:20.51774Z","steps":["trace[290358196] 'range keys from in-memory index tree' (duration: 247.992227ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:32.858899Z","caller":"traceutil/trace.go:171","msg":"trace[786608214] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1409; }","duration":"213.995008ms","start":"2026-06-11T01:56:32.64488Z","end":"2026-06-11T01:56:32.858875Z","steps":["trace[786608214] 'read index received' (duration: 213.804445ms)","trace[786608214] 'applied index is now lower than readState.Index' (duration: 189.093µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:56:32.859083Z","caller":"traceutil/trace.go:171","msg":"trace[1138075847] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"261.165418ms","start":"2026-06-11T01:56:32.597874Z","end":"2026-06-11T01:56:32.85904Z","steps":["trace[1138075847] 'process raft request' (duration: 260.822865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:32.859158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.263615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-11T01:56:32.859193Z","caller":"traceutil/trace.go:171","msg":"trace[104733843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1354; }","duration":"214.357562ms","start":"2026-06-11T01:56:32.644824Z","end":"2026-06-11T01:56:32.859182Z","steps":["trace[104733843] 'agreement among raft nodes before linearized reading' (duration: 214.220893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:32.859592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.252975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-11T01:56:32.859686Z","caller":"traceutil/trace.go:171","msg":"trace[1779717596] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1354; }","duration":"214.387553ms","start":"2026-06-11T01:56:32.64528Z","end":"2026-06-11T01:56:32.859668Z","steps":["trace[1779717596] 'agreement among raft nodes before linearized reading' (duration: 214.109015ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:33.420816Z","caller":"traceutil/trace.go:171","msg":"trace[1605591930] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"100.26059ms","start":"2026-06-11T01:56:33.320529Z","end":"2026-06-11T01:56:33.42079Z","steps":["trace[1605591930] 'process raft request' (duration: 100.115131ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:37.054613Z","caller":"traceutil/trace.go:171","msg":"trace[578221329] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"160.969615ms","start":"2026-06-11T01:56:36.893617Z","end":"2026-06-11T01:56:37.054587Z","steps":["trace[578221329] 'process raft request' (duration: 82.421922ms)","trace[578221329] 'compare' (duration: 78.391883ms)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:56:37.13643Z","caller":"traceutil/trace.go:171","msg":"trace[1247244579] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1428; }","duration":"155.911024ms","start":"2026-06-11T01:56:36.980485Z","end":"2026-06-11T01:56:37.136396Z","steps":["trace[1247244579] 'read index received' (duration: 64.220278ms)","trace[1247244579] 'applied index is now lower than readState.Index' (duration: 91.688685ms)"],"step_count":2} {"level":"warn","ts":"2026-06-11T01:56:37.136905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.404686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050260"} {"level":"info","ts":"2026-06-11T01:56:37.136993Z","caller":"traceutil/trace.go:171","msg":"trace[785100398] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:1373; }","duration":"156.541364ms","start":"2026-06-11T01:56:36.980431Z","end":"2026-06-11T01:56:37.136972Z","steps":["trace[785100398] 'agreement among raft nodes before linearized reading' (duration: 156.092715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:37.147041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.653115ms","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-06-11T01:56:37.147587Z","caller":"traceutil/trace.go:171","msg":"trace[999157914] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1374; }","duration":"104.252645ms","start":"2026-06-11T01:56:37.043309Z","end":"2026-06-11T01:56:37.147562Z","steps":["trace[999157914] 'agreement among raft nodes before linearized reading' (duration: 103.558699ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:43.222733Z","caller":"traceutil/trace.go:171","msg":"trace[1367785919] linearizableReadLoop","detail":"{readStateIndex:1452; appliedIndex:1451; }","duration":"140.803568ms","start":"2026-06-11T01:56:43.081904Z","end":"2026-06-11T01:56:43.222708Z","steps":["trace[1367785919] 'read index received' (duration: 140.631095ms)","trace[1367785919] 'applied index is now lower than readState.Index' (duration: 171.053µs)"],"step_count":2} {"level":"info","ts":"2026-06-11T01:56:43.222779Z","caller":"traceutil/trace.go:171","msg":"trace[113227252] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"142.837993ms","start":"2026-06-11T01:56:43.079914Z","end":"2026-06-11T01:56:43.222752Z","steps":["trace[113227252] 'process raft request' (duration: 142.595396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:43.223296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.187233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:node-autoapprove-certificate-rotation\" ","response":"range_response_count:1 size:541"} {"level":"info","ts":"2026-06-11T01:56:43.223409Z","caller":"traceutil/trace.go:171","msg":"trace[1601150981] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:node-autoapprove-certificate-rotation; range_end:; response_count:1; response_revision:1394; }","duration":"141.488243ms","start":"2026-06-11T01:56:43.081886Z","end":"2026-06-11T01:56:43.223375Z","steps":["trace[1601150981] 'agreement among raft nodes before linearized reading' (duration: 141.040853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:43.282634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.076872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:namespace-controller\" ","response":"range_response_count:1 size:723"} {"level":"info","ts":"2026-06-11T01:56:43.282654Z","caller":"traceutil/trace.go:171","msg":"trace[1957420388] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"113.542364ms","start":"2026-06-11T01:56:43.169086Z","end":"2026-06-11T01:56:43.282629Z","steps":["trace[1957420388] 'process raft request' (duration: 105.932535ms)"],"step_count":1} {"level":"warn","ts":"2026-06-11T01:56:43.282707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.5422ms","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-06-11T01:56:43.282727Z","caller":"traceutil/trace.go:171","msg":"trace[819077406] range","detail":"{range_begin:/registry/clusterroles/system:controller:namespace-controller; range_end:; response_count:1; response_revision:1395; }","duration":"142.215352ms","start":"2026-06-11T01:56:43.140484Z","end":"2026-06-11T01:56:43.282699Z","steps":["trace[819077406] 'agreement among raft nodes before linearized reading' (duration: 142.056321ms)"],"step_count":1} {"level":"info","ts":"2026-06-11T01:56:43.282767Z","caller":"traceutil/trace.go:171","msg":"trace[2097487407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1395; }","duration":"111.656057ms","start":"2026-06-11T01:56:43.171097Z","end":"2026-06-11T01:56:43.282753Z","steps":["trace[2097487407] 'agreement among raft nodes before linearized reading' (duration: 111.432782ms)"],"step_count":1}