{"level":"warn","ts":"2026-05-09T16:51:35.932381Z","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-09T16:51:35.932505Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-09T16:51:35.932601Z","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-09T16:51:35.932619Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-05-09T16:51:35.932644Z","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-09T16:51:35.933524Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-05-09T16:51:35.933613Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-09T16:51:35.937805Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.923008ms"} {"level":"info","ts":"2026-05-09T16:51:35.949514Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-05-09T16:51:35.949603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T16:51:35.949633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-05-09T16:51:35.949651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T16:51:35.949662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-05-09T16:51:35.949708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-05-09T16:51:35.956384Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T16:51:35.963638Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T16:51:35.968847Z","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-09T16:51:35.971662Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T16:51:35.971879Z","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-09T16:51:35.97198Z","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-09T16:51:35.971992Z","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-09T16:51:35.975716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-05-09T16:51:35.975854Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-05-09T16:51:35.977391Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T16:51:35.977644Z","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-09T16:51:35.977776Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-05-09T16:51:35.977799Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-05-09T16:51:35.97806Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T16:51:35.978108Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T16:51:36.351351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T16:51:36.351402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T16:51:36.351436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-05-09T16:51:36.35145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-05-09T16:51:36.351458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-05-09T16:51:36.351604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-05-09T16:51:36.351625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-05-09T16:51:36.387154Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:51:36.388605Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T16:51:36.388829Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T16:51:36.388876Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T16:51:36.389115Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:51:36.38929Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:51:36.38931Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T16:51:36.389458Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T16:51:36.389514Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T16:51:36.391327Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-09T16:51:36.392698Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-05-09T16:51:37.945311Z","caller":"traceutil/trace.go:171","msg":"trace[1001878256] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"148.381033ms","start":"2026-05-09T16:51:37.796895Z","end":"2026-05-09T16:51:37.945276Z","steps":["trace[1001878256] 'read index received' (duration: 148.330523ms)","trace[1001878256] 'applied index is now lower than readState.Index' (duration: 49.35µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:51:37.945385Z","caller":"traceutil/trace.go:171","msg":"trace[1653207600] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"149.221713ms","start":"2026-05-09T16:51:37.796131Z","end":"2026-05-09T16:51:37.945353Z","steps":["trace[1653207600] 'process raft request' (duration: 148.915719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:37.947158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.15732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:51:37.94737Z","caller":"traceutil/trace.go:171","msg":"trace[267196478] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:0; response_revision:2; }","duration":"150.407132ms","start":"2026-05-09T16:51:37.796874Z","end":"2026-05-09T16:51:37.947281Z","steps":["trace[267196478] 'agreement among raft nodes before linearized reading' (duration: 148.580545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.445509Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872623854062976,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T16:51:38.622982Z","caller":"traceutil/trace.go:171","msg":"trace[1090914250] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"729.109225ms","start":"2026-05-09T16:51:37.893845Z","end":"2026-05-09T16:51:38.622954Z","steps":["trace[1090914250] 'process raft request' (duration: 729.075015ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.62318Z","caller":"traceutil/trace.go:171","msg":"trace[1931356682] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"756.09145ms","start":"2026-05-09T16:51:37.867041Z","end":"2026-05-09T16:51:38.623133Z","steps":["trace[1931356682] 'process raft request' (duration: 755.769427ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.623472Z","caller":"traceutil/trace.go:171","msg":"trace[152127287] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"756.533594ms","start":"2026-05-09T16:51:37.866918Z","end":"2026-05-09T16:51:38.623452Z","steps":["trace[152127287] 'process raft request' (duration: 755.814747ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.623542Z","caller":"traceutil/trace.go:171","msg":"trace[423343345] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"756.901659ms","start":"2026-05-09T16:51:37.866629Z","end":"2026-05-09T16:51:38.623531Z","steps":["trace[423343345] 'process raft request' (duration: 755.89595ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.623551Z","caller":"traceutil/trace.go:171","msg":"trace[1847897292] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"756.441054ms","start":"2026-05-09T16:51:37.867076Z","end":"2026-05-09T16:51:38.623517Z","steps":["trace[1847897292] 'process raft request' (duration: 755.693487ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.623817Z","caller":"traceutil/trace.go:171","msg":"trace[1524873436] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"756.572866ms","start":"2026-05-09T16:51:37.867224Z","end":"2026-05-09T16:51:38.623797Z","steps":["trace[1524873436] 'process raft request' (duration: 755.632716ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.62407Z","caller":"traceutil/trace.go:171","msg":"trace[1164913179] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"731.197246ms","start":"2026-05-09T16:51:37.892622Z","end":"2026-05-09T16:51:38.623819Z","steps":["trace[1164913179] 'process raft request' (duration: 730.256086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.624092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.867067Z","time spent":"756.548964ms","remote":"127.0.0.1:58332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:51:38.624112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.867187Z","time spent":"756.861168ms","remote":"127.0.0.1:58332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:51:38.624143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.866617Z","time spent":"756.952239ms","remote":"127.0.0.1:58258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:51:38.624192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.892597Z","time spent":"731.553589ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:51:38.624104Z","caller":"traceutil/trace.go:171","msg":"trace[1214764309] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"756.866478ms","start":"2026-05-09T16:51:37.867228Z","end":"2026-05-09T16:51:38.624094Z","steps":["trace[1214764309] 'process raft request' (duration: 755.608876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.62426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.893827Z","time spent":"729.235937ms","remote":"127.0.0.1:58082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:51:38.624295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.867218Z","time spent":"757.04849ms","remote":"127.0.0.1:58332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:51:38.624165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.867024Z","time spent":"756.252673ms","remote":"127.0.0.1:58332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:51:38.624569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.86691Z","time spent":"756.614396ms","remote":"127.0.0.1:58332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:51:38.760738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"896.486838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.248\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-09T16:51:38.760782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.445069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:51:38.760856Z","caller":"traceutil/trace.go:171","msg":"trace[309852478] range","detail":"{range_begin:/registry/masterleases/199.204.45.248; range_end:; response_count:0; response_revision:11; }","duration":"896.638599ms","start":"2026-05-09T16:51:37.864191Z","end":"2026-05-09T16:51:38.76083Z","steps":["trace[309852478] 'agreement among raft nodes before linearized reading' (duration: 896.356207ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.760916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.863664Z","time spent":"897.240986ms","remote":"127.0.0.1:57846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.248\" "} {"level":"warn","ts":"2026-05-09T16:51:38.760966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.239907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:51:38.761053Z","caller":"traceutil/trace.go:171","msg":"trace[1406404873] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"893.354898ms","start":"2026-05-09T16:51:37.867676Z","end":"2026-05-09T16:51:38.761031Z","steps":["trace[1406404873] 'agreement among raft nodes before linearized reading' (duration: 893.254317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.761165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.867649Z","time spent":"893.479949ms","remote":"127.0.0.1:57884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-09T16:51:38.761333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.969543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:51:38.761317Z","caller":"traceutil/trace.go:171","msg":"trace[1592444786] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"808.323164ms","start":"2026-05-09T16:51:37.952949Z","end":"2026-05-09T16:51:38.761272Z","steps":["trace[1592444786] 'process raft request' (duration: 776.041711ms)","trace[1592444786] 'compare' (duration: 31.252853ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:51:38.761375Z","caller":"traceutil/trace.go:171","msg":"trace[1167764146] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"896.030653ms","start":"2026-05-09T16:51:37.865334Z","end":"2026-05-09T16:51:38.761365Z","steps":["trace[1167764146] 'agreement among raft nodes before linearized reading' (duration: 895.969843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.761418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.865323Z","time spent":"896.080434ms","remote":"127.0.0.1:57924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-09T16:51:38.761282Z","caller":"traceutil/trace.go:171","msg":"trace[606479758] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"815.804914ms","start":"2026-05-09T16:51:37.945419Z","end":"2026-05-09T16:51:38.761224Z","steps":["trace[606479758] 'read index received' (duration: 677.152164ms)","trace[606479758] 'applied index is now lower than readState.Index' (duration: 137.917213ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:51:38.761767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.952913Z","time spent":"808.486956ms","remote":"127.0.0.1:57868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:51:38.761782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.132206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:51:38.761844Z","caller":"traceutil/trace.go:171","msg":"trace[1059896374] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"913.286427ms","start":"2026-05-09T16:51:37.84854Z","end":"2026-05-09T16:51:38.761826Z","steps":["trace[1059896374] 'agreement among raft nodes before linearized reading' (duration: 913.039064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.761872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"910.892214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:51:38.761924Z","caller":"traceutil/trace.go:171","msg":"trace[65898744] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"910.970615ms","start":"2026-05-09T16:51:37.850942Z","end":"2026-05-09T16:51:38.761913Z","steps":["trace[65898744] 'agreement among raft nodes before linearized reading' (duration: 910.895254ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.761937Z","caller":"traceutil/trace.go:171","msg":"trace[1628198808] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"911.616441ms","start":"2026-05-09T16:51:37.849242Z","end":"2026-05-09T16:51:38.760859Z","steps":["trace[1628198808] 'agreement among raft nodes before linearized reading' (duration: 911.375679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.761969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.850932Z","time spent":"911.028935ms","remote":"127.0.0.1:57924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-09T16:51:38.762006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.849204Z","time spent":"912.783192ms","remote":"127.0.0.1:57924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-09T16:51:38.761981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.848508Z","time spent":"913.384248ms","remote":"127.0.0.1:57924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-09T16:51:38.76217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.134187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"warn","ts":"2026-05-09T16:51:38.762204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.212467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-05-09T16:51:38.762212Z","caller":"traceutil/trace.go:171","msg":"trace[1990254985] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"965.186967ms","start":"2026-05-09T16:51:37.797013Z","end":"2026-05-09T16:51:38.7622Z","steps":["trace[1990254985] 'agreement among raft nodes before linearized reading' (duration: 965.087436ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.762242Z","caller":"traceutil/trace.go:171","msg":"trace[586219932] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"965.264097ms","start":"2026-05-09T16:51:37.796967Z","end":"2026-05-09T16:51:38.762231Z","steps":["trace[586219932] 'agreement among raft nodes before linearized reading' (duration: 965.178107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.762282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.796962Z","time spent":"965.312869ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-09T16:51:38.762314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"842.781419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-09T16:51:38.762382Z","caller":"traceutil/trace.go:171","msg":"trace[1431368765] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"844.374004ms","start":"2026-05-09T16:51:37.917993Z","end":"2026-05-09T16:51:38.762367Z","steps":["trace[1431368765] 'agreement among raft nodes before linearized reading' (duration: 842.678738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.762412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.917925Z","time spent":"844.478617ms","remote":"127.0.0.1:57924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-09T16:51:38.762244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:51:37.797005Z","time spent":"965.233457ms","remote":"127.0.0.1:57982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-09T16:51:38.76259Z","caller":"traceutil/trace.go:171","msg":"trace[473262763] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"132.673844ms","start":"2026-05-09T16:51:38.629905Z","end":"2026-05-09T16:51:38.762579Z","steps":["trace[473262763] 'process raft request' (duration: 132.457002ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.762718Z","caller":"traceutil/trace.go:171","msg":"trace[500240480] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"132.30234ms","start":"2026-05-09T16:51:38.630403Z","end":"2026-05-09T16:51:38.762705Z","steps":["trace[500240480] 'process raft request' (duration: 132.073058ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.762847Z","caller":"traceutil/trace.go:171","msg":"trace[1761975850] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"128.408744ms","start":"2026-05-09T16:51:38.634421Z","end":"2026-05-09T16:51:38.76283Z","steps":["trace[1761975850] 'process raft request' (duration: 128.100162ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.762887Z","caller":"traceutil/trace.go:171","msg":"trace[1375575656] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"133.011047ms","start":"2026-05-09T16:51:38.629869Z","end":"2026-05-09T16:51:38.76288Z","steps":["trace[1375575656] 'process raft request' (duration: 132.452683ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.76285Z","caller":"traceutil/trace.go:171","msg":"trace[1649736511] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"133.098638ms","start":"2026-05-09T16:51:38.629739Z","end":"2026-05-09T16:51:38.762837Z","steps":["trace[1649736511] 'process raft request' (duration: 132.517292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:51:38.762771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.47189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-27686\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-05-09T16:51:38.763089Z","caller":"traceutil/trace.go:171","msg":"trace[644997492] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-27686; range_end:; response_count:1; response_revision:18; }","duration":"134.795194ms","start":"2026-05-09T16:51:38.628283Z","end":"2026-05-09T16:51:38.763078Z","steps":["trace[644997492] 'agreement among raft nodes before linearized reading' (duration: 134.38789ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.763161Z","caller":"traceutil/trace.go:171","msg":"trace[604775914] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"133.031348ms","start":"2026-05-09T16:51:38.630114Z","end":"2026-05-09T16:51:38.763145Z","steps":["trace[604775914] 'process raft request' (duration: 132.331611ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:51:38.763463Z","caller":"traceutil/trace.go:171","msg":"trace[892276471] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"133.473981ms","start":"2026-05-09T16:51:38.629975Z","end":"2026-05-09T16:51:38.763449Z","steps":["trace[892276471] 'process raft request' (duration: 132.428102ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:06.866515Z","caller":"traceutil/trace.go:171","msg":"trace[1106863117] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:482; }","duration":"150.209678ms","start":"2026-05-09T16:52:06.716278Z","end":"2026-05-09T16:52:06.866488Z","steps":["trace[1106863117] 'read index received' (duration: 56.655504ms)","trace[1106863117] 'applied index is now lower than readState.Index' (duration: 93.552784ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:52:06.866591Z","caller":"traceutil/trace.go:171","msg":"trace[456567007] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"160.5656ms","start":"2026-05-09T16:52:06.706Z","end":"2026-05-09T16:52:06.866566Z","steps":["trace[456567007] 'process raft request' (duration: 66.824305ms)","trace[456567007] 'compare' (duration: 93.557443ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:52:06.86693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.706487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/cilium\" ","response":"range_response_count:1 size:14463"} {"level":"info","ts":"2026-05-09T16:52:06.866983Z","caller":"traceutil/trace.go:171","msg":"trace[1909149884] range","detail":"{range_begin:/registry/daemonsets/kube-system/cilium; range_end:; response_count:1; response_revision:464; }","duration":"166.827867ms","start":"2026-05-09T16:52:06.700141Z","end":"2026-05-09T16:52:06.866969Z","steps":["trace[1909149884] 'agreement among raft nodes before linearized reading' (duration: 166.499155ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:06.878271Z","caller":"traceutil/trace.go:171","msg":"trace[1838187848] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"154.464541ms","start":"2026-05-09T16:52:06.723466Z","end":"2026-05-09T16:52:06.87793Z","steps":["trace[1838187848] 'process raft request' (duration: 154.30352ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:06.879064Z","caller":"traceutil/trace.go:171","msg":"trace[1707883944] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"145.716093ms","start":"2026-05-09T16:52:06.732245Z","end":"2026-05-09T16:52:06.877961Z","steps":["trace[1707883944] 'process raft request' (duration: 145.597642ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:06.882031Z","caller":"traceutil/trace.go:171","msg":"trace[1508173249] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"139.797697ms","start":"2026-05-09T16:52:06.742203Z","end":"2026-05-09T16:52:06.882001Z","steps":["trace[1508173249] 'process raft request' (duration: 136.601791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:06.882456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.999556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/cilium-operator-869df985b8\" ","response":"range_response_count:1 size:4309"} {"level":"info","ts":"2026-05-09T16:52:06.882588Z","caller":"traceutil/trace.go:171","msg":"trace[2104740338] range","detail":"{range_begin:/registry/replicasets/kube-system/cilium-operator-869df985b8; range_end:; response_count:1; response_revision:467; }","duration":"159.157118ms","start":"2026-05-09T16:52:06.723395Z","end":"2026-05-09T16:52:06.882552Z","steps":["trace[2104740338] 'agreement among raft nodes before linearized reading' (duration: 158.929136ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:07.063533Z","caller":"traceutil/trace.go:171","msg":"trace[283690769] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"107.161748ms","start":"2026-05-09T16:52:06.956346Z","end":"2026-05-09T16:52:07.063508Z","steps":["trace[283690769] 'process raft request' (duration: 107.098158ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:07.063542Z","caller":"traceutil/trace.go:171","msg":"trace[649109595] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"165.813758ms","start":"2026-05-09T16:52:06.897682Z","end":"2026-05-09T16:52:07.063495Z","steps":["trace[649109595] 'process raft request' (duration: 68.731639ms)","trace[649109595] 'compare' (duration: 96.848698ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:52:07.063703Z","caller":"traceutil/trace.go:171","msg":"trace[1619599848] linearizableReadLoop","detail":"{readStateIndex:488; appliedIndex:487; }","duration":"109.303165ms","start":"2026-05-09T16:52:06.954367Z","end":"2026-05-09T16:52:07.06367Z","steps":["trace[1619599848] 'read index received' (duration: 11.983774ms)","trace[1619599848] 'applied index is now lower than readState.Index' (duration: 97.316331ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:52:07.064077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.691499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-05-09T16:52:07.064127Z","caller":"traceutil/trace.go:171","msg":"trace[2042248797] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:470; }","duration":"109.808289ms","start":"2026-05-09T16:52:06.954304Z","end":"2026-05-09T16:52:07.064112Z","steps":["trace[2042248797] 'agreement among raft nodes before linearized reading' (duration: 109.517367ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:08.898056Z","caller":"traceutil/trace.go:171","msg":"trace[1113448423] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"370.312558ms","start":"2026-05-09T16:52:08.527719Z","end":"2026-05-09T16:52:08.898032Z","steps":["trace[1113448423] 'process raft request' (duration: 370.173996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.898222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.527699Z","time spent":"370.452779ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.907917Z","caller":"traceutil/trace.go:171","msg":"trace[927818883] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"379.785623ms","start":"2026-05-09T16:52:08.528107Z","end":"2026-05-09T16:52:08.907893Z","steps":["trace[927818883] 'process raft request' (duration: 379.652971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.908539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.528098Z","time spent":"379.912394ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.908122Z","caller":"traceutil/trace.go:171","msg":"trace[885455616] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"352.314358ms","start":"2026-05-09T16:52:08.555797Z","end":"2026-05-09T16:52:08.908111Z","steps":["trace[885455616] 'process raft request' (duration: 352.279968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.909715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.555773Z","time spent":"353.85832ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.908001Z","caller":"traceutil/trace.go:171","msg":"trace[241522670] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"378.875555ms","start":"2026-05-09T16:52:08.529074Z","end":"2026-05-09T16:52:08.907949Z","steps":["trace[241522670] 'process raft request' (duration: 378.749185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.910515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.529068Z","time spent":"381.391425ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.911004Z","caller":"traceutil/trace.go:171","msg":"trace[1146751419] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"371.045634ms","start":"2026-05-09T16:52:08.539946Z","end":"2026-05-09T16:52:08.910991Z","steps":["trace[1146751419] 'process raft request' (duration: 367.98262ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:08.911467Z","caller":"traceutil/trace.go:171","msg":"trace[1153839358] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"368.086351ms","start":"2026-05-09T16:52:08.543352Z","end":"2026-05-09T16:52:08.911439Z","steps":["trace[1153839358] 'process raft request' (duration: 364.601804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.911564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.543342Z","time spent":"368.170492ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.911334Z","caller":"traceutil/trace.go:171","msg":"trace[367539233] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"215.727636ms","start":"2026-05-09T16:52:08.694763Z","end":"2026-05-09T16:52:08.910491Z","steps":["trace[367539233] 'process raft request' (duration: 215.261454ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:08.911942Z","caller":"traceutil/trace.go:171","msg":"trace[338364433] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"323.324823ms","start":"2026-05-09T16:52:08.588409Z","end":"2026-05-09T16:52:08.911734Z","steps":["trace[338364433] 'process raft request' (duration: 320.876645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.912019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.588398Z","time spent":"323.582105ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.911993Z","caller":"traceutil/trace.go:171","msg":"trace[584407416] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"366.772121ms","start":"2026-05-09T16:52:08.544953Z","end":"2026-05-09T16:52:08.911725Z","steps":["trace[584407416] 'process raft request' (duration: 363.030683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.912116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.544946Z","time spent":"367.121594ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.912633Z","caller":"traceutil/trace.go:171","msg":"trace[665046671] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"340.082184ms","start":"2026-05-09T16:52:08.571643Z","end":"2026-05-09T16:52:08.911725Z","steps":["trace[665046671] 'process raft request' (duration: 337.395203ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.911562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.539902Z","time spent":"371.567479ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:52:08.912977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.571624Z","time spent":"341.140763ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.913022Z","caller":"traceutil/trace.go:171","msg":"trace[39517782] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"373.15174ms","start":"2026-05-09T16:52:08.539847Z","end":"2026-05-09T16:52:08.912999Z","steps":["trace[39517782] 'process raft request' (duration: 368.037131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.913364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.539823Z","time spent":"373.439182ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:08.918497Z","caller":"traceutil/trace.go:171","msg":"trace[1181552759] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"374.426341ms","start":"2026-05-09T16:52:08.537271Z","end":"2026-05-09T16:52:08.911697Z","steps":["trace[1181552759] 'process raft request' (duration: 370.583852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:08.918628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:08.537252Z","time spent":"381.312614ms","remote":"127.0.0.1:57864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:14.598876Z","caller":"traceutil/trace.go:171","msg":"trace[1121901326] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"122.25973ms","start":"2026-05-09T16:52:14.476591Z","end":"2026-05-09T16:52:14.598851Z","steps":["trace[1121901326] 'read index received' (duration: 120.827289ms)","trace[1121901326] 'applied index is now lower than readState.Index' (duration: 1.431411ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:52:14.599067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.481971ms","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-09T16:52:14.599116Z","caller":"traceutil/trace.go:171","msg":"trace[132262183] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:579; }","duration":"122.585161ms","start":"2026-05-09T16:52:14.476518Z","end":"2026-05-09T16:52:14.599103Z","steps":["trace[132262183] 'agreement among raft nodes before linearized reading' (duration: 122.482521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:14.599236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.495461ms","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":"info","ts":"2026-05-09T16:52:14.5994Z","caller":"traceutil/trace.go:171","msg":"trace[2021919270] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:579; }","duration":"122.710283ms","start":"2026-05-09T16:52:14.476632Z","end":"2026-05-09T16:52:14.599343Z","steps":["trace[2021919270] 'agreement among raft nodes before linearized reading' (duration: 122.449101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:14.599864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.122376ms","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-09T16:52:14.599959Z","caller":"traceutil/trace.go:171","msg":"trace[1116182272] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:579; }","duration":"123.193916ms","start":"2026-05-09T16:52:14.476704Z","end":"2026-05-09T16:52:14.599898Z","steps":["trace[1116182272] 'agreement among raft nodes before linearized reading' (duration: 123.124276ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:14.60041Z","caller":"traceutil/trace.go:171","msg":"trace[1741810527] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"146.409822ms","start":"2026-05-09T16:52:14.453983Z","end":"2026-05-09T16:52:14.600393Z","steps":["trace[1741810527] 'process raft request' (duration: 143.717732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:15.183768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.251031ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-09T16:52:15.183919Z","caller":"traceutil/trace.go:171","msg":"trace[1464739862] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"168.704637ms","start":"2026-05-09T16:52:15.015169Z","end":"2026-05-09T16:52:15.183873Z","steps":["trace[1464739862] 'read index received' (duration: 52.162445ms)","trace[1464739862] 'applied index is now lower than readState.Index' (duration: 116.540922ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:52:15.184015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.829238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:15.184051Z","caller":"traceutil/trace.go:171","msg":"trace[2091952869] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:580; }","duration":"168.891888ms","start":"2026-05-09T16:52:15.01515Z","end":"2026-05-09T16:52:15.184042Z","steps":["trace[2091952869] 'agreement among raft nodes before linearized reading' (duration: 168.819658ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:15.223417Z","caller":"traceutil/trace.go:171","msg":"trace[1010389666] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"114.031213ms","start":"2026-05-09T16:52:15.109362Z","end":"2026-05-09T16:52:15.223394Z","steps":["trace[1010389666] 'process raft request' (duration: 112.030498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:15.224117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.717223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T16:52:15.22414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.753273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:15.224195Z","caller":"traceutil/trace.go:171","msg":"trace[1981038154] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"149.833204ms","start":"2026-05-09T16:52:15.074347Z","end":"2026-05-09T16:52:15.22418Z","steps":["trace[1981038154] 'agreement among raft nodes before linearized reading' (duration: 149.753103ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:15.224195Z","caller":"traceutil/trace.go:171","msg":"trace[704265768] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:581; }","duration":"149.829674ms","start":"2026-05-09T16:52:15.074347Z","end":"2026-05-09T16:52:15.224176Z","steps":["trace[704265768] 'agreement among raft nodes before linearized reading' (duration: 149.709473ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:15.22432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.091404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:15.224377Z","caller":"traceutil/trace.go:171","msg":"trace[1145506680] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:581; }","duration":"209.167834ms","start":"2026-05-09T16:52:15.015194Z","end":"2026-05-09T16:52:15.224362Z","steps":["trace[1145506680] 'agreement among raft nodes before linearized reading' (duration: 209.091873ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:15.229041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.788429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:15.229231Z","caller":"traceutil/trace.go:171","msg":"trace[1490462180] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:581; }","duration":"213.985651ms","start":"2026-05-09T16:52:15.015204Z","end":"2026-05-09T16:52:15.22919Z","steps":["trace[1490462180] 'agreement among raft nodes before linearized reading' (duration: 206.967488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:15.424727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.855739ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T16:52:15.424854Z","caller":"traceutil/trace.go:171","msg":"trace[542603926] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"141.271349ms","start":"2026-05-09T16:52:15.283567Z","end":"2026-05-09T16:52:15.424838Z","steps":["trace[542603926] 'compare' (duration: 135.653317ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:15.787992Z","caller":"traceutil/trace.go:171","msg":"trace[514502107] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"120.109909ms","start":"2026-05-09T16:52:15.667857Z","end":"2026-05-09T16:52:15.787967Z","steps":["trace[514502107] 'read index received' (duration: 119.982268ms)","trace[514502107] 'applied index is now lower than readState.Index' (duration: 126.061µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:52:15.788342Z","caller":"traceutil/trace.go:171","msg":"trace[1169577041] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"123.287864ms","start":"2026-05-09T16:52:15.665009Z","end":"2026-05-09T16:52:15.788297Z","steps":["trace[1169577041] 'process raft request' (duration: 122.765149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:15.789157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.276388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T16:52:15.78922Z","caller":"traceutil/trace.go:171","msg":"trace[1923646589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"121.368338ms","start":"2026-05-09T16:52:15.667837Z","end":"2026-05-09T16:52:15.789205Z","steps":["trace[1923646589] 'agreement among raft nodes before linearized reading' (duration: 120.235009ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:15.990151Z","caller":"traceutil/trace.go:171","msg":"trace[1947997903] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"197.552445ms","start":"2026-05-09T16:52:15.792571Z","end":"2026-05-09T16:52:15.990124Z","steps":["trace[1947997903] 'process raft request' (duration: 181.281772ms)","trace[1947997903] 'compare' (duration: 15.750519ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:52:16.03225Z","caller":"traceutil/trace.go:171","msg":"trace[393979427] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"157.732793ms","start":"2026-05-09T16:52:15.874348Z","end":"2026-05-09T16:52:16.032081Z","steps":["trace[393979427] 'process raft request' (duration: 156.232372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:16.842824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.254839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T16:52:16.842961Z","caller":"traceutil/trace.go:171","msg":"trace[1503388126] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"688.546766ms","start":"2026-05-09T16:52:16.154393Z","end":"2026-05-09T16:52:16.84294Z","steps":["trace[1503388126] 'read index received' (duration: 376.971434ms)","trace[1503388126] 'applied index is now lower than readState.Index' (duration: 311.573722ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:52:16.843088Z","caller":"traceutil/trace.go:171","msg":"trace[704218049] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"731.058397ms","start":"2026-05-09T16:52:16.112012Z","end":"2026-05-09T16:52:16.84307Z","steps":["trace[704218049] 'process raft request' (duration: 419.478926ms)","trace[704218049] 'compare' (duration: 311.097458ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:52:16.843215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:16.111974Z","time spent":"731.203708ms","remote":"127.0.0.1:58062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:52:16.84347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.177732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:16.843784Z","caller":"traceutil/trace.go:171","msg":"trace[1920055097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"689.371532ms","start":"2026-05-09T16:52:16.154181Z","end":"2026-05-09T16:52:16.843553Z","steps":["trace[1920055097] 'agreement among raft nodes before linearized reading' (duration: 689.06157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:16.84388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:16.154152Z","time spent":"689.687195ms","remote":"127.0.0.1:57832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T16:52:16.844086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.543542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-09T16:52:16.844348Z","caller":"traceutil/trace.go:171","msg":"trace[1239911399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"625.872443ms","start":"2026-05-09T16:52:16.218455Z","end":"2026-05-09T16:52:16.844328Z","steps":["trace[1239911399] 'agreement among raft nodes before linearized reading' (duration: 624.965557ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:16.844543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:16.21842Z","time spent":"626.109334ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-09T16:52:17.357094Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872623854064144,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:52:17.410267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:16.985872Z","time spent":"424.386763ms","remote":"127.0.0.1:56294","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-09T16:52:17.416302Z","caller":"traceutil/trace.go:171","msg":"trace[1131681171] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"560.026016ms","start":"2026-05-09T16:52:16.856249Z","end":"2026-05-09T16:52:17.416275Z","steps":["trace[1131681171] 'read index received' (duration: 559.819213ms)","trace[1131681171] 'applied index is now lower than readState.Index' (duration: 205.923µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:52:17.416328Z","caller":"traceutil/trace.go:171","msg":"trace[995935847] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"565.574518ms","start":"2026-05-09T16:52:16.850727Z","end":"2026-05-09T16:52:17.416302Z","steps":["trace[995935847] 'process raft request' (duration: 565.396736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:17.416478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.49903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:17.41652Z","caller":"traceutil/trace.go:171","msg":"trace[774864342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"260.58518ms","start":"2026-05-09T16:52:17.155923Z","end":"2026-05-09T16:52:17.416508Z","steps":["trace[774864342] 'agreement among raft nodes before linearized reading' (duration: 260.481479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:17.416661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:16.850715Z","time spent":"565.77683ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:52:17.416669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.252718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:17.416887Z","caller":"traceutil/trace.go:171","msg":"trace[528784140] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:592; }","duration":"560.566263ms","start":"2026-05-09T16:52:16.856228Z","end":"2026-05-09T16:52:17.416795Z","steps":["trace[528784140] 'agreement among raft nodes before linearized reading' (duration: 560.139847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:17.416887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.997001ms","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-09T16:52:17.417197Z","caller":"traceutil/trace.go:171","msg":"trace[178796784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"170.347135ms","start":"2026-05-09T16:52:17.246824Z","end":"2026-05-09T16:52:17.417172Z","steps":["trace[178796784] 'agreement among raft nodes before linearized reading' (duration: 169.89919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:17.417108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:16.856219Z","time spent":"560.778685ms","remote":"127.0.0.1:57946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-05-09T16:52:18.494678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872623854064147,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-09T16:52:18.863253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.229432268s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-09T16:52:18.863379Z","caller":"traceutil/trace.go:171","msg":"trace[1360411652] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.440139234s","start":"2026-05-09T16:52:17.423223Z","end":"2026-05-09T16:52:18.863363Z","steps":["trace[1360411652] 'process raft request' (duration: 210.510456ms)","trace[1360411652] 'compare' (duration: 1.229293672s)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:52:18.86356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:17.42321Z","time spent":"1.440320963s","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:52:18.924522Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.290782479s","expected-duration":"1s"} {"level":"info","ts":"2026-05-09T16:52:18.925289Z","caller":"traceutil/trace.go:171","msg":"trace[2074551330] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.464656837s","start":"2026-05-09T16:52:17.4606Z","end":"2026-05-09T16:52:18.925257Z","steps":["trace[2074551330] 'process raft request' (duration: 1.464421155s)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:18.925372Z","caller":"traceutil/trace.go:171","msg":"trace[457023920] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:618; }","duration":"931.401999ms","start":"2026-05-09T16:52:17.993949Z","end":"2026-05-09T16:52:18.925351Z","steps":["trace[457023920] 'read index received' (duration: 931.008778ms)","trace[457023920] 'applied index is now lower than readState.Index' (duration: 392.291µs)"],"step_count":2} {"level":"info","ts":"2026-05-09T16:52:18.925478Z","caller":"traceutil/trace.go:171","msg":"trace[919825960] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.464843368s","start":"2026-05-09T16:52:17.460622Z","end":"2026-05-09T16:52:18.925465Z","steps":["trace[919825960] 'process raft request' (duration: 1.464548563s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:18.925567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:17.460601Z","time spent":"1.464913771s","remote":"127.0.0.1:57878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T16:52:18.925568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:17.460578Z","time spent":"1.464779504s","remote":"127.0.0.1:57878","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T16:52:18.925586Z","caller":"traceutil/trace.go:171","msg":"trace[978695218] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.463390823s","start":"2026-05-09T16:52:17.462158Z","end":"2026-05-09T16:52:18.925549Z","steps":["trace[978695218] 'process raft request' (duration: 1.463149069s)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:18.925883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"876.793297ms","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-09T16:52:18.925914Z","caller":"traceutil/trace.go:171","msg":"trace[69591649] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.46376068s","start":"2026-05-09T16:52:17.462137Z","end":"2026-05-09T16:52:18.925898Z","steps":["trace[69591649] 'process raft request' (duration: 1.463097026s)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:52:18.925981Z","caller":"traceutil/trace.go:171","msg":"trace[1728648508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"876.945265ms","start":"2026-05-09T16:52:18.049005Z","end":"2026-05-09T16:52:18.92595Z","steps":["trace[1728648508] 'agreement among raft nodes before linearized reading' (duration: 876.674371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:18.925981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:17.462117Z","time spent":"1.463817382s","remote":"127.0.0.1:57996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:52:18.926048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:18.048977Z","time spent":"877.059211ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-09T16:52:18.926182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.991895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:18.926239Z","caller":"traceutil/trace.go:171","msg":"trace[2077158570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"772.0813ms","start":"2026-05-09T16:52:18.154138Z","end":"2026-05-09T16:52:18.926219Z","steps":["trace[2077158570] 'agreement among raft nodes before linearized reading' (duration: 771.991285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:18.926312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:18.154122Z","time spent":"772.172725ms","remote":"127.0.0.1:57834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T16:52:18.926731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"932.777368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-09T16:52:18.926779Z","caller":"traceutil/trace.go:171","msg":"trace[2026220702] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"932.860831ms","start":"2026-05-09T16:52:17.993906Z","end":"2026-05-09T16:52:18.926767Z","steps":["trace[2026220702] 'agreement among raft nodes before linearized reading' (duration: 932.716273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:18.926757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:17.462116Z","time spent":"1.463850493s","remote":"127.0.0.1:58062","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-09T16:52:18.926809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:17.993886Z","time spent":"932.916524ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-09T16:52:19.951667Z","caller":"traceutil/trace.go:171","msg":"trace[733985166] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"160.733314ms","start":"2026-05-09T16:52:19.790917Z","end":"2026-05-09T16:52:19.95165Z","steps":["trace[733985166] 'process raft request' (duration: 158.805967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:35.448696Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3415872623854064461,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T16:52:35.512815Z","caller":"traceutil/trace.go:171","msg":"trace[518364090] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"632.42547ms","start":"2026-05-09T16:52:34.880356Z","end":"2026-05-09T16:52:35.512782Z","steps":["trace[518364090] 'process raft request' (duration: 631.447689ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:35.513028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:34.880327Z","time spent":"632.582406ms","remote":"127.0.0.1:57996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T16:52:35.518611Z","caller":"traceutil/trace.go:171","msg":"trace[1949015564] linearizableReadLoop","detail":"{readStateIndex:785; appliedIndex:783; }","duration":"570.401238ms","start":"2026-05-09T16:52:34.948176Z","end":"2026-05-09T16:52:35.518577Z","steps":["trace[1949015564] 'read index received' (duration: 564.068682ms)","trace[1949015564] 'applied index is now lower than readState.Index' (duration: 6.330276ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T16:52:35.518956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.748574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-09T16:52:35.519001Z","caller":"traceutil/trace.go:171","msg":"trace[458444942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:756; }","duration":"570.868999ms","start":"2026-05-09T16:52:34.94812Z","end":"2026-05-09T16:52:35.518989Z","steps":["trace[458444942] 'agreement among raft nodes before linearized reading' (duration: 570.64556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:35.51904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:34.948103Z","time spent":"570.928361ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-09T16:52:35.519111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.789902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-09T16:52:35.519223Z","caller":"traceutil/trace.go:171","msg":"trace[642154594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:756; }","duration":"464.945219ms","start":"2026-05-09T16:52:35.054245Z","end":"2026-05-09T16:52:35.51919Z","steps":["trace[642154594] 'agreement among raft nodes before linearized reading' (duration: 464.661668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:35.519277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:35.05422Z","time spent":"465.048133ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-09T16:52:35.519468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.352536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T16:52:35.519511Z","caller":"traceutil/trace.go:171","msg":"trace[1774373588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:756; }","duration":"362.44209ms","start":"2026-05-09T16:52:35.157059Z","end":"2026-05-09T16:52:35.519502Z","steps":["trace[1774373588] 'agreement among raft nodes before linearized reading' (duration: 362.375957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:35.519727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:35.157025Z","time spent":"362.69624ms","remote":"127.0.0.1:57832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-09T16:52:35.51977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.37631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-09T16:52:35.519799Z","caller":"traceutil/trace.go:171","msg":"trace[240831570] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:756; }","duration":"457.442802ms","start":"2026-05-09T16:52:35.062346Z","end":"2026-05-09T16:52:35.519789Z","steps":["trace[240831570] 'agreement among raft nodes before linearized reading' (duration: 457.169951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T16:52:35.519829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T16:52:35.062319Z","time spent":"457.505856ms","remote":"127.0.0.1:58096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-09T16:53:07.879024Z","caller":"traceutil/trace.go:171","msg":"trace[836939822] transaction","detail":"{read_only:false; response_revision:988; number_of_response:1; }","duration":"171.09773ms","start":"2026-05-09T16:53:07.707899Z","end":"2026-05-09T16:53:07.878996Z","steps":["trace[836939822] 'process raft request' (duration: 170.934105ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:53:07.893008Z","caller":"traceutil/trace.go:171","msg":"trace[2072318450] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"184.800612ms","start":"2026-05-09T16:53:07.708185Z","end":"2026-05-09T16:53:07.892986Z","steps":["trace[2072318450] 'process raft request' (duration: 184.621057ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T16:53:07.893004Z","caller":"traceutil/trace.go:171","msg":"trace[710897278] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"184.630336ms","start":"2026-05-09T16:53:07.708342Z","end":"2026-05-09T16:53:07.892972Z","steps":["trace[710897278] 'process raft request' (duration: 184.586285ms)"],"step_count":1}