{"level":"warn","ts":"2026-04-25T00:38:52.954783Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-25T00:38:52.95489Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-04-25T00:38:52.955014Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-25T00:38:52.955032Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-25T00:38:52.955055Z","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-04-25T00:38:52.95624Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-04-25T00:38:52.956531Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-04-25T00:38:52.965018Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.293198ms"} {"level":"info","ts":"2026-04-25T00:38:52.973083Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-04-25T00:38:52.973206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-04-25T00:38:52.973331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-04-25T00:38:52.973372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-25T00:38:52.973387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-04-25T00:38:52.973505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-04-25T00:38:52.986033Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-25T00:38:52.987514Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-25T00:38:52.988939Z","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-04-25T00:38:52.99111Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-25T00:38:52.99141Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-25T00:38:52.991544Z","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-04-25T00:38:52.991628Z","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-04-25T00:38:52.991638Z","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-04-25T00:38:52.994032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-04-25T00:38:52.994198Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-25T00:38:52.996429Z","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-04-25T00:38:52.996678Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-25T00:38:52.996891Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-25T00:38:52.996705Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-25T00:38:52.996739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-25T00:38:53.774488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-04-25T00:38:53.774551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-25T00:38:53.774591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-04-25T00:38:53.774622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-04-25T00:38:53.77466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-25T00:38:53.77469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-04-25T00:38:53.774714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-25T00:38:53.859945Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T00:38:53.86752Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-25T00:38:53.867512Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-04-25T00:38:53.867802Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-25T00:38:53.867942Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-25T00:38:53.868285Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-25T00:38:53.868284Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T00:38:53.868463Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T00:38:53.868521Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T00:38:53.87043Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-25T00:38:53.871898Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"warn","ts":"2026-04-25T00:39:00.922438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.497447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T00:39:00.922707Z","caller":"traceutil/trace.go:171","msg":"trace[151927371] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"982.459594ms","start":"2026-04-25T00:38:59.940208Z","end":"2026-04-25T00:39:00.922667Z","steps":["trace[151927371] 'process raft request' (duration: 382.114764ms)","trace[151927371] 'compare' (duration: 599.350482ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:00.922831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.105638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-25T00:39:00.922929Z","caller":"traceutil/trace.go:171","msg":"trace[1706594646] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:267; }","duration":"937.260492ms","start":"2026-04-25T00:38:59.985642Z","end":"2026-04-25T00:39:00.922902Z","steps":["trace[1706594646] 'agreement among raft nodes before linearized reading' (duration: 937.086107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:00.922993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:38:59.985611Z","time spent":"937.371995ms","remote":"127.0.0.1:46206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-25T00:39:00.922916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:38:59.940194Z","time spent":"982.623518ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T00:39:00.922564Z","caller":"traceutil/trace.go:171","msg":"trace[2028427420] linearizableReadLoop","detail":"{readStateIndex:280; appliedIndex:279; }","duration":"936.84113ms","start":"2026-04-25T00:38:59.985707Z","end":"2026-04-25T00:39:00.922548Z","steps":["trace[2028427420] 'read index received' (duration: 336.559661ms)","trace[2028427420] 'applied index is now lower than readState.Index' (duration: 600.280159ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:00.923581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.608537ms","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-04-25T00:39:00.923616Z","caller":"traceutil/trace.go:171","msg":"trace[2084593699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:267; }","duration":"566.733531ms","start":"2026-04-25T00:39:00.356868Z","end":"2026-04-25T00:39:00.923602Z","steps":["trace[2084593699] 'agreement among raft nodes before linearized reading' (duration: 566.623568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:00.923651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:00.356835Z","time spent":"566.808923ms","remote":"127.0.0.1:46372","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-04-25T00:39:01.708012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.38054ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T00:39:01.708154Z","caller":"traceutil/trace.go:171","msg":"trace[1760645715] linearizableReadLoop","detail":"{readStateIndex:282; appliedIndex:281; }","duration":"780.716428ms","start":"2026-04-25T00:39:00.927415Z","end":"2026-04-25T00:39:01.708132Z","steps":["trace[1760645715] 'read index received' (duration: 64.909294ms)","trace[1760645715] 'applied index is now lower than readState.Index' (duration: 715.804674ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:01.708234Z","caller":"traceutil/trace.go:171","msg":"trace[1211409153] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"780.974396ms","start":"2026-04-25T00:39:00.927222Z","end":"2026-04-25T00:39:01.708197Z","steps":["trace[1211409153] 'process raft request' (duration: 138.278217ms)","trace[1211409153] 'compare' (duration: 642.215316ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:01.708327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.098801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T00:39:01.708317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.875122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"warn","ts":"2026-04-25T00:39:01.708394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:00.927197Z","time spent":"781.104589ms","remote":"127.0.0.1:46372","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-04-25T00:39:01.708423Z","caller":"traceutil/trace.go:171","msg":"trace[902585256] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:269; }","duration":"781.032166ms","start":"2026-04-25T00:39:00.927366Z","end":"2026-04-25T00:39:01.708399Z","steps":["trace[902585256] 'agreement among raft nodes before linearized reading' (duration: 780.82072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:01.708474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:00.927347Z","time spent":"781.11714ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":3997,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-04-25T00:39:01.70848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.035688ms","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-04-25T00:39:01.70851Z","caller":"traceutil/trace.go:171","msg":"trace[1673111663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:269; }","duration":"425.08853ms","start":"2026-04-25T00:39:01.283413Z","end":"2026-04-25T00:39:01.708501Z","steps":["trace[1673111663] 'agreement among raft nodes before linearized reading' (duration: 425.039679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:01.708556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:01.283397Z","time spent":"425.151411ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-25T00:39:01.708435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.565392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-25T00:39:01.708688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.804931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-25T00:39:01.708368Z","caller":"traceutil/trace.go:171","msg":"trace[250828069] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:0; response_revision:269; }","duration":"712.169943ms","start":"2026-04-25T00:39:00.996184Z","end":"2026-04-25T00:39:01.708354Z","steps":["trace[250828069] 'agreement among raft nodes before linearized reading' (duration: 712.098121ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:01.708715Z","caller":"traceutil/trace.go:171","msg":"trace[1613940266] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:269; }","duration":"516.863942ms","start":"2026-04-25T00:39:01.191843Z","end":"2026-04-25T00:39:01.708707Z","steps":["trace[1613940266] 'agreement among raft nodes before linearized reading' (duration: 516.798071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:01.708736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:01.191824Z","time spent":"516.908504ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-25T00:39:01.708784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:00.996166Z","time spent":"712.573714ms","remote":"127.0.0.1:46300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" "} {"level":"info","ts":"2026-04-25T00:39:01.708785Z","caller":"traceutil/trace.go:171","msg":"trace[1906759912] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:269; }","duration":"219.903831ms","start":"2026-04-25T00:39:01.488834Z","end":"2026-04-25T00:39:01.708738Z","steps":["trace[1906759912] 'agreement among raft nodes before linearized reading' (duration: 219.569382ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:02.189293Z","caller":"traceutil/trace.go:171","msg":"trace[1040912508] transaction","detail":"{read_only:false; response_revision:270; number_of_response:1; }","duration":"475.659626ms","start":"2026-04-25T00:39:01.713612Z","end":"2026-04-25T00:39:02.189272Z","steps":["trace[1040912508] 'process raft request' (duration: 475.558693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:02.189519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:01.713595Z","time spent":"475.840301ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T00:39:02.196744Z","caller":"traceutil/trace.go:171","msg":"trace[1558663888] transaction","detail":"{read_only:false; response_revision:271; number_of_response:1; }","duration":"482.962954ms","start":"2026-04-25T00:39:01.713764Z","end":"2026-04-25T00:39:02.196727Z","steps":["trace[1558663888] 'process raft request' (duration: 482.742969ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:02.196783Z","caller":"traceutil/trace.go:171","msg":"trace[802745543] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"481.00961ms","start":"2026-04-25T00:39:01.715753Z","end":"2026-04-25T00:39:02.196763Z","steps":["trace[802745543] 'process raft request' (duration: 480.968179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:02.196867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:01.713745Z","time spent":"483.062828ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T00:39:02.196918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:01.715742Z","time spent":"481.104114ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T00:39:02.197041Z","caller":"traceutil/trace.go:171","msg":"trace[2122089786] transaction","detail":"{read_only:false; response_revision:272; number_of_response:1; }","duration":"482.566974ms","start":"2026-04-25T00:39:01.714434Z","end":"2026-04-25T00:39:02.197001Z","steps":["trace[2122089786] 'process raft request' (duration: 482.220865ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:02.197084Z","caller":"traceutil/trace.go:171","msg":"trace[210636602] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"481.821723ms","start":"2026-04-25T00:39:01.715117Z","end":"2026-04-25T00:39:02.196938Z","steps":["trace[210636602] 'process raft request' (duration: 481.561766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:02.197204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:01.714417Z","time spent":"482.706027ms","remote":"127.0.0.1:46372","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-04-25T00:39:02.197228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:01.715107Z","time spent":"482.062749ms","remote":"127.0.0.1:46300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T00:39:14.365621Z","caller":"traceutil/trace.go:171","msg":"trace[1090166463] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"102.827923ms","start":"2026-04-25T00:39:14.262771Z","end":"2026-04-25T00:39:14.365599Z","steps":["trace[1090166463] 'process raft request' (duration: 102.713569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:14.718717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.231687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T00:39:14.718887Z","caller":"traceutil/trace.go:171","msg":"trace[249736821] transaction","detail":"{read_only:false; response_revision:409; number_of_response:1; }","duration":"348.419128ms","start":"2026-04-25T00:39:14.370435Z","end":"2026-04-25T00:39:14.718854Z","steps":["trace[249736821] 'process raft request' (duration: 170.934814ms)","trace[249736821] 'compare' (duration: 177.076663ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:14.718986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:14.370417Z","time spent":"348.52612ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T00:39:14.782902Z","caller":"traceutil/trace.go:171","msg":"trace[1654291700] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"412.124361ms","start":"2026-04-25T00:39:14.370759Z","end":"2026-04-25T00:39:14.782884Z","steps":["trace[1654291700] 'process raft request' (duration: 412.033069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:14.783002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:14.370749Z","time spent":"412.199443ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T00:39:20.573563Z","caller":"traceutil/trace.go:171","msg":"trace[349876808] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"311.493324ms","start":"2026-04-25T00:39:20.262044Z","end":"2026-04-25T00:39:20.573537Z","steps":["trace[349876808] 'process raft request' (duration: 311.201426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:20.573694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.26202Z","time spent":"311.622787ms","remote":"127.0.0.1:46154","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-04-25T00:39:20.617075Z","caller":"traceutil/trace.go:171","msg":"trace[54121573] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"349.032467ms","start":"2026-04-25T00:39:20.268012Z","end":"2026-04-25T00:39:20.617045Z","steps":["trace[54121573] 'process raft request' (duration: 348.762921ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:20.617196Z","caller":"traceutil/trace.go:171","msg":"trace[1976084879] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"342.463085ms","start":"2026-04-25T00:39:20.27468Z","end":"2026-04-25T00:39:20.617143Z","steps":["trace[1976084879] 'process raft request' (duration: 342.316542ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:20.617272Z","caller":"traceutil/trace.go:171","msg":"trace[114871816] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"333.310115ms","start":"2026-04-25T00:39:20.28392Z","end":"2026-04-25T00:39:20.61723Z","steps":["trace[114871816] 'process raft request' (duration: 333.177832ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:20.617357Z","caller":"traceutil/trace.go:171","msg":"trace[1349591584] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"329.421016ms","start":"2026-04-25T00:39:20.287925Z","end":"2026-04-25T00:39:20.617346Z","steps":["trace[1349591584] 'process raft request' (duration: 329.217651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:20.617422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.2839Z","time spent":"333.443049ms","remote":"127.0.0.1:46154","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-04-25T00:39:20.617497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.287918Z","time spent":"329.483287ms","remote":"127.0.0.1:46154","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-04-25T00:39:20.617521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.267992Z","time spent":"349.227332ms","remote":"127.0.0.1:46154","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-04-25T00:39:20.617131Z","caller":"traceutil/trace.go:171","msg":"trace[1262562780] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"348.356111ms","start":"2026-04-25T00:39:20.26874Z","end":"2026-04-25T00:39:20.617096Z","steps":["trace[1262562780] 'process raft request' (duration: 348.202688ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:20.617699Z","caller":"traceutil/trace.go:171","msg":"trace[1295166182] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"326.053698ms","start":"2026-04-25T00:39:20.291609Z","end":"2026-04-25T00:39:20.617662Z","steps":["trace[1295166182] 'process raft request' (duration: 325.641239ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:20.617826Z","caller":"traceutil/trace.go:171","msg":"trace[906524255] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"317.789908ms","start":"2026-04-25T00:39:20.300024Z","end":"2026-04-25T00:39:20.617814Z","steps":["trace[906524255] 'process raft request' (duration: 317.503932ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:20.617854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.291602Z","time spent":"326.186101ms","remote":"127.0.0.1:46154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T00:39:20.617882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.300011Z","time spent":"317.848619ms","remote":"127.0.0.1:46154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T00:39:20.617737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.268733Z","time spent":"348.978005ms","remote":"127.0.0.1:46154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T00:39:20.617971Z","caller":"traceutil/trace.go:171","msg":"trace[1974480322] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"297.593744ms","start":"2026-04-25T00:39:20.320365Z","end":"2026-04-25T00:39:20.617959Z","steps":["trace[1974480322] 'process raft request' (duration: 297.323248ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:20.617982Z","caller":"traceutil/trace.go:171","msg":"trace[1247557528] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"340.818317ms","start":"2026-04-25T00:39:20.277119Z","end":"2026-04-25T00:39:20.617938Z","steps":["trace[1247557528] 'process raft request' (duration: 339.922507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:20.61817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.2771Z","time spent":"341.016482ms","remote":"127.0.0.1:46154","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-04-25T00:39:20.618208Z","caller":"traceutil/trace.go:171","msg":"trace[1396053406] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"283.94581ms","start":"2026-04-25T00:39:20.33425Z","end":"2026-04-25T00:39:20.618196Z","steps":["trace[1396053406] 'process raft request' (duration: 283.595642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:20.618148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:20.274655Z","time spent":"342.704981ms","remote":"127.0.0.1:46154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-25T00:39:20.619007Z","caller":"traceutil/trace.go:171","msg":"trace[588140666] linearizableReadLoop","detail":"{readStateIndex:485; appliedIndex:474; }","duration":"231.185087ms","start":"2026-04-25T00:39:20.387796Z","end":"2026-04-25T00:39:20.618981Z","steps":["trace[588140666] 'read index received' (duration: 185.521816ms)","trace[588140666] 'applied index is now lower than readState.Index' (duration: 45.661661ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:20.619263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.558915ms","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-04-25T00:39:20.619309Z","caller":"traceutil/trace.go:171","msg":"trace[817155904] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:469; }","duration":"231.648797ms","start":"2026-04-25T00:39:20.387647Z","end":"2026-04-25T00:39:20.619296Z","steps":["trace[817155904] 'agreement among raft nodes before linearized reading' (duration: 231.431242ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:20.619757Z","caller":"traceutil/trace.go:171","msg":"trace[140558295] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"163.007729ms","start":"2026-04-25T00:39:20.456735Z","end":"2026-04-25T00:39:20.619742Z","steps":["trace[140558295] 'process raft request' (duration: 161.31199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:26.951123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.473449ms","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-04-25T00:39:26.951209Z","caller":"traceutil/trace.go:171","msg":"trace[1416558422] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:562; }","duration":"284.600922ms","start":"2026-04-25T00:39:26.666591Z","end":"2026-04-25T00:39:26.951192Z","steps":["trace[1416558422] 'range keys from in-memory index tree' (duration: 284.276335ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:27.142101Z","caller":"traceutil/trace.go:171","msg":"trace[216950894] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"467.851384ms","start":"2026-04-25T00:39:26.67423Z","end":"2026-04-25T00:39:27.142082Z","steps":["trace[216950894] 'process raft request' (duration: 460.756991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:27.142233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.211406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-25T00:39:27.142308Z","caller":"traceutil/trace.go:171","msg":"trace[992306717] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:563; }","duration":"363.341608ms","start":"2026-04-25T00:39:26.778928Z","end":"2026-04-25T00:39:27.142269Z","steps":["trace[992306717] 'agreement among raft nodes before linearized reading' (duration: 363.205025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:27.142241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:26.674202Z","time spent":"467.949237ms","remote":"127.0.0.1:46194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T00:39:27.142373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:26.778886Z","time spent":"363.455611ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-25T00:39:27.142079Z","caller":"traceutil/trace.go:171","msg":"trace[1429012582] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:584; }","duration":"363.026162ms","start":"2026-04-25T00:39:26.778995Z","end":"2026-04-25T00:39:27.142021Z","steps":["trace[1429012582] 'read index received' (duration: 355.630742ms)","trace[1429012582] 'applied index is now lower than readState.Index' (duration: 7.39415ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:27.462999Z","caller":"traceutil/trace.go:171","msg":"trace[1433330901] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"320.397619ms","start":"2026-04-25T00:39:27.142567Z","end":"2026-04-25T00:39:27.462965Z","steps":["trace[1433330901] 'read index received' (duration: 320.151983ms)","trace[1433330901] 'applied index is now lower than readState.Index' (duration: 243.905µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:27.463044Z","caller":"traceutil/trace.go:171","msg":"trace[1886221454] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"507.382241ms","start":"2026-04-25T00:39:26.955616Z","end":"2026-04-25T00:39:27.462998Z","steps":["trace[1886221454] 'process raft request' (duration: 507.134756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:27.463236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.355144ms","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-04-25T00:39:27.463282Z","caller":"traceutil/trace.go:171","msg":"trace[2024624002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:564; }","duration":"605.431995ms","start":"2026-04-25T00:39:26.857841Z","end":"2026-04-25T00:39:27.463273Z","steps":["trace[2024624002] 'agreement among raft nodes before linearized reading' (duration: 605.248761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:27.463306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:26.857828Z","time spent":"605.472556ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-25T00:39:27.463306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.709746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-25T00:39:27.463306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:26.955574Z","time spent":"507.572995ms","remote":"127.0.0.1:46372","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-04-25T00:39:27.463372Z","caller":"traceutil/trace.go:171","msg":"trace[207365229] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:564; }","duration":"634.805138ms","start":"2026-04-25T00:39:26.828546Z","end":"2026-04-25T00:39:27.463351Z","steps":["trace[207365229] 'agreement among raft nodes before linearized reading' (duration: 634.584363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:27.463453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:26.828509Z","time spent":"634.931091ms","remote":"127.0.0.1:46134","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.78\" "} {"level":"warn","ts":"2026-04-25T00:39:27.463616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.763996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qp5wn\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-25T00:39:27.463648Z","caller":"traceutil/trace.go:171","msg":"trace[347616812] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qp5wn; range_end:; response_count:1; response_revision:564; }","duration":"564.795847ms","start":"2026-04-25T00:39:26.898843Z","end":"2026-04-25T00:39:27.463639Z","steps":["trace[347616812] 'agreement among raft nodes before linearized reading' (duration: 564.177024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:27.463665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:26.898773Z","time spent":"564.888069ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-qp5wn\" "} {"level":"warn","ts":"2026-04-25T00:39:28.732145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.135128698s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T00:39:28.732603Z","caller":"traceutil/trace.go:171","msg":"trace[1468241527] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"1.53322292s","start":"2026-04-25T00:39:27.19931Z","end":"2026-04-25T00:39:28.732533Z","steps":["trace[1468241527] 'process raft request' (duration: 1.532932644s)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:28.732708Z","caller":"traceutil/trace.go:171","msg":"trace[1227493831] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"1.253821302s","start":"2026-04-25T00:39:27.478865Z","end":"2026-04-25T00:39:28.732686Z","steps":["trace[1227493831] 'process raft request' (duration: 1.25376452s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:28.732807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:27.19928Z","time spent":"1.533418645s","remote":"127.0.0.1:46610","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-04-25T00:39:28.732803Z","caller":"traceutil/trace.go:171","msg":"trace[1414298917] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"1.584717208s","start":"2026-04-25T00:39:27.148031Z","end":"2026-04-25T00:39:28.732748Z","steps":["trace[1414298917] 'process raft request' (duration: 448.900166ms)","trace[1414298917] 'compare' (duration: 1.134969234s)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:28.732888Z","caller":"traceutil/trace.go:171","msg":"trace[606630564] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:586; }","duration":"1.269782658s","start":"2026-04-25T00:39:27.463094Z","end":"2026-04-25T00:39:28.732877Z","steps":["trace[606630564] 'read index received' (duration: 133.73462ms)","trace[606630564] 'applied index is now lower than readState.Index' (duration: 1.136046848s)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:28.733012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:27.148002Z","time spent":"1.584894601s","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T00:39:28.73313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:27.465015Z","time spent":"1.268113061s","remote":"127.0.0.1:46134","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-25T00:39:28.733351Z","caller":"traceutil/trace.go:171","msg":"trace[2007490811] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"1.264281187s","start":"2026-04-25T00:39:27.469058Z","end":"2026-04-25T00:39:28.733339Z","steps":["trace[2007490811] 'process raft request' (duration: 1.263501621s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:28.733418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:27.468939Z","time spent":"1.264442041s","remote":"127.0.0.1:46372","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-04-25T00:39:28.733438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.508754829s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T00:39:28.733475Z","caller":"traceutil/trace.go:171","msg":"trace[263719434] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:568; }","duration":"1.508846121s","start":"2026-04-25T00:39:27.224616Z","end":"2026-04-25T00:39:28.733462Z","steps":["trace[263719434] 'agreement among raft nodes before linearized reading' (duration: 1.5087877s)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:28.733507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:27.224578Z","time spent":"1.508922813s","remote":"127.0.0.1:46094","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-04-25T00:39:28.732834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:27.478837Z","time spent":"1.253922703s","remote":"127.0.0.1:46288","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-04-25T00:39:28.73363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.988033ms","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-04-25T00:39:28.733679Z","caller":"traceutil/trace.go:171","msg":"trace[371727463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:568; }","duration":"868.091085ms","start":"2026-04-25T00:39:27.865573Z","end":"2026-04-25T00:39:28.733664Z","steps":["trace[371727463] 'agreement among raft nodes before linearized reading' (duration: 867.924382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:28.733714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:27.865546Z","time spent":"868.160517ms","remote":"127.0.0.1:46372","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-04-25T00:39:29.343394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.101682ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T00:39:29.343657Z","caller":"traceutil/trace.go:171","msg":"trace[353573389] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"273.778982ms","start":"2026-04-25T00:39:29.06986Z","end":"2026-04-25T00:39:29.343639Z","steps":["trace[353573389] 'process raft request' (duration: 273.739161ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:29.343731Z","caller":"traceutil/trace.go:171","msg":"trace[2011685790] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:591; }","duration":"597.35625ms","start":"2026-04-25T00:39:28.746354Z","end":"2026-04-25T00:39:29.34371Z","steps":["trace[2011685790] 'read index received' (duration: 107.826629ms)","trace[2011685790] 'applied index is now lower than readState.Index' (duration: 489.528121ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:29.343761Z","caller":"traceutil/trace.go:171","msg":"trace[1477296259] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"605.664908ms","start":"2026-04-25T00:39:28.737991Z","end":"2026-04-25T00:39:29.343656Z","steps":["trace[1477296259] 'process raft request' (duration: 116.228479ms)","trace[1477296259] 'compare' (duration: 488.98846ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:29.343877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.519873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T00:39:29.343955Z","caller":"traceutil/trace.go:171","msg":"trace[458698655] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:571; }","duration":"597.608665ms","start":"2026-04-25T00:39:28.746324Z","end":"2026-04-25T00:39:29.343932Z","steps":["trace[458698655] 'agreement among raft nodes before linearized reading' (duration: 597.472522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:29.343999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:28.746308Z","time spent":"597.680726ms","remote":"127.0.0.1:46352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-25T00:39:29.344079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:28.737967Z","time spent":"605.926824ms","remote":"127.0.0.1:46134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-25T00:39:29.343771Z","caller":"traceutil/trace.go:171","msg":"trace[710089566] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"604.265158ms","start":"2026-04-25T00:39:28.73946Z","end":"2026-04-25T00:39:29.343725Z","steps":["trace[710089566] 'process raft request' (duration: 604.078164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:29.345254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:28.739438Z","time spent":"605.545416ms","remote":"127.0.0.1:46372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T00:39:29.359638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.059765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T00:39:29.359774Z","caller":"traceutil/trace.go:171","msg":"trace[993919668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"613.236779ms","start":"2026-04-25T00:39:28.746516Z","end":"2026-04-25T00:39:29.359752Z","steps":["trace[993919668] 'agreement among raft nodes before linearized reading' (duration: 613.003554ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:29.360025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T00:39:28.746509Z","time spent":"613.344701ms","remote":"127.0.0.1:46094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-25T00:39:29.360085Z","caller":"traceutil/trace.go:171","msg":"trace[1016084344] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"112.154983ms","start":"2026-04-25T00:39:29.247897Z","end":"2026-04-25T00:39:29.360052Z","steps":["trace[1016084344] 'process raft request' (duration: 111.269995ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:33.613893Z","caller":"traceutil/trace.go:171","msg":"trace[50223089] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:665; }","duration":"153.056354ms","start":"2026-04-25T00:39:33.460804Z","end":"2026-04-25T00:39:33.613861Z","steps":["trace[50223089] 'read index received' (duration: 81.079286ms)","trace[50223089] 'applied index is now lower than readState.Index' (duration: 71.975458ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:33.613922Z","caller":"traceutil/trace.go:171","msg":"trace[1535492365] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"209.075772ms","start":"2026-04-25T00:39:33.404812Z","end":"2026-04-25T00:39:33.613887Z","steps":["trace[1535492365] 'process raft request' (duration: 137.155535ms)","trace[1535492365] 'compare' (duration: 71.726672ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:33.614214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.034255ms","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-04-25T00:39:33.61426Z","caller":"traceutil/trace.go:171","msg":"trace[2017069538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:642; }","duration":"126.133038ms","start":"2026-04-25T00:39:33.488116Z","end":"2026-04-25T00:39:33.614249Z","steps":["trace[2017069538] 'agreement among raft nodes before linearized reading' (duration: 125.932103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:33.614304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.475553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-04-25T00:39:33.614425Z","caller":"traceutil/trace.go:171","msg":"trace[902848952] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:642; }","duration":"153.652047ms","start":"2026-04-25T00:39:33.460749Z","end":"2026-04-25T00:39:33.614401Z","steps":["trace[902848952] 'agreement among raft nodes before linearized reading' (duration: 153.279369ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:34.941171Z","caller":"traceutil/trace.go:171","msg":"trace[2123575007] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"104.890262ms","start":"2026-04-25T00:39:34.836244Z","end":"2026-04-25T00:39:34.941135Z","steps":["trace[2123575007] 'process raft request' (duration: 104.577715ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:35.948127Z","caller":"traceutil/trace.go:171","msg":"trace[1631971846] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"107.459368ms","start":"2026-04-25T00:39:35.840645Z","end":"2026-04-25T00:39:35.948105Z","steps":["trace[1631971846] 'process raft request' (duration: 106.541508ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:36.618497Z","caller":"traceutil/trace.go:171","msg":"trace[1905650796] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:697; }","duration":"200.675764ms","start":"2026-04-25T00:39:36.417795Z","end":"2026-04-25T00:39:36.618471Z","steps":["trace[1905650796] 'read index received' (duration: 200.491431ms)","trace[1905650796] 'applied index is now lower than readState.Index' (duration: 183.313µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:36.618542Z","caller":"traceutil/trace.go:171","msg":"trace[1562897181] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"225.588206ms","start":"2026-04-25T00:39:36.39292Z","end":"2026-04-25T00:39:36.618508Z","steps":["trace[1562897181] 'process raft request' (duration: 225.380102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:36.618639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.831237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T00:39:36.61873Z","caller":"traceutil/trace.go:171","msg":"trace[1478179941] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:674; }","duration":"200.97806ms","start":"2026-04-25T00:39:36.417737Z","end":"2026-04-25T00:39:36.618715Z","steps":["trace[1478179941] 'agreement among raft nodes before linearized reading' (duration: 200.803987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:36.618788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.609065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T00:39:36.618827Z","caller":"traceutil/trace.go:171","msg":"trace[1728129972] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:674; }","duration":"169.672886ms","start":"2026-04-25T00:39:36.449142Z","end":"2026-04-25T00:39:36.618815Z","steps":["trace[1728129972] 'agreement among raft nodes before linearized reading' (duration: 169.585084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:36.618824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.249408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T00:39:36.618889Z","caller":"traceutil/trace.go:171","msg":"trace[543296146] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:674; }","duration":"170.383591ms","start":"2026-04-25T00:39:36.448491Z","end":"2026-04-25T00:39:36.618874Z","steps":["trace[543296146] 'agreement among raft nodes before linearized reading' (duration: 170.268529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:36.619008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.516624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T00:39:36.619042Z","caller":"traceutil/trace.go:171","msg":"trace[2064475143] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:674; }","duration":"170.578325ms","start":"2026-04-25T00:39:36.448454Z","end":"2026-04-25T00:39:36.619032Z","steps":["trace[2064475143] 'agreement among raft nodes before linearized reading' (duration: 170.527564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:36.619326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.343907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T00:39:36.619324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.859998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-25T00:39:36.619412Z","caller":"traceutil/trace.go:171","msg":"trace[1223611833] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:674; }","duration":"201.00711ms","start":"2026-04-25T00:39:36.418384Z","end":"2026-04-25T00:39:36.619391Z","steps":["trace[1223611833] 'agreement among raft nodes before linearized reading' (duration: 200.310276ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:36.61943Z","caller":"traceutil/trace.go:171","msg":"trace[1501977452] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:674; }","duration":"201.659124ms","start":"2026-04-25T00:39:36.417749Z","end":"2026-04-25T00:39:36.619408Z","steps":["trace[1501977452] 'agreement among raft nodes before linearized reading' (duration: 200.867088ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:38.902721Z","caller":"traceutil/trace.go:171","msg":"trace[1205751781] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"110.097601ms","start":"2026-04-25T00:39:38.792605Z","end":"2026-04-25T00:39:38.902703Z","steps":["trace[1205751781] 'read index received' (duration: 58.970524ms)","trace[1205751781] 'applied index is now lower than readState.Index' (duration: 51.125907ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:38.903008Z","caller":"traceutil/trace.go:171","msg":"trace[1268587649] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"174.252527ms","start":"2026-04-25T00:39:38.728744Z","end":"2026-04-25T00:39:38.902997Z","steps":["trace[1268587649] 'process raft request' (duration: 122.830764ms)","trace[1268587649] 'compare' (duration: 51.044605ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:39:38.903234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.636052ms","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-04-25T00:39:38.903256Z","caller":"traceutil/trace.go:171","msg":"trace[1669035529] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:687; }","duration":"110.709683ms","start":"2026-04-25T00:39:38.79254Z","end":"2026-04-25T00:39:38.90325Z","steps":["trace[1669035529] 'agreement among raft nodes before linearized reading' (duration: 110.588841ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:45.254382Z","caller":"traceutil/trace.go:171","msg":"trace[802920862] linearizableReadLoop","detail":"{readStateIndex:758; appliedIndex:757; }","duration":"240.884305ms","start":"2026-04-25T00:39:45.013472Z","end":"2026-04-25T00:39:45.254357Z","steps":["trace[802920862] 'read index received' (duration: 240.61807ms)","trace[802920862] 'applied index is now lower than readState.Index' (duration: 264.845µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:39:45.254524Z","caller":"traceutil/trace.go:171","msg":"trace[237936646] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"274.87899ms","start":"2026-04-25T00:39:44.979615Z","end":"2026-04-25T00:39:45.254494Z","steps":["trace[237936646] 'process raft request' (duration: 274.570955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:45.25477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.265572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-44686\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-04-25T00:39:45.254786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.252236ms","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-04-25T00:39:45.254836Z","caller":"traceutil/trace.go:171","msg":"trace[96867301] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-44686; range_end:; response_count:1; response_revision:731; }","duration":"241.400264ms","start":"2026-04-25T00:39:45.013419Z","end":"2026-04-25T00:39:45.254819Z","steps":["trace[96867301] 'agreement among raft nodes before linearized reading' (duration: 241.078208ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:39:45.254858Z","caller":"traceutil/trace.go:171","msg":"trace[2091526162] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:731; }","duration":"227.390629ms","start":"2026-04-25T00:39:45.027448Z","end":"2026-04-25T00:39:45.254839Z","steps":["trace[2091526162] 'agreement among raft nodes before linearized reading' (duration: 227.186985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:39:45.254989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.947473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-25T00:39:45.255053Z","caller":"traceutil/trace.go:171","msg":"trace[988724571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:731; }","duration":"152.032994ms","start":"2026-04-25T00:39:45.102999Z","end":"2026-04-25T00:39:45.255032Z","steps":["trace[988724571] 'agreement among raft nodes before linearized reading' (duration: 151.837671ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:40:21.272628Z","caller":"traceutil/trace.go:171","msg":"trace[839179968] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"100.733165ms","start":"2026-04-25T00:40:21.171872Z","end":"2026-04-25T00:40:21.272606Z","steps":["trace[839179968] 'process raft request' (duration: 100.497582ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:40:29.639287Z","caller":"traceutil/trace.go:171","msg":"trace[2141758002] linearizableReadLoop","detail":"{readStateIndex:1081; appliedIndex:1079; }","duration":"104.241678ms","start":"2026-04-25T00:40:29.535027Z","end":"2026-04-25T00:40:29.639268Z","steps":["trace[2141758002] 'read index received' (duration: 63.297007ms)","trace[2141758002] 'applied index is now lower than readState.Index' (duration: 40.943441ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:40:29.639369Z","caller":"traceutil/trace.go:171","msg":"trace[514982855] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"136.764026ms","start":"2026-04-25T00:40:29.502566Z","end":"2026-04-25T00:40:29.63933Z","steps":["trace[514982855] 'process raft request' (duration: 136.587814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:40:29.639815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.506992ms","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-04-25T00:40:29.639872Z","caller":"traceutil/trace.go:171","msg":"trace[1743011304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1042; }","duration":"104.855098ms","start":"2026-04-25T00:40:29.534999Z","end":"2026-04-25T00:40:29.639854Z","steps":["trace[1743011304] 'agreement among raft nodes before linearized reading' (duration: 104.423131ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:40:30.458932Z","caller":"traceutil/trace.go:171","msg":"trace[1446696579] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"131.429359ms","start":"2026-04-25T00:40:30.327475Z","end":"2026-04-25T00:40:30.458905Z","steps":["trace[1446696579] 'process raft request' (duration: 131.272407ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:40:30.901213Z","caller":"traceutil/trace.go:171","msg":"trace[1946408822] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"111.248874ms","start":"2026-04-25T00:40:30.789935Z","end":"2026-04-25T00:40:30.901184Z","steps":["trace[1946408822] 'process raft request' (duration: 111.073721ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:40:35.887579Z","caller":"traceutil/trace.go:171","msg":"trace[1435113834] linearizableReadLoop","detail":"{readStateIndex:1108; appliedIndex:1107; }","duration":"195.233968ms","start":"2026-04-25T00:40:35.692328Z","end":"2026-04-25T00:40:35.887562Z","steps":["trace[1435113834] 'read index received' (duration: 195.140387ms)","trace[1435113834] 'applied index is now lower than readState.Index' (duration: 92.551µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:40:35.887646Z","caller":"traceutil/trace.go:171","msg":"trace[790333077] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"222.509148ms","start":"2026-04-25T00:40:35.665104Z","end":"2026-04-25T00:40:35.887613Z","steps":["trace[790333077] 'process raft request' (duration: 222.359826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:40:35.887747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.417161ms","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-04-25T00:40:35.887774Z","caller":"traceutil/trace.go:171","msg":"trace[1480951342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1068; }","duration":"195.493912ms","start":"2026-04-25T00:40:35.692274Z","end":"2026-04-25T00:40:35.887768Z","steps":["trace[1480951342] 'agreement among raft nodes before linearized reading' (duration: 195.387761ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:40:46.075632Z","caller":"traceutil/trace.go:171","msg":"trace[1951202570] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"131.43372ms","start":"2026-04-25T00:40:45.944174Z","end":"2026-04-25T00:40:46.075607Z","steps":["trace[1951202570] 'process raft request' (duration: 99.134069ms)","trace[1951202570] 'compare' (duration: 32.2009ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T00:40:46.08124Z","caller":"traceutil/trace.go:171","msg":"trace[955864449] linearizableReadLoop","detail":"{readStateIndex:1150; appliedIndex:1148; }","duration":"136.070712ms","start":"2026-04-25T00:40:45.94514Z","end":"2026-04-25T00:40:46.081211Z","steps":["trace[955864449] 'read index received' (duration: 98.179995ms)","trace[955864449] 'applied index is now lower than readState.Index' (duration: 37.889197ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T00:40:46.081397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.231715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pvc-protection-controller\" ","response":"range_response_count:1 size:728"} {"level":"info","ts":"2026-04-25T00:40:46.081394Z","caller":"traceutil/trace.go:171","msg":"trace[619653989] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"137.126837ms","start":"2026-04-25T00:40:45.944222Z","end":"2026-04-25T00:40:46.081349Z","steps":["trace[619653989] 'process raft request' (duration: 136.864534ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T00:40:46.08144Z","caller":"traceutil/trace.go:171","msg":"trace[1019016883] range","detail":"{range_begin:/registry/clusterroles/system:controller:pvc-protection-controller; range_end:; response_count:1; response_revision:1107; }","duration":"136.300155ms","start":"2026-04-25T00:40:45.945127Z","end":"2026-04-25T00:40:46.081427Z","steps":["trace[1019016883] 'agreement among raft nodes before linearized reading' (duration: 136.208694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T00:40:46.081717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.868237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:1 size:1102"} {"level":"info","ts":"2026-04-25T00:40:46.081834Z","caller":"traceutil/trace.go:171","msg":"trace[696339259] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:1; response_revision:1107; }","duration":"111.026089ms","start":"2026-04-25T00:40:45.970769Z","end":"2026-04-25T00:40:46.081795Z","steps":["trace[696339259] 'agreement among raft nodes before linearized reading' (duration: 110.710385ms)"],"step_count":1}