{"level":"warn","ts":"2026-05-10T00:47:14.930444Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-10T00:47:14.930529Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-10T00:47:14.930595Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-10T00:47:14.930608Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-10T00:47:14.930631Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-10T00:47:14.931246Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-05-10T00:47:14.931317Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-10T00:47:14.935877Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.380855ms"} {"level":"info","ts":"2026-05-10T00:47:14.944232Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-05-10T00:47:14.944322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-05-10T00:47:14.94438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-05-10T00:47:14.9444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-10T00:47:14.944411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-05-10T00:47:14.944478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-05-10T00:47:14.950112Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-10T00:47:14.951378Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-10T00:47:14.953582Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-10T00:47:14.955878Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-10T00:47:14.956107Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-10T00:47:14.956327Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T00:47:14.956449Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T00:47:14.956458Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-10T00:47:14.958675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-05-10T00:47:14.961553Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-10T00:47:14.964089Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-10T00:47:14.964293Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-10T00:47:14.964377Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-10T00:47:14.965359Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-10T00:47:14.965412Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-10T00:47:15.944995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-05-10T00:47:15.945056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-10T00:47:15.945099Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-05-10T00:47:15.945118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-05-10T00:47:15.945129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-10T00:47:15.945147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-05-10T00:47:15.945161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-10T00:47:15.94615Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:47:15.947055Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T00:47:15.947049Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-10T00:47:15.94715Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T00:47:15.947506Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:47:15.9476Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:47:15.947634Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T00:47:15.947566Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-10T00:47:15.948265Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-10T00:47:15.950871Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-05-10T00:47:15.951237Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-10T00:47:17.596295Z","caller":"traceutil/trace.go:171","msg":"trace[464159158] transaction","detail":"{read_only:false; response_revision:64; number_of_response:1; }","duration":"199.743549ms","start":"2026-05-10T00:47:17.396516Z","end":"2026-05-10T00:47:17.59626Z","steps":["trace[464159158] 'process raft request' (duration: 106.48453ms)","trace[464159158] 'compare' (duration: 93.05525ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:17.596467Z","caller":"traceutil/trace.go:171","msg":"trace[492120568] linearizableReadLoop","detail":"{readStateIndex:69; appliedIndex:67; }","duration":"140.069174ms","start":"2026-05-10T00:47:17.45636Z","end":"2026-05-10T00:47:17.596429Z","steps":["trace[492120568] 'read index received' (duration: 46.64865ms)","trace[492120568] 'applied index is now lower than readState.Index' (duration: 93.419424ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:17.59655Z","caller":"traceutil/trace.go:171","msg":"trace[1065483215] transaction","detail":"{read_only:false; response_revision:65; number_of_response:1; }","duration":"198.278091ms","start":"2026-05-10T00:47:17.398228Z","end":"2026-05-10T00:47:17.596507Z","steps":["trace[1065483215] 'process raft request' (duration: 197.98504ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:17.596727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.345125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:47:17.596798Z","caller":"traceutil/trace.go:171","msg":"trace[1229802043] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:65; }","duration":"140.485081ms","start":"2026-05-10T00:47:17.456297Z","end":"2026-05-10T00:47:17.596782Z","steps":["trace[1229802043] 'agreement among raft nodes before linearized reading' (duration: 140.250222ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:17.761745Z","caller":"traceutil/trace.go:171","msg":"trace[1111882874] transaction","detail":"{read_only:false; response_revision:68; number_of_response:1; }","duration":"156.802331ms","start":"2026-05-10T00:47:17.604919Z","end":"2026-05-10T00:47:17.761721Z","steps":["trace[1111882874] 'process raft request' (duration: 156.736689ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:17.762102Z","caller":"traceutil/trace.go:171","msg":"trace[1411736906] transaction","detail":"{read_only:false; response_revision:67; number_of_response:1; }","duration":"158.549679ms","start":"2026-05-10T00:47:17.603463Z","end":"2026-05-10T00:47:17.762012Z","steps":["trace[1411736906] 'process raft request' (duration: 97.264683ms)","trace[1411736906] 'compare' (duration: 60.783246ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:18.91833Z","caller":"traceutil/trace.go:171","msg":"trace[1184040280] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"168.412257ms","start":"2026-05-10T00:47:18.749888Z","end":"2026-05-10T00:47:18.918301Z","steps":["trace[1184040280] 'process raft request' (duration: 152.24674ms)","trace[1184040280] 'compare' (duration: 16.022351ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:20.143238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.148004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-10T00:47:20.143334Z","caller":"traceutil/trace.go:171","msg":"trace[1046559438] linearizableReadLoop","detail":"{readStateIndex:122; appliedIndex:121; }","duration":"952.5685ms","start":"2026-05-10T00:47:19.190753Z","end":"2026-05-10T00:47:20.143322Z","steps":["trace[1046559438] 'read index received' (duration: 41.491µs)","trace[1046559438] 'applied index is now lower than readState.Index' (duration: 952.526209ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:20.143398Z","caller":"traceutil/trace.go:171","msg":"trace[1803730577] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"1.218596937s","start":"2026-05-10T00:47:18.924793Z","end":"2026-05-10T00:47:20.14339Z","steps":["trace[1803730577] 'process raft request' (duration: 234.910322ms)","trace[1803730577] 'compare' (duration: 983.02849ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:20.143454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:18.92478Z","time spent":"1.218654598s","remote":"127.0.0.1:44956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":710,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T00:47:20.143611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"952.864071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:47:20.14363Z","caller":"traceutil/trace.go:171","msg":"trace[778563167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:118; }","duration":"952.999716ms","start":"2026-05-10T00:47:19.190625Z","end":"2026-05-10T00:47:20.143624Z","steps":["trace[778563167] 'agreement among raft nodes before linearized reading' (duration: 952.941104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:20.143652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:19.190603Z","time spent":"953.042898ms","remote":"127.0.0.1:44656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T00:47:20.143747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.977634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:47:20.143853Z","caller":"traceutil/trace.go:171","msg":"trace[1476291835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:118; }","duration":"865.09816ms","start":"2026-05-10T00:47:19.278715Z","end":"2026-05-10T00:47:20.143813Z","steps":["trace[1476291835] 'agreement among raft nodes before linearized reading' (duration: 864.950543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:20.143895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:19.278664Z","time spent":"865.223084ms","remote":"127.0.0.1:44664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T00:47:21.127597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.087961ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-10T00:47:21.127951Z","caller":"traceutil/trace.go:171","msg":"trace[1067442302] linearizableReadLoop","detail":"{readStateIndex:123; appliedIndex:122; }","duration":"932.91999ms","start":"2026-05-10T00:47:20.195016Z","end":"2026-05-10T00:47:21.127936Z","steps":["trace[1067442302] 'read index received' (duration: 413.495428ms)","trace[1067442302] 'applied index is now lower than readState.Index' (duration: 519.423372ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:21.128004Z","caller":"traceutil/trace.go:171","msg":"trace[1707445311] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"978.404378ms","start":"2026-05-10T00:47:20.149539Z","end":"2026-05-10T00:47:21.127944Z","steps":["trace[1707445311] 'process raft request' (duration: 458.918634ms)","trace[1707445311] 'compare' (duration: 518.971436ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:21.128189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:20.149523Z","time spent":"978.571144ms","remote":"127.0.0.1:44956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":822,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T00:47:21.128286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.206332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:47:21.128379Z","caller":"traceutil/trace.go:171","msg":"trace[1645252273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:119; }","duration":"933.395788ms","start":"2026-05-10T00:47:20.194971Z","end":"2026-05-10T00:47:21.128367Z","steps":["trace[1645252273] 'agreement among raft nodes before linearized reading' (duration: 933.17741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:21.128518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:20.194944Z","time spent":"933.564184ms","remote":"127.0.0.1:44656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T00:47:21.128625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.165434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:47:21.128684Z","caller":"traceutil/trace.go:171","msg":"trace[1381652629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:119; }","duration":"766.228536ms","start":"2026-05-10T00:47:20.36244Z","end":"2026-05-10T00:47:21.128669Z","steps":["trace[1381652629] 'agreement among raft nodes before linearized reading' (duration: 766.130232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:21.12873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:20.362363Z","time spent":"766.357901ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-10T00:47:21.128926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.827733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:47:21.128966Z","caller":"traceutil/trace.go:171","msg":"trace[2085778823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:119; }","duration":"179.867394ms","start":"2026-05-10T00:47:20.949088Z","end":"2026-05-10T00:47:21.128955Z","steps":["trace[2085778823] 'agreement among raft nodes before linearized reading' (duration: 179.808222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:21.129135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.81927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:47:21.129174Z","caller":"traceutil/trace.go:171","msg":"trace[747169160] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:119; }","duration":"750.909094ms","start":"2026-05-10T00:47:20.378254Z","end":"2026-05-10T00:47:21.129163Z","steps":["trace[747169160] 'agreement among raft nodes before linearized reading' (duration: 750.854252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:21.129208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:20.378235Z","time spent":"750.965557ms","remote":"127.0.0.1:44664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-10T00:47:21.46794Z","caller":"traceutil/trace.go:171","msg":"trace[791067717] transaction","detail":"{read_only:false; response_revision:120; number_of_response:1; }","duration":"335.203808ms","start":"2026-05-10T00:47:21.132639Z","end":"2026-05-10T00:47:21.467842Z","steps":["trace[791067717] 'process raft request' (duration: 332.870781ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:21.468193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:21.132625Z","time spent":"335.451867ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T00:47:21.468305Z","caller":"traceutil/trace.go:171","msg":"trace[54673942] linearizableReadLoop","detail":"{readStateIndex:126; appliedIndex:123; }","duration":"190.074048ms","start":"2026-05-10T00:47:21.278199Z","end":"2026-05-10T00:47:21.468273Z","steps":["trace[54673942] 'read index received' (duration: 187.324917ms)","trace[54673942] 'applied index is now lower than readState.Index' (duration: 2.748001ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:21.468401Z","caller":"traceutil/trace.go:171","msg":"trace[84515696] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"333.817197ms","start":"2026-05-10T00:47:21.134538Z","end":"2026-05-10T00:47:21.468356Z","steps":["trace[84515696] 'process raft request' (duration: 332.888142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:21.468559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.341359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T00:47:21.468593Z","caller":"traceutil/trace.go:171","msg":"trace[341232798] transaction","detail":"{read_only:false; response_revision:122; number_of_response:1; }","duration":"332.084823ms","start":"2026-05-10T00:47:21.136475Z","end":"2026-05-10T00:47:21.46856Z","steps":["trace[341232798] 'process raft request' (duration: 331.747981ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:21.468611Z","caller":"traceutil/trace.go:171","msg":"trace[1098236344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:122; }","duration":"190.457054ms","start":"2026-05-10T00:47:21.278136Z","end":"2026-05-10T00:47:21.468594Z","steps":["trace[1098236344] 'agreement among raft nodes before linearized reading' (duration: 190.250476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:21.468619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:21.134522Z","time spent":"333.982162ms","remote":"127.0.0.1:44956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1063,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T00:47:21.468717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:21.134Z","time spent":"334.648528ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T00:47:22.20806Z","caller":"traceutil/trace.go:171","msg":"trace[1626216578] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"113.225256ms","start":"2026-05-10T00:47:22.094812Z","end":"2026-05-10T00:47:22.208038Z","steps":["trace[1626216578] 'process raft request' (duration: 113.168914ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:22.20821Z","caller":"traceutil/trace.go:171","msg":"trace[46980370] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"115.304511ms","start":"2026-05-10T00:47:22.092874Z","end":"2026-05-10T00:47:22.208179Z","steps":["trace[46980370] 'process raft request' (duration: 103.898265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:22.583451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.069661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:47:22.583579Z","caller":"traceutil/trace.go:171","msg":"trace[2016205401] linearizableReadLoop","detail":"{readStateIndex:205; appliedIndex:204; }","duration":"303.669342ms","start":"2026-05-10T00:47:22.279886Z","end":"2026-05-10T00:47:22.583555Z","steps":["trace[2016205401] 'read index received' (duration: 72.415355ms)","trace[2016205401] 'applied index is now lower than readState.Index' (duration: 231.252537ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:22.583636Z","caller":"traceutil/trace.go:171","msg":"trace[2035656466] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"309.998614ms","start":"2026-05-10T00:47:22.273606Z","end":"2026-05-10T00:47:22.583604Z","steps":["trace[2035656466] 'process raft request' (duration: 78.707175ms)","trace[2035656466] 'compare' (duration: 230.912686ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:22.583744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:22.27358Z","time spent":"310.115769ms","remote":"127.0.0.1:44728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":636,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T00:47:22.58393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.029576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:113"} {"level":"info","ts":"2026-05-10T00:47:22.584012Z","caller":"traceutil/trace.go:171","msg":"trace[194791214] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:200; }","duration":"304.170761ms","start":"2026-05-10T00:47:22.279826Z","end":"2026-05-10T00:47:22.583997Z","steps":["trace[194791214] 'agreement among raft nodes before linearized reading' (duration: 303.789917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:22.584174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:22.279809Z","time spent":"304.346697ms","remote":"127.0.0.1:44720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":135,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-05-10T00:47:22.834312Z","caller":"traceutil/trace.go:171","msg":"trace[894528362] linearizableReadLoop","detail":"{readStateIndex:218; appliedIndex:217; }","duration":"143.861365ms","start":"2026-05-10T00:47:22.690432Z","end":"2026-05-10T00:47:22.834294Z","steps":["trace[894528362] 'read index received' (duration: 75.786508ms)","trace[894528362] 'applied index is now lower than readState.Index' (duration: 68.074207ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:22.834405Z","caller":"traceutil/trace.go:171","msg":"trace[1796710873] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"155.444258ms","start":"2026-05-10T00:47:22.678911Z","end":"2026-05-10T00:47:22.834356Z","steps":["trace[1796710873] 'process raft request' (duration: 87.290758ms)","trace[1796710873] 'compare' (duration: 68.012834ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:22.834595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.143865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:47:22.834626Z","caller":"traceutil/trace.go:171","msg":"trace[1579359967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:212; }","duration":"144.222428ms","start":"2026-05-10T00:47:22.690396Z","end":"2026-05-10T00:47:22.834618Z","steps":["trace[1579359967] 'agreement among raft nodes before linearized reading' (duration: 143.963449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:23.340119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.858661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:47:23.340243Z","caller":"traceutil/trace.go:171","msg":"trace[425286215] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"313.380203ms","start":"2026-05-10T00:47:23.026843Z","end":"2026-05-10T00:47:23.340223Z","steps":["trace[425286215] 'process raft request' (duration: 56.19251ms)","trace[425286215] 'compare' (duration: 256.741067ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:23.340306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:23.026824Z","time spent":"313.452625ms","remote":"127.0.0.1:44728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":638,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T00:47:24.855687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.122049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:47:24.855865Z","caller":"traceutil/trace.go:171","msg":"trace[1018965415] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"124.621945ms","start":"2026-05-10T00:47:24.731205Z","end":"2026-05-10T00:47:24.855827Z","steps":["trace[1018965415] 'process raft request' (duration: 24.281148ms)","trace[1018965415] 'compare' (duration: 99.925361ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:24.855908Z","caller":"traceutil/trace.go:171","msg":"trace[1304323889] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:283; }","duration":"124.380037ms","start":"2026-05-10T00:47:24.731506Z","end":"2026-05-10T00:47:24.855886Z","steps":["trace[1304323889] 'read index received' (duration: 23.728018ms)","trace[1304323889] 'applied index is now lower than readState.Index' (duration: 100.649498ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:24.855949Z","caller":"traceutil/trace.go:171","msg":"trace[1297675101] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"121.292215ms","start":"2026-05-10T00:47:24.734643Z","end":"2026-05-10T00:47:24.855935Z","steps":["trace[1297675101] 'process raft request' (duration: 121.241493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:24.856057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.403933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-10T00:47:24.856027Z","caller":"traceutil/trace.go:171","msg":"trace[1395439466] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"121.481772ms","start":"2026-05-10T00:47:24.734508Z","end":"2026-05-10T00:47:24.85599Z","steps":["trace[1395439466] 'process raft request' (duration: 121.320557ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:24.85608Z","caller":"traceutil/trace.go:171","msg":"trace[491059777] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:280; }","duration":"125.464044ms","start":"2026-05-10T00:47:24.730607Z","end":"2026-05-10T00:47:24.856071Z","steps":["trace[491059777] 'agreement among raft nodes before linearized reading' (duration: 125.366061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:24.871291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.909573ms","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-05-10T00:47:24.871405Z","caller":"traceutil/trace.go:171","msg":"trace[655617372] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:283; }","duration":"137.057569ms","start":"2026-05-10T00:47:24.734324Z","end":"2026-05-10T00:47:24.871382Z","steps":["trace[655617372] 'agreement among raft nodes before linearized reading' (duration: 136.80918ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.037994Z","caller":"traceutil/trace.go:171","msg":"trace[1696590507] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"143.715045ms","start":"2026-05-10T00:47:24.894226Z","end":"2026-05-10T00:47:25.037941Z","steps":["trace[1696590507] 'process raft request' (duration: 77.304503ms)","trace[1696590507] 'compare' (duration: 66.162754ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:25.038087Z","caller":"traceutil/trace.go:171","msg":"trace[85268366] linearizableReadLoop","detail":"{readStateIndex:301; appliedIndex:299; }","duration":"112.718907ms","start":"2026-05-10T00:47:24.925348Z","end":"2026-05-10T00:47:25.038067Z","steps":["trace[85268366] 'read index received' (duration: 46.195462ms)","trace[85268366] 'applied index is now lower than readState.Index' (duration: 66.522305ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:25.038145Z","caller":"traceutil/trace.go:171","msg":"trace[341833851] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"141.010908ms","start":"2026-05-10T00:47:24.897102Z","end":"2026-05-10T00:47:25.038113Z","steps":["trace[341833851] 'process raft request' (duration: 140.736509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:25.038288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.923865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-10T00:47:25.038329Z","caller":"traceutil/trace.go:171","msg":"trace[1204898277] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:292; }","duration":"113.095351ms","start":"2026-05-10T00:47:24.925218Z","end":"2026-05-10T00:47:25.038313Z","steps":["trace[1204898277] 'agreement among raft nodes before linearized reading' (duration: 112.926194ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.66888Z","caller":"traceutil/trace.go:171","msg":"trace[791502640] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"173.563838ms","start":"2026-05-10T00:47:25.495291Z","end":"2026-05-10T00:47:25.668854Z","steps":["trace[791502640] 'read index received' (duration: 99.473699ms)","trace[791502640] 'applied index is now lower than readState.Index' (duration: 74.089199ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:25.668972Z","caller":"traceutil/trace.go:171","msg":"trace[2095878300] transaction","detail":"{read_only:false; response_revision:307; number_of_response:1; }","duration":"184.518995ms","start":"2026-05-10T00:47:25.484406Z","end":"2026-05-10T00:47:25.668925Z","steps":["trace[2095878300] 'process raft request' (duration: 110.398384ms)","trace[2095878300] 'compare' (duration: 73.917174ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:25.669078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.225341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T00:47:25.669118Z","caller":"traceutil/trace.go:171","msg":"trace[17922885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:307; }","duration":"157.300123ms","start":"2026-05-10T00:47:25.511805Z","end":"2026-05-10T00:47:25.669105Z","steps":["trace[17922885] 'agreement among raft nodes before linearized reading' (duration: 157.202019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:25.669096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.772286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T00:47:25.669138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.399549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-10T00:47:25.669178Z","caller":"traceutil/trace.go:171","msg":"trace[1112132973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:307; }","duration":"173.89046ms","start":"2026-05-10T00:47:25.495268Z","end":"2026-05-10T00:47:25.669158Z","steps":["trace[1112132973] 'agreement among raft nodes before linearized reading' (duration: 173.695563ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.669197Z","caller":"traceutil/trace.go:171","msg":"trace[601850418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:307; }","duration":"150.485661ms","start":"2026-05-10T00:47:25.518695Z","end":"2026-05-10T00:47:25.66918Z","steps":["trace[601850418] 'agreement among raft nodes before linearized reading' (duration: 150.352377ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.798284Z","caller":"traceutil/trace.go:171","msg":"trace[725630411] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"123.208127ms","start":"2026-05-10T00:47:25.675051Z","end":"2026-05-10T00:47:25.798259Z","steps":["trace[725630411] 'process raft request' (duration: 121.87719ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.864705Z","caller":"traceutil/trace.go:171","msg":"trace[1348194910] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:317; }","duration":"151.31688ms","start":"2026-05-10T00:47:25.713362Z","end":"2026-05-10T00:47:25.864679Z","steps":["trace[1348194910] 'read index received' (duration: 83.668268ms)","trace[1348194910] 'applied index is now lower than readState.Index' (duration: 67.647802ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:25.864873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.489257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-05-10T00:47:25.864916Z","caller":"traceutil/trace.go:171","msg":"trace[230368324] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:310; }","duration":"151.5853ms","start":"2026-05-10T00:47:25.713319Z","end":"2026-05-10T00:47:25.864904Z","steps":["trace[230368324] 'agreement among raft nodes before linearized reading' (duration: 151.460166ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.865268Z","caller":"traceutil/trace.go:171","msg":"trace[468378814] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"153.152656ms","start":"2026-05-10T00:47:25.7121Z","end":"2026-05-10T00:47:25.865252Z","steps":["trace[468378814] 'process raft request' (duration: 152.481192ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.865326Z","caller":"traceutil/trace.go:171","msg":"trace[1874234309] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"151.992015ms","start":"2026-05-10T00:47:25.713298Z","end":"2026-05-10T00:47:25.86529Z","steps":["trace[1874234309] 'process raft request' (duration: 151.312411ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.865495Z","caller":"traceutil/trace.go:171","msg":"trace[835688967] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"158.509545ms","start":"2026-05-10T00:47:25.706973Z","end":"2026-05-10T00:47:25.865483Z","steps":["trace[835688967] 'process raft request' (duration: 157.5016ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:25.865731Z","caller":"traceutil/trace.go:171","msg":"trace[1775425718] transaction","detail":"{read_only:false; number_of_response:0; response_revision:310; }","duration":"151.929223ms","start":"2026-05-10T00:47:25.713791Z","end":"2026-05-10T00:47:25.865721Z","steps":["trace[1775425718] 'process raft request' (duration: 150.861425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:26.330306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.21381ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:47:26.330416Z","caller":"traceutil/trace.go:171","msg":"trace[1691690676] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:325; }","duration":"351.999235ms","start":"2026-05-10T00:47:25.978398Z","end":"2026-05-10T00:47:26.330397Z","steps":["trace[1691690676] 'read index received' (duration: 118.680112ms)","trace[1691690676] 'applied index is now lower than readState.Index' (duration: 233.317473ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:26.330507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.10251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:47:26.330544Z","caller":"traceutil/trace.go:171","msg":"trace[783162952] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:314; }","duration":"352.164111ms","start":"2026-05-10T00:47:25.978365Z","end":"2026-05-10T00:47:26.330529Z","steps":["trace[783162952] 'agreement among raft nodes before linearized reading' (duration: 352.082708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:26.330584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:25.97835Z","time spent":"352.223335ms","remote":"127.0.0.1:44818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" "} {"level":"info","ts":"2026-05-10T00:47:26.330811Z","caller":"traceutil/trace.go:171","msg":"trace[2140495765] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"386.607339ms","start":"2026-05-10T00:47:25.944186Z","end":"2026-05-10T00:47:26.330794Z","steps":["trace[2140495765] 'process raft request' (duration: 152.81887ms)","trace[2140495765] 'compare' (duration: 232.94937ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:26.330886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:25.944167Z","time spent":"386.677652ms","remote":"127.0.0.1:44800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T00:47:26.534905Z","caller":"traceutil/trace.go:171","msg":"trace[1658330693] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"111.728258ms","start":"2026-05-10T00:47:26.423154Z","end":"2026-05-10T00:47:26.534882Z","steps":["trace[1658330693] 'process raft request' (duration: 102.162504ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:26.535971Z","caller":"traceutil/trace.go:171","msg":"trace[571342066] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"109.76013ms","start":"2026-05-10T00:47:26.426198Z","end":"2026-05-10T00:47:26.535958Z","steps":["trace[571342066] 'process raft request' (duration: 109.688978ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:27.951433Z","caller":"traceutil/trace.go:171","msg":"trace[1319141866] linearizableReadLoop","detail":"{readStateIndex:347; appliedIndex:346; }","duration":"131.39273ms","start":"2026-05-10T00:47:27.820019Z","end":"2026-05-10T00:47:27.951412Z","steps":["trace[1319141866] 'read index received' (duration: 71.931201ms)","trace[1319141866] 'applied index is now lower than readState.Index' (duration: 59.460218ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:27.951779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.399397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-05-10T00:47:27.951823Z","caller":"traceutil/trace.go:171","msg":"trace[2110997264] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:335; }","duration":"111.455539ms","start":"2026-05-10T00:47:27.840356Z","end":"2026-05-10T00:47:27.951811Z","steps":["trace[2110997264] 'agreement among raft nodes before linearized reading' (duration: 111.370936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:27.951779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.271487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:47:27.951895Z","caller":"traceutil/trace.go:171","msg":"trace[239488395] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"183.079707ms","start":"2026-05-10T00:47:27.768782Z","end":"2026-05-10T00:47:27.951862Z","steps":["trace[239488395] 'process raft request' (duration: 123.234816ms)","trace[239488395] 'compare' (duration: 59.262581ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:27.952031Z","caller":"traceutil/trace.go:171","msg":"trace[85774160] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:335; }","duration":"162.468525ms","start":"2026-05-10T00:47:27.789468Z","end":"2026-05-10T00:47:27.951936Z","steps":["trace[85774160] 'agreement among raft nodes before linearized reading' (duration: 162.214696ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:27.952311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.621295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-10T00:47:27.95255Z","caller":"traceutil/trace.go:171","msg":"trace[1901828251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:335; }","duration":"150.835282ms","start":"2026-05-10T00:47:27.801642Z","end":"2026-05-10T00:47:27.952477Z","steps":["trace[1901828251] 'agreement among raft nodes before linearized reading' (duration: 150.47813ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.003698Z","caller":"traceutil/trace.go:171","msg":"trace[524955921] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"104.446227ms","start":"2026-05-10T00:47:28.899216Z","end":"2026-05-10T00:47:29.003662Z","steps":["trace[524955921] 'process raft request' (duration: 104.289561ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.453091Z","caller":"traceutil/trace.go:171","msg":"trace[1783642612] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"103.505298ms","start":"2026-05-10T00:47:29.349556Z","end":"2026-05-10T00:47:29.453062Z","steps":["trace[1783642612] 'process raft request' (duration: 102.937919ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.601702Z","caller":"traceutil/trace.go:171","msg":"trace[514098818] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"134.595602ms","start":"2026-05-10T00:47:29.467091Z","end":"2026-05-10T00:47:29.601687Z","steps":["trace[514098818] 'process raft request' (duration: 72.531448ms)","trace[514098818] 'compare' (duration: 61.94815ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:29.601834Z","caller":"traceutil/trace.go:171","msg":"trace[1672612959] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:358; }","duration":"130.486132ms","start":"2026-05-10T00:47:29.471336Z","end":"2026-05-10T00:47:29.601822Z","steps":["trace[1672612959] 'read index received' (duration: 68.318335ms)","trace[1672612959] 'applied index is now lower than readState.Index' (duration: 62.167107ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:29.601889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.262976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-05-10T00:47:29.60187Z","caller":"traceutil/trace.go:171","msg":"trace[1199837096] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"134.401746ms","start":"2026-05-10T00:47:29.467436Z","end":"2026-05-10T00:47:29.601838Z","steps":["trace[1199837096] 'process raft request' (duration: 134.21996ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.601928Z","caller":"traceutil/trace.go:171","msg":"trace[1801743397] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:349; }","duration":"138.319798ms","start":"2026-05-10T00:47:29.463599Z","end":"2026-05-10T00:47:29.601919Z","steps":["trace[1801743397] 'agreement among raft nodes before linearized reading' (duration: 138.224225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:29.601958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.400321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"warn","ts":"2026-05-10T00:47:29.601935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.306947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-05-10T00:47:29.601983Z","caller":"traceutil/trace.go:171","msg":"trace[428590789] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:349; }","duration":"138.446482ms","start":"2026-05-10T00:47:29.463529Z","end":"2026-05-10T00:47:29.601976Z","steps":["trace[428590789] 'agreement among raft nodes before linearized reading' (duration: 138.414331ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.602011Z","caller":"traceutil/trace.go:171","msg":"trace[1479242226] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:349; }","duration":"138.390561ms","start":"2026-05-10T00:47:29.463595Z","end":"2026-05-10T00:47:29.601986Z","steps":["trace[1479242226] 'agreement among raft nodes before linearized reading' (duration: 138.278217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:29.601931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.328889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-05-10T00:47:29.601883Z","caller":"traceutil/trace.go:171","msg":"trace[837702124] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"134.270552ms","start":"2026-05-10T00:47:29.467598Z","end":"2026-05-10T00:47:29.601868Z","steps":["trace[837702124] 'process raft request' (duration: 134.178179ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.602098Z","caller":"traceutil/trace.go:171","msg":"trace[817948366] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:349; }","duration":"138.521185ms","start":"2026-05-10T00:47:29.46356Z","end":"2026-05-10T00:47:29.602081Z","steps":["trace[817948366] 'agreement among raft nodes before linearized reading' (duration: 138.335389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:29.602178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.261597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-10T00:47:29.602214Z","caller":"traceutil/trace.go:171","msg":"trace[1970545094] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:349; }","duration":"112.325889ms","start":"2026-05-10T00:47:29.489878Z","end":"2026-05-10T00:47:29.602204Z","steps":["trace[1970545094] 'agreement among raft nodes before linearized reading' (duration: 112.251196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:29.602373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.814195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-05-10T00:47:29.602578Z","caller":"traceutil/trace.go:171","msg":"trace[486059292] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:349; }","duration":"138.851696ms","start":"2026-05-10T00:47:29.463542Z","end":"2026-05-10T00:47:29.602394Z","steps":["trace[486059292] 'agreement among raft nodes before linearized reading' (duration: 138.498163ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.814902Z","caller":"traceutil/trace.go:171","msg":"trace[981854274] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"206.849931ms","start":"2026-05-10T00:47:29.608025Z","end":"2026-05-10T00:47:29.814875Z","steps":["trace[981854274] 'process raft request' (duration: 194.42741ms)","trace[981854274] 'compare' (duration: 12.257475ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:29.819959Z","caller":"traceutil/trace.go:171","msg":"trace[502182418] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"210.881259ms","start":"2026-05-10T00:47:29.609052Z","end":"2026-05-10T00:47:29.819933Z","steps":["trace[502182418] 'process raft request' (duration: 210.617769ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.82004Z","caller":"traceutil/trace.go:171","msg":"trace[363447689] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:361; }","duration":"179.261026ms","start":"2026-05-10T00:47:29.640762Z","end":"2026-05-10T00:47:29.820023Z","steps":["trace[363447689] 'read index received' (duration: 161.703881ms)","trace[363447689] 'applied index is now lower than readState.Index' (duration: 17.556115ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:29.820125Z","caller":"traceutil/trace.go:171","msg":"trace[686856503] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"209.540872ms","start":"2026-05-10T00:47:29.610575Z","end":"2026-05-10T00:47:29.820116Z","steps":["trace[686856503] 'process raft request' (duration: 209.373566ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.82024Z","caller":"traceutil/trace.go:171","msg":"trace[1697513187] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"209.954827ms","start":"2026-05-10T00:47:29.61028Z","end":"2026-05-10T00:47:29.820234Z","steps":["trace[1697513187] 'process raft request' (duration: 209.535182ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:29.820334Z","caller":"traceutil/trace.go:171","msg":"trace[11437677] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"210.06122ms","start":"2026-05-10T00:47:29.610267Z","end":"2026-05-10T00:47:29.820328Z","steps":["trace[11437677] 'process raft request' (duration: 209.610375ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:29.820397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.586957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-05-10T00:47:29.820482Z","caller":"traceutil/trace.go:171","msg":"trace[1661201911] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:354; }","duration":"179.748602ms","start":"2026-05-10T00:47:29.640716Z","end":"2026-05-10T00:47:29.820464Z","steps":["trace[1661201911] 'agreement among raft nodes before linearized reading' (duration: 179.505604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:29.820784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.41149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-10T00:47:29.821017Z","caller":"traceutil/trace.go:171","msg":"trace[508685102] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:354; }","duration":"130.527615ms","start":"2026-05-10T00:47:29.690311Z","end":"2026-05-10T00:47:29.820839Z","steps":["trace[508685102] 'agreement among raft nodes before linearized reading' (duration: 130.266097ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.064098Z","caller":"traceutil/trace.go:171","msg":"trace[810166933] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:366; }","duration":"236.63408ms","start":"2026-05-10T00:47:29.827446Z","end":"2026-05-10T00:47:30.06408Z","steps":["trace[810166933] 'read index received' (duration: 3.709476ms)","trace[810166933] 'applied index is now lower than readState.Index' (duration: 232.923684ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:30.064302Z","caller":"traceutil/trace.go:171","msg":"trace[750849673] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"235.351698ms","start":"2026-05-10T00:47:29.82891Z","end":"2026-05-10T00:47:30.064262Z","steps":["trace[750849673] 'process raft request' (duration: 235.117329ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.064327Z","caller":"traceutil/trace.go:171","msg":"trace[1162699803] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"234.544809ms","start":"2026-05-10T00:47:29.829766Z","end":"2026-05-10T00:47:30.064311Z","steps":["trace[1162699803] 'process raft request' (duration: 234.28055ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.064516Z","caller":"traceutil/trace.go:171","msg":"trace[1209282066] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"237.088456ms","start":"2026-05-10T00:47:29.827382Z","end":"2026-05-10T00:47:30.06447Z","steps":["trace[1209282066] 'process raft request' (duration: 236.608939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:30.064545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.075645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T00:47:30.06461Z","caller":"traceutil/trace.go:171","msg":"trace[1190331978] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:359; }","duration":"237.18909ms","start":"2026-05-10T00:47:29.827405Z","end":"2026-05-10T00:47:30.064594Z","steps":["trace[1190331978] 'agreement among raft nodes before linearized reading' (duration: 237.001043ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.06438Z","caller":"traceutil/trace.go:171","msg":"trace[1037917501] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"236.994012ms","start":"2026-05-10T00:47:29.827317Z","end":"2026-05-10T00:47:30.064311Z","steps":["trace[1037917501] 'process raft request' (duration: 167.530818ms)","trace[1037917501] 'compare' (duration: 69.03156ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:30.066516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.032767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:3475"} {"level":"info","ts":"2026-05-10T00:47:30.066597Z","caller":"traceutil/trace.go:171","msg":"trace[717993486] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:362; }","duration":"238.12347ms","start":"2026-05-10T00:47:29.828449Z","end":"2026-05-10T00:47:30.066573Z","steps":["trace[717993486] 'agreement among raft nodes before linearized reading' (duration: 238.014026ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.067008Z","caller":"traceutil/trace.go:171","msg":"trace[1936569200] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"233.519713ms","start":"2026-05-10T00:47:29.833458Z","end":"2026-05-10T00:47:30.066978Z","steps":["trace[1936569200] 'process raft request' (duration: 232.972535ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:30.067122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.5103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-10T00:47:30.067275Z","caller":"traceutil/trace.go:171","msg":"trace[1289821320] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"235.532342ms","start":"2026-05-10T00:47:29.831699Z","end":"2026-05-10T00:47:30.067231Z","steps":["trace[1289821320] 'process raft request' (duration: 234.695464ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.067303Z","caller":"traceutil/trace.go:171","msg":"trace[1911257442] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"235.992868ms","start":"2026-05-10T00:47:29.831291Z","end":"2026-05-10T00:47:30.067284Z","steps":["trace[1911257442] 'process raft request' (duration: 235.026096ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.067516Z","caller":"traceutil/trace.go:171","msg":"trace[1276159274] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:362; }","duration":"227.915633ms","start":"2026-05-10T00:47:29.839578Z","end":"2026-05-10T00:47:30.067494Z","steps":["trace[1276159274] 'agreement among raft nodes before linearized reading' (duration: 227.443257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:30.067439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.406585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-10T00:47:30.067841Z","caller":"traceutil/trace.go:171","msg":"trace[230400703] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:362; }","duration":"178.8379ms","start":"2026-05-10T00:47:29.888993Z","end":"2026-05-10T00:47:30.067831Z","steps":["trace[230400703] 'agreement among raft nodes before linearized reading' (duration: 178.386425ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.305736Z","caller":"traceutil/trace.go:171","msg":"trace[2100169347] transaction","detail":"{read_only:false; response_revision:383; number_of_response:1; }","duration":"163.036398ms","start":"2026-05-10T00:47:30.142669Z","end":"2026-05-10T00:47:30.305705Z","steps":["trace[2100169347] 'process raft request' (duration: 122.976084ms)","trace[2100169347] 'compare' (duration: 39.888258ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:30.305768Z","caller":"traceutil/trace.go:171","msg":"trace[388887627] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"160.051929ms","start":"2026-05-10T00:47:30.145698Z","end":"2026-05-10T00:47:30.30575Z","steps":["trace[388887627] 'process raft request' (duration: 159.979106ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.306561Z","caller":"traceutil/trace.go:171","msg":"trace[572275203] transaction","detail":"{read_only:false; response_revision:384; number_of_response:1; }","duration":"163.606387ms","start":"2026-05-10T00:47:30.142729Z","end":"2026-05-10T00:47:30.306335Z","steps":["trace[572275203] 'process raft request' (duration: 162.914834ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.307141Z","caller":"traceutil/trace.go:171","msg":"trace[1046530485] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"156.561041ms","start":"2026-05-10T00:47:30.150453Z","end":"2026-05-10T00:47:30.307014Z","steps":["trace[1046530485] 'process raft request' (duration: 155.255257ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.308953Z","caller":"traceutil/trace.go:171","msg":"trace[2038890737] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"158.042971ms","start":"2026-05-10T00:47:30.15089Z","end":"2026-05-10T00:47:30.308933Z","steps":["trace[2038890737] 'process raft request' (duration: 155.690153ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.424951Z","caller":"traceutil/trace.go:171","msg":"trace[1768826520] linearizableReadLoop","detail":"{readStateIndex:400; appliedIndex:399; }","duration":"107.192875ms","start":"2026-05-10T00:47:30.31773Z","end":"2026-05-10T00:47:30.424922Z","steps":["trace[1768826520] 'read index received' (duration: 99.90546ms)","trace[1768826520] 'applied index is now lower than readState.Index' (duration: 7.286045ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:30.425024Z","caller":"traceutil/trace.go:171","msg":"trace[1610342600] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"109.936857ms","start":"2026-05-10T00:47:30.315047Z","end":"2026-05-10T00:47:30.424984Z","steps":["trace[1610342600] 'process raft request' (duration: 102.711965ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:30.425156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.393992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-05-10T00:47:30.425251Z","caller":"traceutil/trace.go:171","msg":"trace[88129410] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:388; }","duration":"107.528526ms","start":"2026-05-10T00:47:30.317703Z","end":"2026-05-10T00:47:30.425232Z","steps":["trace[88129410] 'agreement among raft nodes before linearized reading' (duration: 107.32725ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:30.658499Z","caller":"traceutil/trace.go:171","msg":"trace[608240825] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"224.292963ms","start":"2026-05-10T00:47:30.434178Z","end":"2026-05-10T00:47:30.658471Z","steps":["trace[608240825] 'process raft request' (duration: 138.475996ms)","trace[608240825] 'compare' (duration: 85.694983ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:30.660646Z","caller":"traceutil/trace.go:171","msg":"trace[935250624] linearizableReadLoop","detail":"{readStateIndex:402; appliedIndex:400; }","duration":"223.30142ms","start":"2026-05-10T00:47:30.43732Z","end":"2026-05-10T00:47:30.660621Z","steps":["trace[935250624] 'read index received' (duration: 135.349631ms)","trace[935250624] 'applied index is now lower than readState.Index' (duration: 87.950569ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:30.660747Z","caller":"traceutil/trace.go:171","msg":"trace[2040786746] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"224.005043ms","start":"2026-05-10T00:47:30.436711Z","end":"2026-05-10T00:47:30.660716Z","steps":["trace[2040786746] 'process raft request' (duration: 223.776905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:30.660804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.459536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"info","ts":"2026-05-10T00:47:30.660892Z","caller":"traceutil/trace.go:171","msg":"trace[1151534858] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:390; }","duration":"223.583151ms","start":"2026-05-10T00:47:30.437296Z","end":"2026-05-10T00:47:30.660879Z","steps":["trace[1151534858] 'agreement among raft nodes before linearized reading' (duration: 223.445896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:30.660945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.708474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:47:30.661124Z","caller":"traceutil/trace.go:171","msg":"trace[1395715559] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:390; }","duration":"161.89223ms","start":"2026-05-10T00:47:30.499208Z","end":"2026-05-10T00:47:30.6611Z","steps":["trace[1395715559] 'agreement among raft nodes before linearized reading' (duration: 161.665183ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:42.326852Z","caller":"traceutil/trace.go:171","msg":"trace[2061729267] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"113.021469ms","start":"2026-05-10T00:47:42.213809Z","end":"2026-05-10T00:47:42.326831Z","steps":["trace[2061729267] 'process raft request' (duration: 103.62307ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.940525Z","caller":"traceutil/trace.go:171","msg":"trace[125786753] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"136.331765ms","start":"2026-05-10T00:47:50.804175Z","end":"2026-05-10T00:47:50.940507Z","steps":["trace[125786753] 'process raft request' (duration: 136.227982ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.952579Z","caller":"traceutil/trace.go:171","msg":"trace[180454486] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"146.921056ms","start":"2026-05-10T00:47:50.805631Z","end":"2026-05-10T00:47:50.952552Z","steps":["trace[180454486] 'process raft request' (duration: 146.724741ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.952856Z","caller":"traceutil/trace.go:171","msg":"trace[804132781] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"135.83468ms","start":"2026-05-10T00:47:50.817Z","end":"2026-05-10T00:47:50.952835Z","steps":["trace[804132781] 'process raft request' (duration: 135.521222ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.953026Z","caller":"traceutil/trace.go:171","msg":"trace[395769088] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"136.066798ms","start":"2026-05-10T00:47:50.816942Z","end":"2026-05-10T00:47:50.953009Z","steps":["trace[395769088] 'process raft request' (duration: 135.539733ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.952994Z","caller":"traceutil/trace.go:171","msg":"trace[1634056575] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"136.095447ms","start":"2026-05-10T00:47:50.816878Z","end":"2026-05-10T00:47:50.952973Z","steps":["trace[1634056575] 'process raft request' (duration: 135.566603ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.953196Z","caller":"traceutil/trace.go:171","msg":"trace[471056550] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"104.365124ms","start":"2026-05-10T00:47:50.848821Z","end":"2026-05-10T00:47:50.953186Z","steps":["trace[471056550] 'process raft request' (duration: 103.801898ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.953326Z","caller":"traceutil/trace.go:171","msg":"trace[381478524] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"134.818743ms","start":"2026-05-10T00:47:50.818494Z","end":"2026-05-10T00:47:50.953312Z","steps":["trace[381478524] 'process raft request' (duration: 134.057572ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.953346Z","caller":"traceutil/trace.go:171","msg":"trace[1141159540] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"119.443429ms","start":"2026-05-10T00:47:50.833891Z","end":"2026-05-10T00:47:50.953334Z","steps":["trace[1141159540] 'process raft request' (duration: 118.702419ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:50.953432Z","caller":"traceutil/trace.go:171","msg":"trace[150266588] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"102.164844ms","start":"2026-05-10T00:47:50.851252Z","end":"2026-05-10T00:47:50.953416Z","steps":["trace[150266588] 'process raft request' (duration: 101.623758ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:54.769943Z","caller":"traceutil/trace.go:171","msg":"trace[1924794744] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"442.21455ms","start":"2026-05-10T00:47:54.327701Z","end":"2026-05-10T00:47:54.769916Z","steps":["trace[1924794744] 'read index received' (duration: 440.619407ms)","trace[1924794744] 'applied index is now lower than readState.Index' (duration: 1.594243ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:54.770008Z","caller":"traceutil/trace.go:171","msg":"trace[1218206377] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"707.301458ms","start":"2026-05-10T00:47:54.062681Z","end":"2026-05-10T00:47:54.769983Z","steps":["trace[1218206377] 'process raft request' (duration: 706.146167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:54.770165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:54.062653Z","time spent":"707.442012ms","remote":"127.0.0.1:44742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T00:47:54.770247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.705058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-10T00:47:54.770246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.408166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:47:54.77118Z","caller":"traceutil/trace.go:171","msg":"trace[768396425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:599; }","duration":"319.77987ms","start":"2026-05-10T00:47:54.450493Z","end":"2026-05-10T00:47:54.770273Z","steps":["trace[768396425] 'agreement among raft nodes before linearized reading' (duration: 319.613296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:54.771301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.600146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T00:47:54.771366Z","caller":"traceutil/trace.go:171","msg":"trace[888897892] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:599; }","duration":"443.685939ms","start":"2026-05-10T00:47:54.327648Z","end":"2026-05-10T00:47:54.771334Z","steps":["trace[888897892] 'agreement among raft nodes before linearized reading' (duration: 442.451946ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:54.771409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:54.327627Z","time spent":"443.771671ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-10T00:47:54.771542Z","caller":"traceutil/trace.go:171","msg":"trace[241366584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:599; }","duration":"240.381221ms","start":"2026-05-10T00:47:54.530775Z","end":"2026-05-10T00:47:54.771156Z","steps":["trace[241366584] 'agreement among raft nodes before linearized reading' (duration: 239.401146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:54.775092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:54.450476Z","time spent":"324.579107ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-10T00:47:57.177697Z","caller":"traceutil/trace.go:171","msg":"trace[25802504] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"177.759506ms","start":"2026-05-10T00:47:56.999917Z","end":"2026-05-10T00:47:57.177677Z","steps":["trace[25802504] 'process raft request' (duration: 177.637163ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:57.44375Z","caller":"traceutil/trace.go:171","msg":"trace[1847915663] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"146.966368ms","start":"2026-05-10T00:47:57.296756Z","end":"2026-05-10T00:47:57.443722Z","steps":["trace[1847915663] 'process raft request' (duration: 146.394763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:58.102309Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398340590351025432,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-10T00:47:59.061729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"571.630162ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T00:47:59.061954Z","caller":"traceutil/trace.go:171","msg":"trace[951542799] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"1.553700654s","start":"2026-05-10T00:47:57.50821Z","end":"2026-05-10T00:47:59.06191Z","steps":["trace[951542799] 'process raft request' (duration: 981.427535ms)","trace[951542799] 'compare' (duration: 571.355186ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:47:59.062086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:57.508183Z","time spent":"1.553825217s","remote":"127.0.0.1:44958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T00:47:59.067688Z","caller":"traceutil/trace.go:171","msg":"trace[980487606] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"1.466351574s","start":"2026-05-10T00:47:57.601321Z","end":"2026-05-10T00:47:59.067672Z","steps":["trace[980487606] 'read index received' (duration: 888.33627ms)","trace[980487606] 'applied index is now lower than readState.Index' (duration: 578.014564ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:47:59.067723Z","caller":"traceutil/trace.go:171","msg":"trace[71818766] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"716.524872ms","start":"2026-05-10T00:47:58.351174Z","end":"2026-05-10T00:47:59.067699Z","steps":["trace[71818766] 'process raft request' (duration: 716.399979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:59.067827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.273333404s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hcjh4\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-10T00:47:59.067852Z","caller":"traceutil/trace.go:171","msg":"trace[1885353993] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hcjh4; range_end:; response_count:1; response_revision:621; }","duration":"1.273427038s","start":"2026-05-10T00:47:57.794418Z","end":"2026-05-10T00:47:59.067845Z","steps":["trace[1885353993] 'agreement among raft nodes before linearized reading' (duration: 1.273344975s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:59.067877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:57.794399Z","time spent":"1.273471658s","remote":"127.0.0.1:44800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-hcjh4\" "} {"level":"warn","ts":"2026-05-10T00:47:59.067923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.855424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-10T00:47:59.067917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:58.35115Z","time spent":"716.694138ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T00:47:59.067953Z","caller":"traceutil/trace.go:171","msg":"trace[1701275815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:621; }","duration":"268.922746ms","start":"2026-05-10T00:47:58.799021Z","end":"2026-05-10T00:47:59.067943Z","steps":["trace[1701275815] 'agreement among raft nodes before linearized reading' (duration: 268.813613ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:59.067932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.893325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-10T00:47:59.068034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.007674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:47:59.06804Z","caller":"traceutil/trace.go:171","msg":"trace[1501713299] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"268.999408ms","start":"2026-05-10T00:47:58.799024Z","end":"2026-05-10T00:47:59.068024Z","steps":["trace[1501713299] 'agreement among raft nodes before linearized reading' (duration: 268.753881ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:47:59.068065Z","caller":"traceutil/trace.go:171","msg":"trace[1553355993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"569.034895ms","start":"2026-05-10T00:47:58.499019Z","end":"2026-05-10T00:47:59.068054Z","steps":["trace[1553355993] 'agreement among raft nodes before linearized reading' (duration: 568.989724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:59.068092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:58.498978Z","time spent":"569.108617ms","remote":"127.0.0.1:44656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T00:47:59.068212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.466905247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T00:47:59.068239Z","caller":"traceutil/trace.go:171","msg":"trace[1730949926] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:621; }","duration":"1.466969789s","start":"2026-05-10T00:47:57.60126Z","end":"2026-05-10T00:47:59.06823Z","steps":["trace[1730949926] 'agreement among raft nodes before linearized reading' (duration: 1.466886737s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:47:59.068258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:47:57.60124Z","time spent":"1.467013051s","remote":"127.0.0.1:44894","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-05-10T00:48:00.104973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.049022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T00:48:00.105049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.300988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:48:00.105055Z","caller":"traceutil/trace.go:171","msg":"trace[1655837219] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:632; }","duration":"171.176294ms","start":"2026-05-10T00:47:59.933862Z","end":"2026-05-10T00:48:00.105038Z","steps":["trace[1655837219] 'range keys from in-memory index tree' (duration: 171.013391ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:00.105094Z","caller":"traceutil/trace.go:171","msg":"trace[575089728] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:632; }","duration":"171.36022ms","start":"2026-05-10T00:47:59.933716Z","end":"2026-05-10T00:48:00.105076Z","steps":["trace[575089728] 'count revisions from in-memory index tree' (duration: 171.254767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:00.105249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.527927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T00:48:00.104979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.97516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:48:00.10539Z","caller":"traceutil/trace.go:171","msg":"trace[1643199957] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:632; }","duration":"153.758203ms","start":"2026-05-10T00:47:59.951607Z","end":"2026-05-10T00:48:00.105365Z","steps":["trace[1643199957] 'range keys from in-memory index tree' (duration: 153.452725ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:00.105349Z","caller":"traceutil/trace.go:171","msg":"trace[2100302233] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:632; }","duration":"171.36994ms","start":"2026-05-10T00:47:59.93397Z","end":"2026-05-10T00:48:00.105339Z","steps":["trace[2100302233] 'range keys from in-memory index tree' (duration: 170.946859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:00.105517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.902095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:48:00.105748Z","caller":"traceutil/trace.go:171","msg":"trace[1718663922] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:632; }","duration":"150.11026ms","start":"2026-05-10T00:47:59.955587Z","end":"2026-05-10T00:48:00.105698Z","steps":["trace[1718663922] 'range keys from in-memory index tree' (duration: 149.871884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:00.106535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.923551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:48:00.106659Z","caller":"traceutil/trace.go:171","msg":"trace[340596229] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:632; }","duration":"155.085476ms","start":"2026-05-10T00:47:59.951543Z","end":"2026-05-10T00:48:00.106628Z","steps":["trace[340596229] 'count revisions from in-memory index tree' (duration: 153.465685ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:00.109306Z","caller":"traceutil/trace.go:171","msg":"trace[546737066] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"107.5942ms","start":"2026-05-10T00:48:00.001693Z","end":"2026-05-10T00:48:00.109288Z","steps":["trace[546737066] 'process raft request' (duration: 106.324538ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:04.158385Z","caller":"traceutil/trace.go:171","msg":"trace[703090601] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:730; }","duration":"103.15147ms","start":"2026-05-10T00:48:04.055218Z","end":"2026-05-10T00:48:04.15837Z","steps":["trace[703090601] 'read index received' (duration: 102.926784ms)","trace[703090601] 'applied index is now lower than readState.Index' (duration: 224.026µs)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:48:04.158648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.426956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-05-10T00:48:04.158703Z","caller":"traceutil/trace.go:171","msg":"trace[343055546] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:708; }","duration":"103.527938ms","start":"2026-05-10T00:48:04.055164Z","end":"2026-05-10T00:48:04.158692Z","steps":["trace[343055546] 'agreement among raft nodes before linearized reading' (duration: 103.385025ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:04.158815Z","caller":"traceutil/trace.go:171","msg":"trace[694693359] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"163.853059ms","start":"2026-05-10T00:48:03.994888Z","end":"2026-05-10T00:48:04.158741Z","steps":["trace[694693359] 'process raft request' (duration: 163.309977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:15.161754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.20056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:48:15.161837Z","caller":"traceutil/trace.go:171","msg":"trace[939612864] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:781; }","duration":"663.313592ms","start":"2026-05-10T00:48:14.498503Z","end":"2026-05-10T00:48:15.161816Z","steps":["trace[939612864] 'range keys from in-memory index tree' (duration: 663.102227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:15.161858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.427328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-m56jv\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-10T00:48:15.161887Z","caller":"traceutil/trace.go:171","msg":"trace[1812892205] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-m56jv; range_end:; response_count:1; response_revision:781; }","duration":"270.489439ms","start":"2026-05-10T00:48:14.891389Z","end":"2026-05-10T00:48:15.161878Z","steps":["trace[1812892205] 'range keys from in-memory index tree' (duration: 270.311786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:15.161807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.535394ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:48:15.161944Z","caller":"traceutil/trace.go:171","msg":"trace[530975771] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:781; }","duration":"292.680207ms","start":"2026-05-10T00:48:14.869242Z","end":"2026-05-10T00:48:15.161922Z","steps":["trace[530975771] 'range keys from in-memory index tree' (duration: 292.520694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:15.162003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.271965ms","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-05-10T00:48:15.162106Z","caller":"traceutil/trace.go:171","msg":"trace[832623920] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:781; }","duration":"636.404808ms","start":"2026-05-10T00:48:14.525687Z","end":"2026-05-10T00:48:15.162092Z","steps":["trace[832623920] 'range keys from in-memory index tree' (duration: 636.135682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:15.161887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:14.498487Z","time spent":"663.385464ms","remote":"127.0.0.1:44656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T00:48:15.162156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T00:48:14.52567Z","time spent":"636.472799ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-10T00:48:29.486677Z","caller":"traceutil/trace.go:171","msg":"trace[1933626052] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"207.592271ms","start":"2026-05-10T00:48:29.279062Z","end":"2026-05-10T00:48:29.486655Z","steps":["trace[1933626052] 'process raft request' (duration: 188.402276ms)","trace[1933626052] 'compare' (duration: 19.084673ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:48:29.486986Z","caller":"traceutil/trace.go:171","msg":"trace[1338195008] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"207.809566ms","start":"2026-05-10T00:48:29.279151Z","end":"2026-05-10T00:48:29.48696Z","steps":["trace[1338195008] 'process raft request' (duration: 207.476309ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:48:29.487185Z","caller":"traceutil/trace.go:171","msg":"trace[1742600610] linearizableReadLoop","detail":"{readStateIndex:989; appliedIndex:986; }","duration":"154.935353ms","start":"2026-05-10T00:48:29.332237Z","end":"2026-05-10T00:48:29.487173Z","steps":["trace[1742600610] 'read index received' (duration: 135.223997ms)","trace[1742600610] 'applied index is now lower than readState.Index' (duration: 19.710546ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T00:48:29.487263Z","caller":"traceutil/trace.go:171","msg":"trace[2136046538] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"208.00363ms","start":"2026-05-10T00:48:29.279251Z","end":"2026-05-10T00:48:29.487255Z","steps":["trace[2136046538] 'process raft request' (duration: 207.615973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:29.487363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.112347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-tzh5k\" ","response":"range_response_count:1 size:5674"} {"level":"info","ts":"2026-05-10T00:48:29.487402Z","caller":"traceutil/trace.go:171","msg":"trace[663657510] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-tzh5k; range_end:; response_count:1; response_revision:957; }","duration":"155.161317ms","start":"2026-05-10T00:48:29.332229Z","end":"2026-05-10T00:48:29.487391Z","steps":["trace[663657510] 'agreement among raft nodes before linearized reading' (duration: 155.039325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T00:48:29.487453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.628414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-10T00:48:29.487528Z","caller":"traceutil/trace.go:171","msg":"trace[1313418458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:957; }","duration":"129.745868ms","start":"2026-05-10T00:48:29.357767Z","end":"2026-05-10T00:48:29.487513Z","steps":["trace[1313418458] 'agreement among raft nodes before linearized reading' (duration: 129.503972ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:50:44.400514Z","caller":"traceutil/trace.go:171","msg":"trace[1336730791] linearizableReadLoop","detail":"{readStateIndex:1520; appliedIndex:1518; }","duration":"101.911871ms","start":"2026-05-10T00:50:44.298578Z","end":"2026-05-10T00:50:44.400489Z","steps":["trace[1336730791] 'read index received' (duration: 18.200616ms)","trace[1336730791] 'applied index is now lower than readState.Index' (duration: 83.710365ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:50:44.400766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.172294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T00:50:44.400808Z","caller":"traceutil/trace.go:171","msg":"trace[1031915239] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1457; }","duration":"102.252804ms","start":"2026-05-10T00:50:44.298543Z","end":"2026-05-10T00:50:44.400796Z","steps":["trace[1031915239] 'agreement among raft nodes before linearized reading' (duration: 102.083962ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:50:44.400778Z","caller":"traceutil/trace.go:171","msg":"trace[510153984] transaction","detail":"{read_only:false; response_revision:1457; number_of_response:1; }","duration":"118.581427ms","start":"2026-05-10T00:50:44.28212Z","end":"2026-05-10T00:50:44.400701Z","steps":["trace[510153984] 'process raft request' (duration: 118.248913ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:50:44.603443Z","caller":"traceutil/trace.go:171","msg":"trace[1846491227] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"198.09843ms","start":"2026-05-10T00:50:44.405308Z","end":"2026-05-10T00:50:44.603406Z","steps":["trace[1846491227] 'process raft request' (duration: 196.786574ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:50:44.603492Z","caller":"traceutil/trace.go:171","msg":"trace[1100726614] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"197.741895ms","start":"2026-05-10T00:50:44.405707Z","end":"2026-05-10T00:50:44.603449Z","steps":["trace[1100726614] 'process raft request' (duration: 197.613613ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T00:50:44.603583Z","caller":"traceutil/trace.go:171","msg":"trace[1441752077] linearizableReadLoop","detail":"{readStateIndex:1522; appliedIndex:1520; }","duration":"104.048997ms","start":"2026-05-10T00:50:44.499499Z","end":"2026-05-10T00:50:44.603548Z","steps":["trace[1441752077] 'read index received' (duration: 102.593718ms)","trace[1441752077] 'applied index is now lower than readState.Index' (duration: 1.451009ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T00:50:44.603695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.187258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T00:50:44.603732Z","caller":"traceutil/trace.go:171","msg":"trace[596029157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1460; }","duration":"104.270379ms","start":"2026-05-10T00:50:44.499449Z","end":"2026-05-10T00:50:44.603719Z","steps":["trace[596029157] 'agreement among raft nodes before linearized reading' (duration: 104.203098ms)"],"step_count":1}