{"level":"warn","ts":"2026-07-15T04:52:33.096861Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T04:52:33.097026Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.23: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.23:2380","--initial-cluster=instance=https://199.204.45.23:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.23:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.23: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-07-15T04:52:33.097135Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-15T04:52:33.097151Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-07-15T04:52:33.097171Z","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-07-15T04:52:33.097915Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"]} {"level":"info","ts":"2026-07-15T04:52:33.098015Z","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.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.23: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-07-15T04:52:33.102588Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.302732ms"} {"level":"info","ts":"2026-07-15T04:52:33.11087Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"51a5c416a4d98c86","cluster-id":"ade2045974c19907"} {"level":"info","ts":"2026-07-15T04:52:33.11097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=()"} {"level":"info","ts":"2026-07-15T04:52:33.111001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 0"} {"level":"info","ts":"2026-07-15T04:52:33.111012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 51a5c416a4d98c86 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-15T04:52:33.111026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became follower at term 1"} {"level":"info","ts":"2026-07-15T04:52:33.111076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"warn","ts":"2026-07-15T04:52:33.117025Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-15T04:52:33.118606Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-15T04:52:33.119827Z","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-07-15T04:52:33.122275Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"51a5c416a4d98c86","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-15T04:52:33.12347Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"51a5c416a4d98c86","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-15T04:52:33.12354Z","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-07-15T04:52:33.124243Z","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-07-15T04:52:33.124766Z","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-07-15T04:52:33.128094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 switched to configuration voters=(5883324089763466374)"} {"level":"info","ts":"2026-07-15T04:52:33.128264Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","added-peer-id":"51a5c416a4d98c86","added-peer-peer-urls":["https://199.204.45.23:2380"]} {"level":"info","ts":"2026-07-15T04:52:33.129882Z","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-07-15T04:52:33.129979Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-07-15T04:52:33.130044Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.23:2380"} {"level":"info","ts":"2026-07-15T04:52:33.132505Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"51a5c416a4d98c86","initial-advertise-peer-urls":["https://199.204.45.23:2380"],"listen-peer-urls":["https://199.204.45.23:2380"],"advertise-client-urls":["https://199.204.45.23:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.23:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-15T04:52:33.13255Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-15T04:52:33.311518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 is starting a new election at term 1"} {"level":"info","ts":"2026-07-15T04:52:33.311581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-15T04:52:33.311605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgPreVoteResp from 51a5c416a4d98c86 at term 1"} {"level":"info","ts":"2026-07-15T04:52:33.311626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became candidate at term 2"} {"level":"info","ts":"2026-07-15T04:52:33.311639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 received MsgVoteResp from 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-07-15T04:52:33.311679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"51a5c416a4d98c86 became leader at term 2"} {"level":"info","ts":"2026-07-15T04:52:33.311693Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 51a5c416a4d98c86 elected leader 51a5c416a4d98c86 at term 2"} {"level":"info","ts":"2026-07-15T04:52:33.313146Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"51a5c416a4d98c86","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.23:2379]}","request-path":"/0/members/51a5c416a4d98c86/attributes","cluster-id":"ade2045974c19907","publish-timeout":"7s"} {"level":"info","ts":"2026-07-15T04:52:33.313157Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:52:33.313346Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T04:52:33.313375Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-15T04:52:33.315474Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ade2045974c19907","local-member-id":"51a5c416a4d98c86","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:52:33.31569Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:52:33.315858Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-15T04:52:33.317447Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-15T04:52:33.318134Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.23:2379"} {"level":"info","ts":"2026-07-15T04:52:33.31387Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-15T04:52:33.323436Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-07-15T04:52:41.556434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.15835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:52:41.556576Z","caller":"traceutil/trace.go:171","msg":"trace[1987954662] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:288; }","duration":"122.374811ms","start":"2026-07-15T04:52:41.434184Z","end":"2026-07-15T04:52:41.556559Z","steps":["trace[1987954662] 'range keys from in-memory index tree' (duration: 122.07134ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:42.842651Z","caller":"traceutil/trace.go:171","msg":"trace[1321980385] linearizableReadLoop","detail":"{readStateIndex:312; appliedIndex:311; }","duration":"101.400204ms","start":"2026-07-15T04:52:42.741227Z","end":"2026-07-15T04:52:42.842627Z","steps":["trace[1321980385] 'read index received' (duration: 101.241504ms)","trace[1321980385] 'applied index is now lower than readState.Index' (duration: 157.8µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:52:42.842777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.543305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:52:42.842813Z","caller":"traceutil/trace.go:171","msg":"trace[131275002] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:0; response_revision:298; }","duration":"101.654555ms","start":"2026-07-15T04:52:42.741145Z","end":"2026-07-15T04:52:42.8428Z","steps":["trace[131275002] 'agreement among raft nodes before linearized reading' (duration: 101.582305ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:42.842919Z","caller":"traceutil/trace.go:171","msg":"trace[166192977] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"102.46979ms","start":"2026-07-15T04:52:42.740418Z","end":"2026-07-15T04:52:42.842888Z","steps":["trace[166192977] 'process raft request' (duration: 102.107378ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:43.552179Z","caller":"traceutil/trace.go:171","msg":"trace[279124470] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:317; }","duration":"118.234813ms","start":"2026-07-15T04:52:43.433918Z","end":"2026-07-15T04:52:43.552153Z","steps":["trace[279124470] 'read index received' (duration: 103.799543ms)","trace[279124470] 'applied index is now lower than readState.Index' (duration: 14.43408ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:52:43.552303Z","caller":"traceutil/trace.go:171","msg":"trace[59328464] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"119.740452ms","start":"2026-07-15T04:52:43.432539Z","end":"2026-07-15T04:52:43.55228Z","steps":["trace[59328464] 'process raft request' (duration: 105.172211ms)","trace[59328464] 'compare' (duration: 14.205529ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:52:43.552457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.511325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-15T04:52:43.552542Z","caller":"traceutil/trace.go:171","msg":"trace[1060386926] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:304; }","duration":"118.627705ms","start":"2026-07-15T04:52:43.433901Z","end":"2026-07-15T04:52:43.552529Z","steps":["trace[1060386926] 'agreement among raft nodes before linearized reading' (duration: 118.485205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:52:45.566561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.008353ms","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-07-15T04:52:45.566645Z","caller":"traceutil/trace.go:171","msg":"trace[229741881] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:355; }","duration":"212.148944ms","start":"2026-07-15T04:52:45.354476Z","end":"2026-07-15T04:52:45.566625Z","steps":["trace[229741881] 'range keys from in-memory index tree' (duration: 211.903582ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:52:52.104723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.293384ms","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-07-15T04:52:52.104807Z","caller":"traceutil/trace.go:171","msg":"trace[1598344170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:374; }","duration":"266.436636ms","start":"2026-07-15T04:52:51.838349Z","end":"2026-07-15T04:52:52.104786Z","steps":["trace[1598344170] 'range keys from in-memory index tree' (duration: 266.122274ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:58.504828Z","caller":"traceutil/trace.go:171","msg":"trace[1415517305] linearizableReadLoop","detail":"{readStateIndex:407; appliedIndex:406; }","duration":"367.985345ms","start":"2026-07-15T04:52:58.136822Z","end":"2026-07-15T04:52:58.504808Z","steps":["trace[1415517305] 'read index received' (duration: 367.820174ms)","trace[1415517305] 'applied index is now lower than readState.Index' (duration: 164.531µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:52:58.50506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.226267ms","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-07-15T04:52:58.50513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.425022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4368"} {"level":"info","ts":"2026-07-15T04:52:58.505134Z","caller":"traceutil/trace.go:171","msg":"trace[1543691652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:389; }","duration":"368.358288ms","start":"2026-07-15T04:52:58.136761Z","end":"2026-07-15T04:52:58.505119Z","steps":["trace[1543691652] 'agreement among raft nodes before linearized reading' (duration: 368.181506ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:58.505164Z","caller":"traceutil/trace.go:171","msg":"trace[580502400] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:389; }","duration":"175.492723ms","start":"2026-07-15T04:52:58.32966Z","end":"2026-07-15T04:52:58.505152Z","steps":["trace[580502400] 'agreement among raft nodes before linearized reading' (duration: 175.442901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:52:58.505177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:52:58.13674Z","time spent":"368.42423ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-15T04:52:58.505082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.937296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:52:58.505205Z","caller":"traceutil/trace.go:171","msg":"trace[355017024] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"838.973394ms","start":"2026-07-15T04:52:57.66619Z","end":"2026-07-15T04:52:58.505163Z","steps":["trace[355017024] 'process raft request' (duration: 838.503699ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:52:58.505296Z","caller":"traceutil/trace.go:171","msg":"trace[296720747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:389; }","duration":"197.149569ms","start":"2026-07-15T04:52:58.308103Z","end":"2026-07-15T04:52:58.505253Z","steps":["trace[296720747] 'agreement among raft nodes before linearized reading' (duration: 196.938567ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:52:58.505708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:52:57.666174Z","time spent":"839.099864ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:13.959682Z","caller":"traceutil/trace.go:171","msg":"trace[1418616842] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"411.77988ms","start":"2026-07-15T04:53:13.547862Z","end":"2026-07-15T04:53:13.959642Z","steps":["trace[1418616842] 'process raft request' (duration: 407.072379ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:13.959768Z","caller":"traceutil/trace.go:171","msg":"trace[531922087] linearizableReadLoop","detail":"{readStateIndex:547; appliedIndex:546; }","duration":"404.88418ms","start":"2026-07-15T04:53:13.554854Z","end":"2026-07-15T04:53:13.959738Z","steps":["trace[531922087] 'read index received' (duration: 400.085128ms)","trace[531922087] 'applied index is now lower than readState.Index' (duration: 4.796122ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:53:13.959849Z","caller":"traceutil/trace.go:171","msg":"trace[548113647] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"328.388561ms","start":"2026-07-15T04:53:13.631422Z","end":"2026-07-15T04:53:13.95981Z","steps":["trace[548113647] 'process raft request' (duration: 328.303951ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:13.959891Z","caller":"traceutil/trace.go:171","msg":"trace[549348659] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"404.790099ms","start":"2026-07-15T04:53:13.555051Z","end":"2026-07-15T04:53:13.959841Z","steps":["trace[549348659] 'process raft request' (duration: 404.562277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.959992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.106802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:53:13.960019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.107682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:53:13.960042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.631409Z","time spent":"328.555403ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T04:53:13.960094Z","caller":"traceutil/trace.go:171","msg":"trace[1353302779] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:526; }","duration":"405.181952ms","start":"2026-07-15T04:53:13.554883Z","end":"2026-07-15T04:53:13.960065Z","steps":["trace[1353302779] 'agreement among raft nodes before linearized reading' (duration: 405.055611ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.554791Z","time spent":"405.338144ms","remote":"127.0.0.1:32794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T04:53:13.96016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.716012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:53:13.960131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.55503Z","time spent":"404.95183ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:13.960184Z","caller":"traceutil/trace.go:171","msg":"trace[1155498668] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:526; }","duration":"362.749382ms","start":"2026-07-15T04:53:13.597428Z","end":"2026-07-15T04:53:13.960177Z","steps":["trace[1155498668] 'agreement among raft nodes before linearized reading' (duration: 362.708652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.597424Z","time spent":"362.790523ms","remote":"127.0.0.1:32802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-07-15T04:53:13.960261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.370965ms","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-07-15T04:53:13.960326Z","caller":"traceutil/trace.go:171","msg":"trace[150607360] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:526; }","duration":"381.452726ms","start":"2026-07-15T04:53:13.578857Z","end":"2026-07-15T04:53:13.960309Z","steps":["trace[150607360] 'agreement among raft nodes before linearized reading' (duration: 381.351996ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.296675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:53:13.960382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.578853Z","time spent":"381.513017ms","remote":"127.0.0.1:32796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-15T04:53:13.960399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.914052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:13.960449Z","caller":"traceutil/trace.go:171","msg":"trace[414598415] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:526; }","duration":"323.947982ms","start":"2026-07-15T04:53:13.636467Z","end":"2026-07-15T04:53:13.960415Z","steps":["trace[414598415] 'agreement among raft nodes before linearized reading' (duration: 323.911652ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:13.960423Z","caller":"traceutil/trace.go:171","msg":"trace[272244395] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:526; }","duration":"364.358595ms","start":"2026-07-15T04:53:13.596041Z","end":"2026-07-15T04:53:13.9604Z","steps":["trace[272244395] 'agreement among raft nodes before linearized reading' (duration: 364.271285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.627938ms","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-07-15T04:53:13.960529Z","caller":"traceutil/trace.go:171","msg":"trace[1434467993] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:526; }","duration":"381.687428ms","start":"2026-07-15T04:53:13.57883Z","end":"2026-07-15T04:53:13.960518Z","steps":["trace[1434467993] 'agreement among raft nodes before linearized reading' (duration: 381.619958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.596036Z","time spent":"364.470666ms","remote":"127.0.0.1:32802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T04:53:13.960558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.578824Z","time spent":"381.726479ms","remote":"127.0.0.1:32796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T04:53:13.960583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.495018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:13.960629Z","caller":"traceutil/trace.go:171","msg":"trace[1113003888] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:526; }","duration":"324.567588ms","start":"2026-07-15T04:53:13.636052Z","end":"2026-07-15T04:53:13.96062Z","steps":["trace[1113003888] 'agreement among raft nodes before linearized reading' (duration: 324.508718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.636035Z","time spent":"324.613258ms","remote":"127.0.0.1:32828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-07-15T04:53:13.960646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.714959ms","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":"warn","ts":"2026-07-15T04:53:13.96075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.390655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:13.960696Z","caller":"traceutil/trace.go:171","msg":"trace[1708052137] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:526; }","duration":"380.77709ms","start":"2026-07-15T04:53:13.579906Z","end":"2026-07-15T04:53:13.960683Z","steps":["trace[1708052137] 'agreement among raft nodes before linearized reading' (duration: 380.701519ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:13.960793Z","caller":"traceutil/trace.go:171","msg":"trace[1159005254] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:526; }","duration":"405.454425ms","start":"2026-07-15T04:53:13.555327Z","end":"2026-07-15T04:53:13.960782Z","steps":["trace[1159005254] 'agreement among raft nodes before linearized reading' (duration: 405.359085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.555319Z","time spent":"405.500126ms","remote":"127.0.0.1:32794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-07-15T04:53:13.960829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.5799Z","time spent":"380.912151ms","remote":"127.0.0.1:32796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-07-15T04:53:13.960861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.436434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:13.960883Z","caller":"traceutil/trace.go:171","msg":"trace[2135400511] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:526; }","duration":"342.471324ms","start":"2026-07-15T04:53:13.618405Z","end":"2026-07-15T04:53:13.960877Z","steps":["trace[2135400511] 'agreement among raft nodes before linearized reading' (duration: 342.441254ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.618399Z","time spent":"342.499164ms","remote":"127.0.0.1:32818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-07-15T04:53:13.960044Z","caller":"traceutil/trace.go:171","msg":"trace[425592796] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:526; }","duration":"405.189332ms","start":"2026-07-15T04:53:13.554841Z","end":"2026-07-15T04:53:13.960031Z","steps":["trace[425592796] 'agreement among raft nodes before linearized reading' (duration: 405.047101ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.960962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.554837Z","time spent":"406.112991ms","remote":"127.0.0.1:32794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-07-15T04:53:13.960538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.415616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-15T04:53:13.960827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.261273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:13.961179Z","caller":"traceutil/trace.go:171","msg":"trace[2023349878] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:526; }","duration":"325.062173ms","start":"2026-07-15T04:53:13.636102Z","end":"2026-07-15T04:53:13.961164Z","steps":["trace[2023349878] 'agreement among raft nodes before linearized reading' (duration: 324.382077ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:13.961194Z","caller":"traceutil/trace.go:171","msg":"trace[306586607] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:526; }","duration":"342.638836ms","start":"2026-07-15T04:53:13.618548Z","end":"2026-07-15T04:53:13.961187Z","steps":["trace[306586607] 'agreement among raft nodes before linearized reading' (duration: 342.259233ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.96122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.618543Z","time spent":"342.669256ms","remote":"127.0.0.1:32818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-15T04:53:13.961224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.636097Z","time spent":"325.114103ms","remote":"127.0.0.1:32828","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-15T04:53:13.96047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.636462Z","time spent":"324.002584ms","remote":"127.0.0.1:32818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-07-15T04:53:13.961489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.547842Z","time spent":"411.948111ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:53:13.960836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.748509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:13.962156Z","caller":"traceutil/trace.go:171","msg":"trace[476907214] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:526; }","duration":"366.07558ms","start":"2026-07-15T04:53:13.596064Z","end":"2026-07-15T04:53:13.962139Z","steps":["trace[476907214] 'agreement among raft nodes before linearized reading' (duration: 364.728139ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:13.962196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.596061Z","time spent":"366.11894ms","remote":"127.0.0.1:32802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-07-15T04:53:14.362591Z","caller":"traceutil/trace.go:171","msg":"trace[1646725263] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"385.759855ms","start":"2026-07-15T04:53:13.976804Z","end":"2026-07-15T04:53:14.362564Z","steps":["trace[1646725263] 'process raft request' (duration: 385.606973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:14.363292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.976778Z","time spent":"386.32685ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:14.363526Z","caller":"traceutil/trace.go:171","msg":"trace[1753631363] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"391.331784ms","start":"2026-07-15T04:53:13.972161Z","end":"2026-07-15T04:53:14.363493Z","steps":["trace[1753631363] 'process raft request' (duration: 384.081079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:14.363604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:13.972138Z","time spent":"391.431704ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:14.364165Z","caller":"traceutil/trace.go:171","msg":"trace[966460837] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"354.535402ms","start":"2026-07-15T04:53:14.009514Z","end":"2026-07-15T04:53:14.364049Z","steps":["trace[966460837] 'process raft request' (duration: 353.003668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:14.364237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:14.009481Z","time spent":"354.724104ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-15T04:53:14.368837Z","caller":"traceutil/trace.go:171","msg":"trace[1175411723] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"323.448167ms","start":"2026-07-15T04:53:14.045348Z","end":"2026-07-15T04:53:14.368796Z","steps":["trace[1175411723] 'process raft request' (duration: 317.809188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:14.369015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:14.045331Z","time spent":"323.585758ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:53:15.720044Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10125956064547625914,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-15T04:53:16.042584Z","caller":"traceutil/trace.go:171","msg":"trace[1636383648] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"836.740602ms","start":"2026-07-15T04:53:15.205419Z","end":"2026-07-15T04:53:16.04216Z","steps":["trace[1636383648] 'process raft request' (duration: 828.091025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:16.042943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:15.205403Z","time spent":"837.455738ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15664,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:16.047072Z","caller":"traceutil/trace.go:171","msg":"trace[1849948044] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:585; }","duration":"827.359509ms","start":"2026-07-15T04:53:15.219657Z","end":"2026-07-15T04:53:16.047016Z","steps":["trace[1849948044] 'read index received' (duration: 813.947399ms)","trace[1849948044] 'applied index is now lower than readState.Index' (duration: 13.41084ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:53:16.051907Z","caller":"traceutil/trace.go:171","msg":"trace[707373457] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"703.47183ms","start":"2026-07-15T04:53:15.348397Z","end":"2026-07-15T04:53:16.051868Z","steps":["trace[707373457] 'process raft request' (duration: 693.735844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:16.052043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.698698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"warn","ts":"2026-07-15T04:53:16.052088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:15.348373Z","time spent":"703.631501ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:16.052142Z","caller":"traceutil/trace.go:171","msg":"trace[731154644] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:564; }","duration":"832.490644ms","start":"2026-07-15T04:53:15.219627Z","end":"2026-07-15T04:53:16.052118Z","steps":["trace[731154644] 'agreement among raft nodes before linearized reading' (duration: 827.517771ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:16.052202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:15.219613Z","time spent":"832.579915ms","remote":"127.0.0.1:56870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":29593,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-07-15T04:53:19.804157Z","caller":"traceutil/trace.go:171","msg":"trace[196211239] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"165.374236ms","start":"2026-07-15T04:53:19.638761Z","end":"2026-07-15T04:53:19.804136Z","steps":["trace[196211239] 'process raft request' (duration: 165.232245ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:20.178986Z","caller":"traceutil/trace.go:171","msg":"trace[1981544394] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"379.718069ms","start":"2026-07-15T04:53:19.799241Z","end":"2026-07-15T04:53:20.178959Z","steps":["trace[1981544394] 'process raft request' (duration: 375.245269ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:20.179108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:19.799209Z","time spent":"379.840621ms","remote":"127.0.0.1:56912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:23.146453Z","caller":"traceutil/trace.go:171","msg":"trace[556568521] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"498.677037ms","start":"2026-07-15T04:53:22.64775Z","end":"2026-07-15T04:53:23.146427Z","steps":["trace[556568521] 'process raft request' (duration: 498.513195ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:23.146635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:22.647731Z","time spent":"498.824418ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:23.302359Z","caller":"traceutil/trace.go:171","msg":"trace[1885190370] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:633; }","duration":"596.031497ms","start":"2026-07-15T04:53:22.706294Z","end":"2026-07-15T04:53:23.302325Z","steps":["trace[1885190370] 'read index received' (duration: 439.996491ms)","trace[1885190370] 'applied index is now lower than readState.Index' (duration: 156.033396ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:53:23.302468Z","caller":"traceutil/trace.go:171","msg":"trace[1327480327] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"652.607452ms","start":"2026-07-15T04:53:22.649834Z","end":"2026-07-15T04:53:23.302441Z","steps":["trace[1327480327] 'process raft request' (duration: 610.937044ms)","trace[1327480327] 'compare' (duration: 41.368876ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:53:23.302612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:22.649809Z","time spent":"652.725184ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-15T04:53:23.302784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.467942ms","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-07-15T04:53:23.302963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.230677ms","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-07-15T04:53:23.303055Z","caller":"traceutil/trace.go:171","msg":"trace[156578931] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"205.389338ms","start":"2026-07-15T04:53:23.097646Z","end":"2026-07-15T04:53:23.303035Z","steps":["trace[156578931] 'agreement among raft nodes before linearized reading' (duration: 205.205596ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:23.303032Z","caller":"traceutil/trace.go:171","msg":"trace[391207596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:610; }","duration":"596.753875ms","start":"2026-07-15T04:53:22.706255Z","end":"2026-07-15T04:53:23.303009Z","steps":["trace[391207596] 'agreement among raft nodes before linearized reading' (duration: 596.252299ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:23.302965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.725982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nlg9j\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-15T04:53:23.303416Z","caller":"traceutil/trace.go:171","msg":"trace[1477928542] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nlg9j; range_end:; response_count:1; response_revision:610; }","duration":"379.212417ms","start":"2026-07-15T04:53:22.924187Z","end":"2026-07-15T04:53:23.303399Z","steps":["trace[1477928542] 'agreement among raft nodes before linearized reading' (duration: 378.623812ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:23.303564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:22.924146Z","time spent":"379.358698ms","remote":"127.0.0.1:56996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-nlg9j\" "} {"level":"warn","ts":"2026-07-15T04:53:23.303264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:22.706242Z","time spent":"597.005498ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-15T04:53:24.170417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.396465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:53:24.170645Z","caller":"traceutil/trace.go:171","msg":"trace[1120900293] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"859.2991ms","start":"2026-07-15T04:53:23.311327Z","end":"2026-07-15T04:53:24.170626Z","steps":["trace[1120900293] 'process raft request' (duration: 859.188789ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:24.170668Z","caller":"traceutil/trace.go:171","msg":"trace[175343896] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"859.884766ms","start":"2026-07-15T04:53:23.31075Z","end":"2026-07-15T04:53:24.170635Z","steps":["trace[175343896] 'process raft request' (duration: 155.998557ms)","trace[175343896] 'compare' (duration: 703.276234ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:53:24.170722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:23.311314Z","time spent":"859.373751ms","remote":"127.0.0.1:57090","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-07-15T04:53:24.170822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:23.310727Z","time spent":"860.006257ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:24.171097Z","caller":"traceutil/trace.go:171","msg":"trace[692256176] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"849.637951ms","start":"2026-07-15T04:53:23.321447Z","end":"2026-07-15T04:53:24.171085Z","steps":["trace[692256176] 'process raft request' (duration: 849.127176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:24.17117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:23.321438Z","time spent":"849.696342ms","remote":"127.0.0.1:56996","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-15T04:53:24.171228Z","caller":"traceutil/trace.go:171","msg":"trace[1006212409] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"859.690114ms","start":"2026-07-15T04:53:23.311519Z","end":"2026-07-15T04:53:24.171209Z","steps":["trace[1006212409] 'read index received' (duration: 155.205178ms)","trace[1006212409] 'applied index is now lower than readState.Index' (duration: 704.483446ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:53:24.171316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.795525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:24.171353Z","caller":"traceutil/trace.go:171","msg":"trace[437896931] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"859.878747ms","start":"2026-07-15T04:53:23.311462Z","end":"2026-07-15T04:53:24.17134Z","steps":["trace[437896931] 'agreement among raft nodes before linearized reading' (duration: 859.822196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:24.171408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:23.311436Z","time spent":"859.964827ms","remote":"127.0.0.1:56840","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-07-15T04:53:25.904604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.88488ms","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-07-15T04:53:25.904698Z","caller":"traceutil/trace.go:171","msg":"trace[1197676344] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:613; }","duration":"754.009401ms","start":"2026-07-15T04:53:25.150662Z","end":"2026-07-15T04:53:25.904671Z","steps":["trace[1197676344] 'range keys from in-memory index tree' (duration: 753.715639ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:25.904754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:25.150646Z","time spent":"754.093532ms","remote":"127.0.0.1:57090","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-07-15T04:53:25.904777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.652736ms","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-07-15T04:53:25.904838Z","caller":"traceutil/trace.go:171","msg":"trace[1701995520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:613; }","duration":"594.747848ms","start":"2026-07-15T04:53:25.310072Z","end":"2026-07-15T04:53:25.90482Z","steps":["trace[1701995520] 'range keys from in-memory index tree' (duration: 594.496724ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:25.904878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:25.310051Z","time spent":"594.815728ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-15T04:53:25.904871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.976189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:25.904945Z","caller":"traceutil/trace.go:171","msg":"trace[937362126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"597.08972ms","start":"2026-07-15T04:53:25.307838Z","end":"2026-07-15T04:53:25.904928Z","steps":["trace[937362126] 'range keys from in-memory index tree' (duration: 596.912448ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:25.904993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-15T04:53:25.307822Z","time spent":"597.158331ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-15T04:53:28.102332Z","caller":"traceutil/trace.go:171","msg":"trace[26162538] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"158.875562ms","start":"2026-07-15T04:53:27.943439Z","end":"2026-07-15T04:53:28.102314Z","steps":["trace[26162538] 'process raft request' (duration: 158.775161ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:28.106421Z","caller":"traceutil/trace.go:171","msg":"trace[1093674075] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:649; }","duration":"132.4777ms","start":"2026-07-15T04:53:27.973935Z","end":"2026-07-15T04:53:28.106413Z","steps":["trace[1093674075] 'read index received' (duration: 128.32129ms)","trace[1093674075] 'applied index is now lower than readState.Index' (duration: 4.15608ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:53:28.106514Z","caller":"traceutil/trace.go:171","msg":"trace[671400813] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"152.742533ms","start":"2026-07-15T04:53:27.953742Z","end":"2026-07-15T04:53:28.106484Z","steps":["trace[671400813] 'process raft request' (duration: 152.626562ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:28.106597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.662152ms","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-07-15T04:53:28.106615Z","caller":"traceutil/trace.go:171","msg":"trace[2105239805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"132.695082ms","start":"2026-07-15T04:53:27.973915Z","end":"2026-07-15T04:53:28.10661Z","steps":["trace[2105239805] 'agreement among raft nodes before linearized reading' (duration: 132.544211ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:28.106549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.713313ms","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-07-15T04:53:28.106707Z","caller":"traceutil/trace.go:171","msg":"trace[1098077570] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"130.891104ms","start":"2026-07-15T04:53:27.975788Z","end":"2026-07-15T04:53:28.106679Z","steps":["trace[1098077570] 'agreement among raft nodes before linearized reading' (duration: 130.690052ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:28.439437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.24253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:53:28.43949Z","caller":"traceutil/trace.go:171","msg":"trace[1563739214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"131.343671ms","start":"2026-07-15T04:53:28.308134Z","end":"2026-07-15T04:53:28.439478Z","steps":["trace[1563739214] 'range keys from in-memory index tree' (duration: 131.1695ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:29.100512Z","caller":"traceutil/trace.go:171","msg":"trace[2096702500] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"140.995318ms","start":"2026-07-15T04:53:28.959471Z","end":"2026-07-15T04:53:29.100466Z","steps":["trace[2096702500] 'read index received' (duration: 140.913607ms)","trace[2096702500] 'applied index is now lower than readState.Index' (duration: 80.661µs)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:53:29.100532Z","caller":"traceutil/trace.go:171","msg":"trace[1654042013] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"145.052967ms","start":"2026-07-15T04:53:28.955451Z","end":"2026-07-15T04:53:29.100504Z","steps":["trace[1654042013] 'process raft request' (duration: 144.838525ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:29.10091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.25231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nlg9j\" ","response":"range_response_count:1 size:17520"} {"level":"info","ts":"2026-07-15T04:53:29.100984Z","caller":"traceutil/trace.go:171","msg":"trace[1525995399] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nlg9j; range_end:; response_count:1; response_revision:645; }","duration":"141.509573ms","start":"2026-07-15T04:53:28.95946Z","end":"2026-07-15T04:53:29.10097Z","steps":["trace[1525995399] 'agreement among raft nodes before linearized reading' (duration: 141.086879ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:38.869262Z","caller":"traceutil/trace.go:171","msg":"trace[720099897] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"141.381284ms","start":"2026-07-15T04:53:38.727847Z","end":"2026-07-15T04:53:38.869229Z","steps":["trace[720099897] 'process raft request' (duration: 141.168962ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:42.362372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.104594ms","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-07-15T04:53:42.362504Z","caller":"traceutil/trace.go:171","msg":"trace[1614628563] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:772; }","duration":"181.327037ms","start":"2026-07-15T04:53:42.181152Z","end":"2026-07-15T04:53:42.362479Z","steps":["trace[1614628563] 'range keys from in-memory index tree' (duration: 180.804411ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:42.362562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.706487ms","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-07-15T04:53:42.362665Z","caller":"traceutil/trace.go:171","msg":"trace[725234280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:772; }","duration":"165.891038ms","start":"2026-07-15T04:53:42.196751Z","end":"2026-07-15T04:53:42.362642Z","steps":["trace[725234280] 'range keys from in-memory index tree' (duration: 165.259512ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:53:42.365315Z","caller":"traceutil/trace.go:171","msg":"trace[1518318982] linearizableReadLoop","detail":"{readStateIndex:803; appliedIndex:802; }","duration":"106.255849ms","start":"2026-07-15T04:53:42.25904Z","end":"2026-07-15T04:53:42.365296Z","steps":["trace[1518318982] 'read index received' (duration: 101.110877ms)","trace[1518318982] 'applied index is now lower than readState.Index' (duration: 5.143631ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:53:42.365554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.464801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-15T04:53:42.365595Z","caller":"traceutil/trace.go:171","msg":"trace[1763157941] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:772; }","duration":"106.577601ms","start":"2026-07-15T04:53:42.259006Z","end":"2026-07-15T04:53:42.365584Z","steps":["trace[1763157941] 'agreement among raft nodes before linearized reading' (duration: 106.40413ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:53:42.366375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.180427ms","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-07-15T04:53:42.366429Z","caller":"traceutil/trace.go:171","msg":"trace[1619134736] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:772; }","duration":"107.27814ms","start":"2026-07-15T04:53:42.259138Z","end":"2026-07-15T04:53:42.366416Z","steps":["trace[1619134736] 'agreement among raft nodes before linearized reading' (duration: 107.134198ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:54:18.739141Z","caller":"traceutil/trace.go:171","msg":"trace[271931843] linearizableReadLoop","detail":"{readStateIndex:1062; appliedIndex:1061; }","duration":"106.077015ms","start":"2026-07-15T04:54:18.633037Z","end":"2026-07-15T04:54:18.739114Z","steps":["trace[271931843] 'read index received' (duration: 105.900673ms)","trace[271931843] 'applied index is now lower than readState.Index' (duration: 174.962µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:54:18.739444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.394039ms","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-07-15T04:54:18.739493Z","caller":"traceutil/trace.go:171","msg":"trace[1887851071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1023; }","duration":"106.51116ms","start":"2026-07-15T04:54:18.63297Z","end":"2026-07-15T04:54:18.739481Z","steps":["trace[1887851071] 'agreement among raft nodes before linearized reading' (duration: 106.311958ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:54:18.739251Z","caller":"traceutil/trace.go:171","msg":"trace[2028602058] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"161.0516ms","start":"2026-07-15T04:54:18.578161Z","end":"2026-07-15T04:54:18.739213Z","steps":["trace[2028602058] 'process raft request' (duration: 160.764277ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:54:18.739598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.850201ms","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-07-15T04:54:18.739652Z","caller":"traceutil/trace.go:171","msg":"trace[42143035] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1023; }","duration":"104.925952ms","start":"2026-07-15T04:54:18.634714Z","end":"2026-07-15T04:54:18.73964Z","steps":["trace[42143035] 'agreement among raft nodes before linearized reading' (duration: 104.79836ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:54:18.739818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.053613ms","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-07-15T04:54:18.739859Z","caller":"traceutil/trace.go:171","msg":"trace[1622107744] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1023; }","duration":"105.095314ms","start":"2026-07-15T04:54:18.634755Z","end":"2026-07-15T04:54:18.73985Z","steps":["trace[1622107744] 'agreement among raft nodes before linearized reading' (duration: 105.004883ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:54:18.848162Z","caller":"traceutil/trace.go:171","msg":"trace[1290854235] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"103.205142ms","start":"2026-07-15T04:54:18.744927Z","end":"2026-07-15T04:54:18.848132Z","steps":["trace[1290854235] 'process raft request' (duration: 54.965915ms)","trace[1290854235] 'compare' (duration: 48.080016ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:54:18.848348Z","caller":"traceutil/trace.go:171","msg":"trace[1428799921] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"102.742447ms","start":"2026-07-15T04:54:18.745585Z","end":"2026-07-15T04:54:18.848327Z","steps":["trace[1428799921] 'process raft request' (duration: 102.507775ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:54:19.480474Z","caller":"traceutil/trace.go:171","msg":"trace[134566465] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1066; }","duration":"169.681221ms","start":"2026-07-15T04:54:19.31077Z","end":"2026-07-15T04:54:19.480451Z","steps":["trace[134566465] 'read index received' (duration: 169.530669ms)","trace[134566465] 'applied index is now lower than readState.Index' (duration: 149.392µs)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:54:19.480615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.829944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:54:19.480643Z","caller":"traceutil/trace.go:171","msg":"trace[2120824997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1028; }","duration":"169.918565ms","start":"2026-07-15T04:54:19.310717Z","end":"2026-07-15T04:54:19.480636Z","steps":["trace[2120824997] 'agreement among raft nodes before linearized reading' (duration: 169.824853ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:54:19.480895Z","caller":"traceutil/trace.go:171","msg":"trace[1916137971] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"170.575382ms","start":"2026-07-15T04:54:19.310312Z","end":"2026-07-15T04:54:19.480887Z","steps":["trace[1916137971] 'process raft request' (duration: 170.001564ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:54:47.774159Z","caller":"traceutil/trace.go:171","msg":"trace[403023785] transaction","detail":"{read_only:false; response_revision:1120; number_of_response:1; }","duration":"121.626568ms","start":"2026-07-15T04:54:47.652512Z","end":"2026-07-15T04:54:47.774139Z","steps":["trace[403023785] 'process raft request' (duration: 121.507606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:23.570569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.939726ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-15T04:55:23.570666Z","caller":"traceutil/trace.go:171","msg":"trace[1519617023] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1293; }","duration":"164.293712ms","start":"2026-07-15T04:55:23.406358Z","end":"2026-07-15T04:55:23.570652Z","steps":["trace[1519617023] 'read index received' (duration: 44.134963ms)","trace[1519617023] 'applied index is now lower than readState.Index' (duration: 120.157759ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:55:23.570812Z","caller":"traceutil/trace.go:171","msg":"trace[1349192546] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"164.906378ms","start":"2026-07-15T04:55:23.405888Z","end":"2026-07-15T04:55:23.570794Z","steps":["trace[1349192546] 'process raft request' (duration: 44.669789ms)","trace[1349192546] 'compare' (duration: 119.861275ms)"],"step_count":2} {"level":"warn","ts":"2026-07-15T04:55:23.570986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.611255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:1490"} {"level":"info","ts":"2026-07-15T04:55:23.571105Z","caller":"traceutil/trace.go:171","msg":"trace[1351666158] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1241; }","duration":"164.739647ms","start":"2026-07-15T04:55:23.406341Z","end":"2026-07-15T04:55:23.571081Z","steps":["trace[1351666158] 'agreement among raft nodes before linearized reading' (duration: 164.397663ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:43.476089Z","caller":"traceutil/trace.go:171","msg":"trace[898795135] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1402; }","duration":"138.876219ms","start":"2026-07-15T04:55:43.337184Z","end":"2026-07-15T04:55:43.47606Z","steps":["trace[898795135] 'read index received' (duration: 131.607038ms)","trace[898795135] 'applied index is now lower than readState.Index' (duration: 7.267821ms)"],"step_count":2} {"level":"info","ts":"2026-07-15T04:55:43.47618Z","caller":"traceutil/trace.go:171","msg":"trace[1301548622] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"151.011969ms","start":"2026-07-15T04:55:43.325134Z","end":"2026-07-15T04:55:43.476146Z","steps":["trace[1301548622] 'process raft request' (duration: 143.787129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:43.476272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.074981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:daemon-set-controller\" ","response":"range_response_count:1 size:958"} {"level":"info","ts":"2026-07-15T04:55:43.476373Z","caller":"traceutil/trace.go:171","msg":"trace[250176956] range","detail":"{range_begin:/registry/clusterroles/system:controller:daemon-set-controller; range_end:; response_count:1; response_revision:1345; }","duration":"139.244173ms","start":"2026-07-15T04:55:43.337116Z","end":"2026-07-15T04:55:43.47636Z","steps":["trace[250176956] 'agreement among raft nodes before linearized reading' (duration: 139.082371ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:43.486975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.660865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:deployment-controller\" ","response":"range_response_count:1 size:913"} {"level":"info","ts":"2026-07-15T04:55:43.487056Z","caller":"traceutil/trace.go:171","msg":"trace[608530705] range","detail":"{range_begin:/registry/clusterroles/system:controller:deployment-controller; range_end:; response_count:1; response_revision:1346; }","duration":"117.800526ms","start":"2026-07-15T04:55:43.369231Z","end":"2026-07-15T04:55:43.487032Z","steps":["trace[608530705] 'agreement among raft nodes before linearized reading' (duration: 117.656514ms)"],"step_count":1} {"level":"warn","ts":"2026-07-15T04:55:43.487224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.933342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-15T04:55:43.487283Z","caller":"traceutil/trace.go:171","msg":"trace[1284601662] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1346; }","duration":"112.008784ms","start":"2026-07-15T04:55:43.375252Z","end":"2026-07-15T04:55:43.487261Z","steps":["trace[1284601662] 'agreement among raft nodes before linearized reading' (duration: 111.924662ms)"],"step_count":1} {"level":"info","ts":"2026-07-15T04:55:59.635701Z","caller":"traceutil/trace.go:171","msg":"trace[1123610284] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"143.955093ms","start":"2026-07-15T04:55:59.491703Z","end":"2026-07-15T04:55:59.635658Z","steps":["trace[1123610284] 'process raft request' (duration: 143.181824ms)"],"step_count":1}