{"level":"warn","ts":"2026-07-02T05:06:35.521423Z","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-02T05:06:35.521685Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-02T05:06:35.521761Z","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-02T05:06:35.521771Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-07-02T05:06:35.521791Z","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-02T05:06:35.523352Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-07-02T05:06:35.523443Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-02T05:06:35.52801Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.152354ms"} {"level":"info","ts":"2026-07-02T05:06:35.536701Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-07-02T05:06:35.536894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T05:06:35.537539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-07-02T05:06:35.537628Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T05:06:35.537698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-07-02T05:06:35.53786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-07-02T05:06:35.543885Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T05:06:35.54527Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T05:06:35.546591Z","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-02T05:06:35.549004Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T05:06:35.549218Z","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-02T05:06:35.549324Z","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-02T05:06:35.54938Z","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-02T05:06:35.549597Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T05:06:35.550574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-07-02T05:06:35.55115Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-07-02T05:06:35.554084Z","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-02T05:06:35.554384Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T05:06:35.554455Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T05:06:35.554622Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-07-02T05:06:35.554686Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-07-02T05:06:36.438395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T05:06:36.438499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T05:06:36.438529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-07-02T05:06:36.438554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-07-02T05:06:36.438567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-07-02T05:06:36.438585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-07-02T05:06:36.438608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-07-02T05:06:36.510673Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:06:36.5127Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:06:36.51281Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T05:06:36.512839Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T05:06:36.512908Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T05:06:36.513319Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T05:06:36.513402Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T05:06:36.513407Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:06:36.513582Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T05:06:36.517178Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-07-02T05:06:36.517962Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-02T05:06:45.66539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.119701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:06:45.665634Z","caller":"traceutil/trace.go:171","msg":"trace[1026432430] linearizableReadLoop","detail":"{readStateIndex:358; appliedIndex:357; }","duration":"573.042913ms","start":"2026-07-02T05:06:45.092569Z","end":"2026-07-02T05:06:45.665612Z","steps":["trace[1026432430] 'read index received' (duration: 56.911995ms)","trace[1026432430] 'applied index is now lower than readState.Index' (duration: 516.129268ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:45.665845Z","caller":"traceutil/trace.go:171","msg":"trace[1530518011] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"600.469759ms","start":"2026-07-02T05:06:45.065295Z","end":"2026-07-02T05:06:45.665765Z","steps":["trace[1530518011] 'process raft request' (duration: 84.238901ms)","trace[1530518011] 'compare' (duration: 514.98278ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:45.666471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.220877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-07-02T05:06:45.666536Z","caller":"traceutil/trace.go:171","msg":"trace[193731952] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:348; }","duration":"524.309147ms","start":"2026-07-02T05:06:45.142201Z","end":"2026-07-02T05:06:45.66651Z","steps":["trace[193731952] 'agreement among raft nodes before linearized reading' (duration: 524.215657ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:45.666599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.142155Z","time spent":"524.435508ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"warn","ts":"2026-07-02T05:06:45.666546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.065277Z","time spent":"601.163993ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:06:45.666691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.453986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-07-02T05:06:45.666786Z","caller":"traceutil/trace.go:171","msg":"trace[309498863] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:348; }","duration":"324.676128ms","start":"2026-07-02T05:06:45.342088Z","end":"2026-07-02T05:06:45.666764Z","steps":["trace[309498863] 'agreement among raft nodes before linearized reading' (duration: 324.357006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:45.666763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.345139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-07-02T05:06:45.66594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.314874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-07-02T05:06:45.666886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.342076Z","time spent":"324.791618ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"info","ts":"2026-07-02T05:06:45.666946Z","caller":"traceutil/trace.go:171","msg":"trace[30010721] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:348; }","duration":"224.560831ms","start":"2026-07-02T05:06:45.442368Z","end":"2026-07-02T05:06:45.666929Z","steps":["trace[30010721] 'agreement among raft nodes before linearized reading' (duration: 224.304549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:45.666963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.836202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-07-02T05:06:45.666967Z","caller":"traceutil/trace.go:171","msg":"trace[1486519204] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:348; }","duration":"574.424551ms","start":"2026-07-02T05:06:45.092522Z","end":"2026-07-02T05:06:45.666947Z","steps":["trace[1486519204] 'agreement among raft nodes before linearized reading' (duration: 573.217513ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:45.667005Z","caller":"traceutil/trace.go:171","msg":"trace[169999151] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:348; }","duration":"374.875042ms","start":"2026-07-02T05:06:45.292117Z","end":"2026-07-02T05:06:45.666992Z","steps":["trace[169999151] 'agreement among raft nodes before linearized reading' (duration: 374.806412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:45.667023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.092505Z","time spent":"574.503611ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-07-02T05:06:45.667047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.292069Z","time spent":"374.971262ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-07-02T05:06:45.667223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.514022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-07-02T05:06:45.667244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.059516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-07-02T05:06:45.667272Z","caller":"traceutil/trace.go:171","msg":"trace[662521459] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:348; }","duration":"275.099267ms","start":"2026-07-02T05:06:45.392164Z","end":"2026-07-02T05:06:45.667263Z","steps":["trace[662521459] 'agreement among raft nodes before linearized reading' (duration: 275.043116ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:45.667342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.014848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-02T05:06:45.667329Z","caller":"traceutil/trace.go:171","msg":"trace[452739558] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:348; }","duration":"424.553903ms","start":"2026-07-02T05:06:45.2427Z","end":"2026-07-02T05:06:45.667254Z","steps":["trace[452739558] 'agreement among raft nodes before linearized reading' (duration: 424.486602ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:45.66738Z","caller":"traceutil/trace.go:171","msg":"trace[968248505] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:348; }","duration":"475.084928ms","start":"2026-07-02T05:06:45.192282Z","end":"2026-07-02T05:06:45.667367Z","steps":["trace[968248505] 'agreement among raft nodes before linearized reading' (duration: 474.999648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:45.667411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.242656Z","time spent":"424.746014ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-07-02T05:06:45.667414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.192263Z","time spent":"475.14312ms","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-07-02T05:06:46.401529Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289350439,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:06:46.901747Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289350439,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:06:47.075727Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.401001913s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T05:06:48.560565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.484574011s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:06:48.560681Z","caller":"traceutil/trace.go:171","msg":"trace[336088771] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"2.886026577s","start":"2026-07-02T05:06:45.674635Z","end":"2026-07-02T05:06:48.560662Z","steps":["trace[336088771] 'process raft request' (duration: 1.401288885s)","trace[336088771] 'compare' (duration: 1.478953792s)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:48.560737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.674615Z","time spent":"2.886095998s","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:06:49.499067Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.423063902s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T05:06:49.630416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.240036ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:06:49.630708Z","caller":"traceutil/trace.go:171","msg":"trace[1744486771] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"3.955745406s","start":"2026-07-02T05:06:45.674925Z","end":"2026-07-02T05:06:49.630671Z","steps":["trace[1744486771] 'process raft request' (duration: 3.825184806s)","trace[1744486771] 'compare' (duration: 130.045805ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:49.630687Z","caller":"traceutil/trace.go:171","msg":"trace[415664471] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"3.954730779s","start":"2026-07-02T05:06:45.675914Z","end":"2026-07-02T05:06:49.630644Z","steps":["trace[415664471] 'process raft request' (duration: 3.954591648s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.630784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.674918Z","time spent":"3.955838636s","remote":"127.0.0.1:38072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:06:49.630814Z","caller":"traceutil/trace.go:171","msg":"trace[2050880067] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"3.952520047s","start":"2026-07-02T05:06:45.678253Z","end":"2026-07-02T05:06:49.630773Z","steps":["trace[2050880067] 'process raft request' (duration: 3.952298894s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.630947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.678232Z","time spent":"3.952652318s","remote":"127.0.0.1:37932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:06:49.631066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.675906Z","time spent":"3.954887831s","remote":"127.0.0.1:38160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:06:49.63155Z","caller":"traceutil/trace.go:171","msg":"trace[969911554] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"3.95258475s","start":"2026-07-02T05:06:45.678944Z","end":"2026-07-02T05:06:49.631529Z","steps":["trace[969911554] 'process raft request' (duration: 3.951642231s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.631644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.678938Z","time spent":"3.95265436s","remote":"127.0.0.1:38038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4354,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:06:49.631731Z","caller":"traceutil/trace.go:171","msg":"trace[367293262] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"3.944041059s","start":"2026-07-02T05:06:45.687664Z","end":"2026-07-02T05:06:49.631705Z","steps":["trace[367293262] 'process raft request' (duration: 3.943720035s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.631957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.687654Z","time spent":"3.94421886s","remote":"127.0.0.1:37958","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:06:49.632056Z","caller":"traceutil/trace.go:171","msg":"trace[927553371] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"3.944346702s","start":"2026-07-02T05:06:45.687691Z","end":"2026-07-02T05:06:49.632038Z","steps":["trace[927553371] 'process raft request' (duration: 3.943966048s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.632197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.687607Z","time spent":"3.944549753s","remote":"127.0.0.1:38138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1247,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:06:49.632291Z","caller":"traceutil/trace.go:171","msg":"trace[2143409929] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"1.37893513s","start":"2026-07-02T05:06:48.253335Z","end":"2026-07-02T05:06:49.632271Z","steps":["trace[2143409929] 'process raft request' (duration: 1.378872699s)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:49.63231Z","caller":"traceutil/trace.go:171","msg":"trace[972823509] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"3.943380306s","start":"2026-07-02T05:06:45.688904Z","end":"2026-07-02T05:06:49.632284Z","steps":["trace[972823509] 'process raft request' (duration: 3.942959112s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.632589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:48.253304Z","time spent":"1.379039932s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:06:49.632626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.688896Z","time spent":"3.943688569s","remote":"127.0.0.1:38378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:06:49.632801Z","caller":"traceutil/trace.go:171","msg":"trace[960500920] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"3.943588549s","start":"2026-07-02T05:06:45.689196Z","end":"2026-07-02T05:06:49.632785Z","steps":["trace[960500920] 'process raft request' (duration: 3.942946523s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.632886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.68919Z","time spent":"3.9436477s","remote":"127.0.0.1:38382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:06:49.633069Z","caller":"traceutil/trace.go:171","msg":"trace[26442849] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:358; }","duration":"3.73242107s","start":"2026-07-02T05:06:45.900612Z","end":"2026-07-02T05:06:49.633033Z","steps":["trace[26442849] 'read index received' (duration: 1.175306035s)","trace[26442849] 'applied index is now lower than readState.Index' (duration: 2.557113925s)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:06:49.633347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.732733304s","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-02T05:06:49.633383Z","caller":"traceutil/trace.go:171","msg":"trace[549706906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:358; }","duration":"3.732811085s","start":"2026-07-02T05:06:45.900562Z","end":"2026-07-02T05:06:49.633373Z","steps":["trace[549706906] 'agreement among raft nodes before linearized reading' (duration: 3.732737244s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.633667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:45.90054Z","time spent":"3.732871815s","remote":"127.0.0.1:38150","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-02T05:06:49.63368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.412756849s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-02T05:06:49.633742Z","caller":"traceutil/trace.go:171","msg":"trace[1229360757] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:358; }","duration":"3.41286726s","start":"2026-07-02T05:06:46.220857Z","end":"2026-07-02T05:06:49.633725Z","steps":["trace[1229360757] 'agreement among raft nodes before linearized reading' (duration: 3.412726029s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.633775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:46.220836Z","time spent":"3.41293238s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-02T05:06:49.633911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.51854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-07-02T05:06:49.633943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.246377379s","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-02T05:06:49.633946Z","caller":"traceutil/trace.go:171","msg":"trace[70051824] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:358; }","duration":"100.58029ms","start":"2026-07-02T05:06:49.533356Z","end":"2026-07-02T05:06:49.633936Z","steps":["trace[70051824] 'agreement among raft nodes before linearized reading' (duration: 100.518909ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:49.633966Z","caller":"traceutil/trace.go:171","msg":"trace[664139309] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:358; }","duration":"3.246431709s","start":"2026-07-02T05:06:46.387527Z","end":"2026-07-02T05:06:49.633959Z","steps":["trace[664139309] 'agreement among raft nodes before linearized reading' (duration: 3.246390769s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.63388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.624538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4322"} {"level":"warn","ts":"2026-07-02T05:06:49.633985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:46.387509Z","time spent":"3.246470929s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T05:06:49.634046Z","caller":"traceutil/trace.go:171","msg":"trace[1786211613] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:358; }","duration":"867.79327ms","start":"2026-07-02T05:06:48.766201Z","end":"2026-07-02T05:06:49.633994Z","steps":["trace[1786211613] 'agreement among raft nodes before linearized reading' (duration: 867.615308ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.63414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:48.766142Z","time spent":"867.985471ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4345,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-07-02T05:06:49.634552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.390516966s","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-02T05:06:49.6346Z","caller":"traceutil/trace.go:171","msg":"trace[613428899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:358; }","duration":"3.390599987s","start":"2026-07-02T05:06:46.243989Z","end":"2026-07-02T05:06:49.634589Z","steps":["trace[613428899] 'agreement among raft nodes before linearized reading' (duration: 3.390519197s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:49.634631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:06:46.243967Z","time spent":"3.390656258s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-02T05:06:51.784374Z","caller":"traceutil/trace.go:171","msg":"trace[901288086] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"127.794792ms","start":"2026-07-02T05:06:51.656548Z","end":"2026-07-02T05:06:51.784343Z","steps":["trace[901288086] 'process raft request' (duration: 127.559589ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:51.788953Z","caller":"traceutil/trace.go:171","msg":"trace[401748222] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"128.380757ms","start":"2026-07-02T05:06:51.660541Z","end":"2026-07-02T05:06:51.788922Z","steps":["trace[401748222] 'process raft request' (duration: 128.284146ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:51.789059Z","caller":"traceutil/trace.go:171","msg":"trace[232760518] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:412; }","duration":"112.896182ms","start":"2026-07-02T05:06:51.676156Z","end":"2026-07-02T05:06:51.789052Z","steps":["trace[232760518] 'read index received' (duration: 108.011667ms)","trace[232760518] 'applied index is now lower than readState.Index' (duration: 4.883265ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:51.788974Z","caller":"traceutil/trace.go:171","msg":"trace[1827752308] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"132.202291ms","start":"2026-07-02T05:06:51.656742Z","end":"2026-07-02T05:06:51.788945Z","steps":["trace[1827752308] 'process raft request' (duration: 131.943958ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:51.789405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.224845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:06:51.789427Z","caller":"traceutil/trace.go:171","msg":"trace[2051414344] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"125.169511ms","start":"2026-07-02T05:06:51.664234Z","end":"2026-07-02T05:06:51.789404Z","steps":["trace[2051414344] 'process raft request' (duration: 124.643575ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:51.78947Z","caller":"traceutil/trace.go:171","msg":"trace[263399680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:404; }","duration":"113.349867ms","start":"2026-07-02T05:06:51.676103Z","end":"2026-07-02T05:06:51.789453Z","steps":["trace[263399680] 'agreement among raft nodes before linearized reading' (duration: 113.149695ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:58.038747Z","caller":"traceutil/trace.go:171","msg":"trace[482322697] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"219.510436ms","start":"2026-07-02T05:06:57.819216Z","end":"2026-07-02T05:06:58.038727Z","steps":["trace[482322697] 'process raft request' (duration: 219.363703ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:58.039572Z","caller":"traceutil/trace.go:171","msg":"trace[946230549] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:426; }","duration":"219.575087ms","start":"2026-07-02T05:06:57.819373Z","end":"2026-07-02T05:06:58.038948Z","steps":["trace[946230549] 'read index received' (duration: 70.313217ms)","trace[946230549] 'applied index is now lower than readState.Index' (duration: 149.254919ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:06:58.039627Z","caller":"traceutil/trace.go:171","msg":"trace[120090227] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"219.704709ms","start":"2026-07-02T05:06:57.819853Z","end":"2026-07-02T05:06:58.039558Z","steps":["trace[120090227] 'process raft request' (duration: 218.842774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:06:58.039729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.333049ms","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-02T05:06:58.039821Z","caller":"traceutil/trace.go:171","msg":"trace[599296310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:416; }","duration":"220.436441ms","start":"2026-07-02T05:06:57.819358Z","end":"2026-07-02T05:06:58.039795Z","steps":["trace[599296310] 'agreement among raft nodes before linearized reading' (duration: 220.291258ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:06:58.166037Z","caller":"traceutil/trace.go:171","msg":"trace[789216662] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"121.07704ms","start":"2026-07-02T05:06:58.044933Z","end":"2026-07-02T05:06:58.16601Z","steps":["trace[789216662] 'process raft request' (duration: 120.226236ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:00.049389Z","caller":"traceutil/trace.go:171","msg":"trace[1027774766] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"154.141297ms","start":"2026-07-02T05:06:59.895222Z","end":"2026-07-02T05:07:00.049363Z","steps":["trace[1027774766] 'process raft request' (duration: 60.192525ms)","trace[1027774766] 'compare' (duration: 93.758689ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:16.286928Z","caller":"traceutil/trace.go:171","msg":"trace[869296624] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"107.272624ms","start":"2026-07-02T05:07:16.17962Z","end":"2026-07-02T05:07:16.286893Z","steps":["trace[869296624] 'process raft request' (duration: 61.900319ms)","trace[869296624] 'compare' (duration: 45.229821ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:18.135268Z","caller":"traceutil/trace.go:171","msg":"trace[950587263] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"699.859977ms","start":"2026-07-02T05:07:17.435381Z","end":"2026-07-02T05:07:18.135241Z","steps":["trace[950587263] 'process raft request' (duration: 699.598479ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:18.135409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:17.435355Z","time spent":"699.987981ms","remote":"127.0.0.1:37948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":317296,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:07:18.367667Z","caller":"traceutil/trace.go:171","msg":"trace[1932544404] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"174.962176ms","start":"2026-07-02T05:07:18.19268Z","end":"2026-07-02T05:07:18.367643Z","steps":["trace[1932544404] 'process raft request' (duration: 84.111322ms)","trace[1932544404] 'compare' (duration: 90.478593ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:18.367773Z","caller":"traceutil/trace.go:171","msg":"trace[1120973822] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"174.946735ms","start":"2026-07-02T05:07:18.192809Z","end":"2026-07-02T05:07:18.367756Z","steps":["trace[1120973822] 'process raft request' (duration: 174.645836ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:18.583616Z","caller":"traceutil/trace.go:171","msg":"trace[1517848419] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"134.388344ms","start":"2026-07-02T05:07:18.449207Z","end":"2026-07-02T05:07:18.583595Z","steps":["trace[1517848419] 'process raft request' (duration: 81.620658ms)","trace[1517848419] 'compare' (duration: 52.673093ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:18.756748Z","caller":"traceutil/trace.go:171","msg":"trace[2081760096] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"163.543345ms","start":"2026-07-02T05:07:18.593181Z","end":"2026-07-02T05:07:18.756724Z","steps":["trace[2081760096] 'process raft request' (duration: 121.049636ms)","trace[2081760096] 'compare' (duration: 42.356345ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:18.762963Z","caller":"traceutil/trace.go:171","msg":"trace[909251064] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"129.073505ms","start":"2026-07-02T05:07:18.633865Z","end":"2026-07-02T05:07:18.762939Z","steps":["trace[909251064] 'process raft request' (duration: 128.716914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:19.061851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.348896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:07:19.062099Z","caller":"traceutil/trace.go:171","msg":"trace[1231862805] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:528; }","duration":"221.583358ms","start":"2026-07-02T05:07:18.840496Z","end":"2026-07-02T05:07:19.062079Z","steps":["trace[1231862805] 'read index received' (duration: 109.81948ms)","trace[1231862805] 'applied index is now lower than readState.Index' (duration: 111.762988ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:19.062271Z","caller":"traceutil/trace.go:171","msg":"trace[106505631] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"294.62ms","start":"2026-07-02T05:07:18.767623Z","end":"2026-07-02T05:07:19.062243Z","steps":["trace[106505631] 'process raft request' (duration: 182.744758ms)","trace[106505631] 'compare' (duration: 111.182281ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:19.06243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.934149ms","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-07-02T05:07:19.062469Z","caller":"traceutil/trace.go:171","msg":"trace[1227182998] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:513; }","duration":"221.97301ms","start":"2026-07-02T05:07:18.840481Z","end":"2026-07-02T05:07:19.062454Z","steps":["trace[1227182998] 'agreement among raft nodes before linearized reading' (duration: 221.658451ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.062523Z","caller":"traceutil/trace.go:171","msg":"trace[2018347724] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"293.786865ms","start":"2026-07-02T05:07:18.768704Z","end":"2026-07-02T05:07:19.062491Z","steps":["trace[2018347724] 'process raft request' (duration: 293.26867ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.062665Z","caller":"traceutil/trace.go:171","msg":"trace[618338102] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"292.121685ms","start":"2026-07-02T05:07:18.770529Z","end":"2026-07-02T05:07:19.06265Z","steps":["trace[618338102] 'process raft request' (duration: 291.511217ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.233224Z","caller":"traceutil/trace.go:171","msg":"trace[499173022] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"163.996247ms","start":"2026-07-02T05:07:19.069208Z","end":"2026-07-02T05:07:19.233204Z","steps":["trace[499173022] 'process raft request' (duration: 112.537832ms)","trace[499173022] 'compare' (duration: 51.314271ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:19.233639Z","caller":"traceutil/trace.go:171","msg":"trace[1376311975] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"161.559813ms","start":"2026-07-02T05:07:19.072071Z","end":"2026-07-02T05:07:19.233631Z","steps":["trace[1376311975] 'process raft request' (duration: 161.422799ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.23375Z","caller":"traceutil/trace.go:171","msg":"trace[1381151034] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"163.460841ms","start":"2026-07-02T05:07:19.070281Z","end":"2026-07-02T05:07:19.233741Z","steps":["trace[1381151034] 'process raft request' (duration: 163.08941ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.23371Z","caller":"traceutil/trace.go:171","msg":"trace[1691252697] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"114.828322ms","start":"2026-07-02T05:07:19.118853Z","end":"2026-07-02T05:07:19.233681Z","steps":["trace[1691252697] 'process raft request' (duration: 114.77919ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.233756Z","caller":"traceutil/trace.go:171","msg":"trace[708667011] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"142.06081ms","start":"2026-07-02T05:07:19.091642Z","end":"2026-07-02T05:07:19.233703Z","steps":["trace[708667011] 'process raft request' (duration: 141.924456ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.233748Z","caller":"traceutil/trace.go:171","msg":"trace[1511168577] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:531; }","duration":"163.012957ms","start":"2026-07-02T05:07:19.070699Z","end":"2026-07-02T05:07:19.233712Z","steps":["trace[1511168577] 'read index received' (duration: 43.190793ms)","trace[1511168577] 'applied index is now lower than readState.Index' (duration: 119.819374ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:19.233978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.262675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-07-02T05:07:19.234034Z","caller":"traceutil/trace.go:171","msg":"trace[1823078799] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:520; }","duration":"163.362578ms","start":"2026-07-02T05:07:19.070654Z","end":"2026-07-02T05:07:19.234016Z","steps":["trace[1823078799] 'agreement among raft nodes before linearized reading' (duration: 163.152641ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:19.23404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.415329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c6dfq\" ","response":"range_response_count:1 size:15076"} {"level":"info","ts":"2026-07-02T05:07:19.234116Z","caller":"traceutil/trace.go:171","msg":"trace[657766257] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c6dfq; range_end:; response_count:1; response_revision:520; }","duration":"113.543473ms","start":"2026-07-02T05:07:19.120559Z","end":"2026-07-02T05:07:19.234102Z","steps":["trace[657766257] 'agreement among raft nodes before linearized reading' (duration: 113.42746ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.234467Z","caller":"traceutil/trace.go:171","msg":"trace[1322863885] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"164.39753ms","start":"2026-07-02T05:07:19.069993Z","end":"2026-07-02T05:07:19.234391Z","steps":["trace[1322863885] 'process raft request' (duration: 163.171403ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.398234Z","caller":"traceutil/trace.go:171","msg":"trace[285922016] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:539; }","duration":"128.023844ms","start":"2026-07-02T05:07:19.270192Z","end":"2026-07-02T05:07:19.398216Z","steps":["trace[285922016] 'read index received' (duration: 43.892155ms)","trace[285922016] 'applied index is now lower than readState.Index' (duration: 84.130989ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:19.398488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.271211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-07-02T05:07:19.39857Z","caller":"traceutil/trace.go:171","msg":"trace[261037032] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:524; }","duration":"128.415426ms","start":"2026-07-02T05:07:19.270133Z","end":"2026-07-02T05:07:19.398549Z","steps":["trace[261037032] 'agreement among raft nodes before linearized reading' (duration: 128.170379ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:19.398926Z","caller":"traceutil/trace.go:171","msg":"trace[877179056] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"148.707412ms","start":"2026-07-02T05:07:19.249557Z","end":"2026-07-02T05:07:19.398264Z","steps":["trace[877179056] 'process raft request' (duration: 148.129935ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:20.437658Z","caller":"traceutil/trace.go:171","msg":"trace[583120216] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"211.326211ms","start":"2026-07-02T05:07:20.226312Z","end":"2026-07-02T05:07:20.437638Z","steps":["trace[583120216] 'process raft request' (duration: 211.195517ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:20.477707Z","caller":"traceutil/trace.go:171","msg":"trace[258799904] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:548; }","duration":"174.000985ms","start":"2026-07-02T05:07:20.303687Z","end":"2026-07-02T05:07:20.477688Z","steps":["trace[258799904] 'read index received' (duration: 133.845933ms)","trace[258799904] 'applied index is now lower than readState.Index' (duration: 40.154122ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:20.477952Z","caller":"traceutil/trace.go:171","msg":"trace[1071137042] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"229.807002ms","start":"2026-07-02T05:07:20.248138Z","end":"2026-07-02T05:07:20.477945Z","steps":["trace[1071137042] 'process raft request' (duration: 229.450231ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:20.478103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.433598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:20.478134Z","caller":"traceutil/trace.go:171","msg":"trace[169091835] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:531; }","duration":"174.515841ms","start":"2026-07-02T05:07:20.303611Z","end":"2026-07-02T05:07:20.478127Z","steps":["trace[169091835] 'agreement among raft nodes before linearized reading' (duration: 174.454969ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:20.478274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.845937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-02T05:07:20.478293Z","caller":"traceutil/trace.go:171","msg":"trace[371395420] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:531; }","duration":"106.900609ms","start":"2026-07-02T05:07:20.371386Z","end":"2026-07-02T05:07:20.478287Z","steps":["trace[371395420] 'agreement among raft nodes before linearized reading' (duration: 106.863608ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:21.695108Z","caller":"traceutil/trace.go:171","msg":"trace[1539041879] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"905.112748ms","start":"2026-07-02T05:07:20.789957Z","end":"2026-07-02T05:07:21.69507Z","steps":["trace[1539041879] 'process raft request' (duration: 904.85435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:21.695313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.789935Z","time spent":"905.280443ms","remote":"127.0.0.1:37908","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-07-02T05:07:21.706157Z","caller":"traceutil/trace.go:171","msg":"trace[675687941] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"901.266175ms","start":"2026-07-02T05:07:20.804854Z","end":"2026-07-02T05:07:21.70612Z","steps":["trace[675687941] 'process raft request' (duration: 900.832391ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:21.706264Z","caller":"traceutil/trace.go:171","msg":"trace[984279869] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"885.416865ms","start":"2026-07-02T05:07:20.82082Z","end":"2026-07-02T05:07:21.706237Z","steps":["trace[984279869] 'process raft request' (duration: 885.047893ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:21.706296Z","caller":"traceutil/trace.go:171","msg":"trace[741563241] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"866.703855ms","start":"2026-07-02T05:07:20.839521Z","end":"2026-07-02T05:07:21.706225Z","steps":["trace[741563241] 'process raft request' (duration: 866.386395ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:21.706208Z","caller":"traceutil/trace.go:171","msg":"trace[1252817622] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"912.073789ms","start":"2026-07-02T05:07:20.794083Z","end":"2026-07-02T05:07:21.706156Z","steps":["trace[1252817622] 'process raft request' (duration: 911.494641ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:21.7064Z","caller":"traceutil/trace.go:171","msg":"trace[2115959413] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"902.544755ms","start":"2026-07-02T05:07:20.803845Z","end":"2026-07-02T05:07:21.70639Z","steps":["trace[2115959413] 'process raft request' (duration: 901.76566ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:21.706437Z","caller":"traceutil/trace.go:171","msg":"trace[1590107512] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"753.412109ms","start":"2026-07-02T05:07:20.953016Z","end":"2026-07-02T05:07:21.706428Z","steps":["trace[1590107512] 'process raft request' (duration: 752.943124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:21.706468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.952985Z","time spent":"753.471301ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:07:21.70647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.803792Z","time spent":"902.639278ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:07:21.706492Z","caller":"traceutil/trace.go:171","msg":"trace[285592082] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"899.292884ms","start":"2026-07-02T05:07:20.807179Z","end":"2026-07-02T05:07:21.706472Z","steps":["trace[285592082] 'process raft request' (duration: 898.53959ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:21.706416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.820806Z","time spent":"885.528948ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:07:21.70658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.807169Z","time spent":"899.378736ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:07:21.706572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.794073Z","time spent":"912.323457ms","remote":"127.0.0.1:37908","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-07-02T05:07:21.706709Z","caller":"traceutil/trace.go:171","msg":"trace[283329007] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"896.145537ms","start":"2026-07-02T05:07:20.810552Z","end":"2026-07-02T05:07:21.706697Z","steps":["trace[283329007] 'process raft request' (duration: 895.252169ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:21.706688Z","caller":"traceutil/trace.go:171","msg":"trace[809809544] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"902.738571ms","start":"2026-07-02T05:07:20.803924Z","end":"2026-07-02T05:07:21.706663Z","steps":["trace[809809544] 'process raft request' (duration: 901.725719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:21.706403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.839497Z","time spent":"866.8562ms","remote":"127.0.0.1:37908","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-07-02T05:07:21.706752Z","caller":"traceutil/trace.go:171","msg":"trace[1022592084] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"894.468325ms","start":"2026-07-02T05:07:20.812271Z","end":"2026-07-02T05:07:21.706739Z","steps":["trace[1022592084] 'process raft request' (duration: 893.561186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:21.706766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.810542Z","time spent":"896.198939ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:07:21.706797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.803917Z","time spent":"902.838424ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:07:21.706818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.812261Z","time spent":"894.528467ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:07:21.706353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.804835Z","time spent":"901.43941ms","remote":"127.0.0.1:37908","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-07-02T05:07:21.706855Z","caller":"traceutil/trace.go:171","msg":"trace[2029443544] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"914.225087ms","start":"2026-07-02T05:07:20.792484Z","end":"2026-07-02T05:07:21.706709Z","steps":["trace[2029443544] 'process raft request' (duration: 913.004718ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:21.707058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:20.792471Z","time spent":"914.523706ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:07:22.433383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.003556ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:07:22.433452Z","caller":"traceutil/trace.go:171","msg":"trace[1806052512] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"598.929216ms","start":"2026-07-02T05:07:21.834512Z","end":"2026-07-02T05:07:22.433441Z","steps":["trace[1806052512] 'process raft request' (duration: 385.807566ms)","trace[1806052512] 'compare' (duration: 212.851792ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:22.4337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:21.834481Z","time spent":"599.197654ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:22.515932Z","caller":"traceutil/trace.go:171","msg":"trace[946742936] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"673.191706ms","start":"2026-07-02T05:07:21.842721Z","end":"2026-07-02T05:07:22.515912Z","steps":["trace[946742936] 'process raft request' (duration: 673.035291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:22.516055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:21.842701Z","time spent":"673.29532ms","remote":"127.0.0.1:37908","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-02T05:07:22.516569Z","caller":"traceutil/trace.go:171","msg":"trace[1998483643] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"672.01768ms","start":"2026-07-02T05:07:21.844529Z","end":"2026-07-02T05:07:22.516546Z","steps":["trace[1998483643] 'process raft request' (duration: 671.334788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:22.516711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:21.844517Z","time spent":"672.121544ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:22.516892Z","caller":"traceutil/trace.go:171","msg":"trace[150426886] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"667.469367ms","start":"2026-07-02T05:07:21.849413Z","end":"2026-07-02T05:07:22.516882Z","steps":["trace[150426886] 'process raft request' (duration: 666.666082ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:22.516945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:21.8494Z","time spent":"667.514808ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:22.517016Z","caller":"traceutil/trace.go:171","msg":"trace[1444714867] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"624.273387ms","start":"2026-07-02T05:07:21.892735Z","end":"2026-07-02T05:07:22.517008Z","steps":["trace[1444714867] 'process raft request' (duration: 623.705549ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:22.517054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:21.892704Z","time spent":"624.332359ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:07:22.51749Z","caller":"traceutil/trace.go:171","msg":"trace[61025721] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"475.520506ms","start":"2026-07-02T05:07:22.041948Z","end":"2026-07-02T05:07:22.517469Z","steps":["trace[61025721] 'process raft request' (duration: 474.547345ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:22.517596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:22.04193Z","time spent":"475.609639ms","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:07:22.676143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.679614ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:07:22.676535Z","caller":"traceutil/trace.go:171","msg":"trace[589887272] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"153.891084ms","start":"2026-07-02T05:07:22.522609Z","end":"2026-07-02T05:07:22.6765Z","steps":["trace[589887272] 'process raft request' (duration: 11.801527ms)","trace[589887272] 'compare' (duration: 141.56148ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:22.676603Z","caller":"traceutil/trace.go:171","msg":"trace[986377574] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"151.388725ms","start":"2026-07-02T05:07:22.525196Z","end":"2026-07-02T05:07:22.676584Z","steps":["trace[986377574] 'process raft request' (duration: 151.027253ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:22.676728Z","caller":"traceutil/trace.go:171","msg":"trace[1482320857] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"148.225343ms","start":"2026-07-02T05:07:22.528465Z","end":"2026-07-02T05:07:22.67669Z","steps":["trace[1482320857] 'process raft request' (duration: 147.986665ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:22.676792Z","caller":"traceutil/trace.go:171","msg":"trace[1757398451] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"146.487688ms","start":"2026-07-02T05:07:22.530296Z","end":"2026-07-02T05:07:22.676784Z","steps":["trace[1757398451] 'process raft request' (duration: 146.254201ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:22.677395Z","caller":"traceutil/trace.go:171","msg":"trace[1061180027] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"146.339103ms","start":"2026-07-02T05:07:22.53041Z","end":"2026-07-02T05:07:22.676749Z","steps":["trace[1061180027] 'process raft request' (duration: 146.279401ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:22.776061Z","caller":"traceutil/trace.go:171","msg":"trace[1726187497] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"234.904087ms","start":"2026-07-02T05:07:22.541133Z","end":"2026-07-02T05:07:22.776038Z","steps":["trace[1726187497] 'process raft request' (duration: 234.66978ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:22.776225Z","caller":"traceutil/trace.go:171","msg":"trace[1313680515] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"195.33273ms","start":"2026-07-02T05:07:22.580863Z","end":"2026-07-02T05:07:22.776196Z","steps":["trace[1313680515] 'process raft request' (duration: 195.126384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:24.016511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036188519s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:07:24.016601Z","caller":"traceutil/trace.go:171","msg":"trace[1453786818] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"1.239154904s","start":"2026-07-02T05:07:22.777431Z","end":"2026-07-02T05:07:24.016586Z","steps":["trace[1453786818] 'read index received' (duration: 202.796709ms)","trace[1453786818] 'applied index is now lower than readState.Index' (duration: 1.036357225s)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:24.016666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.239222726s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:24.016691Z","caller":"traceutil/trace.go:171","msg":"trace[138430004] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"1.239278308s","start":"2026-07-02T05:07:22.777404Z","end":"2026-07-02T05:07:24.016682Z","steps":["trace[138430004] 'agreement among raft nodes before linearized reading' (duration: 1.239224566s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:24.016721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:22.777391Z","time spent":"1.239324s","remote":"127.0.0.1:37858","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-02T05:07:24.016926Z","caller":"traceutil/trace.go:171","msg":"trace[593397501] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.325999394s","start":"2026-07-02T05:07:22.690914Z","end":"2026-07-02T05:07:24.016913Z","steps":["trace[593397501] 'process raft request' (duration: 289.335759ms)","trace[593397501] 'compare' (duration: 1.035787276s)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:24.016984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:22.690885Z","time spent":"1.326067746s","remote":"127.0.0.1:37908","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-02T05:07:24.057006Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.076819201s","expected-duration":"1s"} {"level":"info","ts":"2026-07-02T05:07:24.057791Z","caller":"traceutil/trace.go:171","msg":"trace[31044611] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"1.267463562s","start":"2026-07-02T05:07:22.790286Z","end":"2026-07-02T05:07:24.057749Z","steps":["trace[31044611] 'process raft request' (duration: 1.267143842s)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:24.057902Z","caller":"traceutil/trace.go:171","msg":"trace[1334349822] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.21145052s","start":"2026-07-02T05:07:22.846422Z","end":"2026-07-02T05:07:24.057872Z","steps":["trace[1334349822] 'process raft request' (duration: 1.211250724s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:24.057978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:22.790266Z","time spent":"1.267613187s","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:07:24.058054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:22.846394Z","time spent":"1.211593025s","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:07:24.32322Z","caller":"traceutil/trace.go:171","msg":"trace[578494443] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"215.000189ms","start":"2026-07-02T05:07:24.108192Z","end":"2026-07-02T05:07:24.323192Z","steps":["trace[578494443] 'process raft request' (duration: 214.916256ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:24.323281Z","caller":"traceutil/trace.go:171","msg":"trace[762456701] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"222.576048ms","start":"2026-07-02T05:07:24.100645Z","end":"2026-07-02T05:07:24.323221Z","steps":["trace[762456701] 'process raft request' (duration: 169.696462ms)","trace[762456701] 'compare' (duration: 52.575336ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:25.118499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.341901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-07-02T05:07:25.11864Z","caller":"traceutil/trace.go:171","msg":"trace[490970235] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:615; }","duration":"111.518977ms","start":"2026-07-02T05:07:25.007096Z","end":"2026-07-02T05:07:25.118615Z","steps":["trace[490970235] 'range keys from in-memory index tree' (duration: 111.156666ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:29.095469Z","caller":"traceutil/trace.go:171","msg":"trace[1149883951] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"346.062489ms","start":"2026-07-02T05:07:28.749382Z","end":"2026-07-02T05:07:29.095445Z","steps":["trace[1149883951] 'process raft request' (duration: 345.921864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:29.095624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:28.749368Z","time spent":"346.176583ms","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:29.390904Z","caller":"traceutil/trace.go:171","msg":"trace[1278478352] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"639.801995ms","start":"2026-07-02T05:07:28.751073Z","end":"2026-07-02T05:07:29.390875Z","steps":["trace[1278478352] 'process raft request' (duration: 637.640449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:29.391054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:28.751052Z","time spent":"639.92531ms","remote":"127.0.0.1:38150","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-02T05:07:29.391314Z","caller":"traceutil/trace.go:171","msg":"trace[1088827045] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:664; }","duration":"135.153698ms","start":"2026-07-02T05:07:29.256135Z","end":"2026-07-02T05:07:29.391289Z","steps":["trace[1088827045] 'read index received' (duration: 132.484293ms)","trace[1088827045] 'applied index is now lower than readState.Index' (duration: 2.668375ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:29.392187Z","caller":"traceutil/trace.go:171","msg":"trace[300038376] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"639.104732ms","start":"2026-07-02T05:07:28.753062Z","end":"2026-07-02T05:07:29.392167Z","steps":["trace[300038376] 'process raft request' (duration: 637.586128ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:29.392275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:28.753048Z","time spent":"639.185694ms","remote":"127.0.0.1:38150","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-07-02T05:07:29.392299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.124342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c6dfq\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-02T05:07:29.392385Z","caller":"traceutil/trace.go:171","msg":"trace[1433721598] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c6dfq; range_end:; response_count:1; response_revision:640; }","duration":"136.279028ms","start":"2026-07-02T05:07:29.256087Z","end":"2026-07-02T05:07:29.392366Z","steps":["trace[1433721598] 'agreement among raft nodes before linearized reading' (duration: 135.287103ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:29.392914Z","caller":"traceutil/trace.go:171","msg":"trace[771569824] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"449.984281ms","start":"2026-07-02T05:07:28.942066Z","end":"2026-07-02T05:07:29.39205Z","steps":["trace[771569824] 'process raft request' (duration: 448.809129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:29.393026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:28.94204Z","time spent":"450.916753ms","remote":"127.0.0.1:37948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036233,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:07:30.036168Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289350985,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T05:07:30.326592Z","caller":"traceutil/trace.go:171","msg":"trace[1852712134] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"917.964464ms","start":"2026-07-02T05:07:29.408599Z","end":"2026-07-02T05:07:30.326563Z","steps":["trace[1852712134] 'process raft request' (duration: 917.798078ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:30.327203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:29.408576Z","time spent":"918.475553ms","remote":"127.0.0.1:38054","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-02T05:07:30.403481Z","caller":"traceutil/trace.go:171","msg":"trace[1563782464] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:667; }","duration":"867.687718ms","start":"2026-07-02T05:07:29.53577Z","end":"2026-07-02T05:07:30.403458Z","steps":["trace[1563782464] 'read index received' (duration: 790.53301ms)","trace[1563782464] 'applied index is now lower than readState.Index' (duration: 77.153508ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:30.403771Z","caller":"traceutil/trace.go:171","msg":"trace[869957439] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"958.6158ms","start":"2026-07-02T05:07:29.445144Z","end":"2026-07-02T05:07:30.40376Z","steps":["trace[869957439] 'process raft request' (duration: 958.214016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:30.40385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:29.44512Z","time spent":"958.680503ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T05:07:30.40405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"868.27725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-02T05:07:30.404077Z","caller":"traceutil/trace.go:171","msg":"trace[174546460] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:642; }","duration":"868.356502ms","start":"2026-07-02T05:07:29.535714Z","end":"2026-07-02T05:07:30.40407Z","steps":["trace[174546460] 'agreement among raft nodes before linearized reading' (duration: 868.256849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:30.404096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:29.535686Z","time spent":"868.406304ms","remote":"127.0.0.1:37896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"warn","ts":"2026-07-02T05:07:30.404195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.185418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:30.404214Z","caller":"traceutil/trace.go:171","msg":"trace[1114314878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"728.204968ms","start":"2026-07-02T05:07:29.676004Z","end":"2026-07-02T05:07:30.404209Z","steps":["trace[1114314878] 'agreement among raft nodes before linearized reading' (duration: 728.177087ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:30.404229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:29.675926Z","time spent":"728.300492ms","remote":"127.0.0.1:37854","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-02T05:07:30.522147Z","caller":"traceutil/trace.go:171","msg":"trace[1015825953] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:669; }","duration":"106.829833ms","start":"2026-07-02T05:07:30.415293Z","end":"2026-07-02T05:07:30.522123Z","steps":["trace[1015825953] 'read index received' (duration: 23.776453ms)","trace[1015825953] 'applied index is now lower than readState.Index' (duration: 83.05182ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:30.522292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.978958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:30.522521Z","caller":"traceutil/trace.go:171","msg":"trace[1087550886] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:642; }","duration":"107.05171ms","start":"2026-07-02T05:07:30.415262Z","end":"2026-07-02T05:07:30.522314Z","steps":["trace[1087550886] 'agreement among raft nodes before linearized reading' (duration: 106.980018ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:31.177368Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289350993,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:31.678522Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289350993,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:32.179585Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289350993,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:32.676532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000137305s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-02T05:07:32.676652Z","caller":"traceutil/trace.go:171","msg":"trace[1868424200] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000307022s","start":"2026-07-02T05:07:30.676318Z","end":"2026-07-02T05:07:32.676625Z","steps":["trace[1868424200] 'agreement among raft nodes before linearized reading' (duration: 2.000175337s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:32.676725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:30.676292Z","time spent":"2.000417776s","remote":"127.0.0.1:37854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/02 05:07:32 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-02T05:07:32.679713Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289350993,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:33.180678Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289350993,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:33.509769Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.98629468s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-02T05:07:33.660943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.870356ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:07:33.661123Z","caller":"traceutil/trace.go:171","msg":"trace[944783882] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"3.137657233s","start":"2026-07-02T05:07:30.52338Z","end":"2026-07-02T05:07:33.661038Z","steps":["trace[944783882] 'process raft request' (duration: 2.986616022s)","trace[944783882] 'compare' (duration: 150.435529ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:33.661292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:30.523358Z","time spent":"3.137865301s","remote":"127.0.0.1:37896","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:33.860062Z","caller":"traceutil/trace.go:171","msg":"trace[423199100] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"3.058875242s","start":"2026-07-02T05:07:30.801164Z","end":"2026-07-02T05:07:33.86004Z","steps":["trace[423199100] 'process raft request' (duration: 3.050653466s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.860239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:30.801144Z","time spent":"3.058973135s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:33.860737Z","caller":"traceutil/trace.go:171","msg":"trace[1892179135] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:670; }","duration":"3.184357336s","start":"2026-07-02T05:07:30.676368Z","end":"2026-07-02T05:07:33.860725Z","steps":["trace[1892179135] 'read index received' (duration: 2.833610022s)","trace[1892179135] 'applied index is now lower than readState.Index' (duration: 350.746694ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:33.860832Z","caller":"traceutil/trace.go:171","msg":"trace[744426247] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"2.916301188s","start":"2026-07-02T05:07:30.944476Z","end":"2026-07-02T05:07:33.860777Z","steps":["trace[744426247] 'process raft request' (duration: 2.915568161s)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:33.860948Z","caller":"traceutil/trace.go:171","msg":"trace[1774257262] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"1.14176988s","start":"2026-07-02T05:07:32.719117Z","end":"2026-07-02T05:07:33.860887Z","steps":["trace[1774257262] 'process raft request' (duration: 1.141574603s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.861065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.109986378s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-02T05:07:33.861072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:30.944444Z","time spent":"2.916503405s","remote":"127.0.0.1:37948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036269,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:07:33.861115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.469422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:33.861154Z","caller":"traceutil/trace.go:171","msg":"trace[132517302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:646; }","duration":"3.110155334s","start":"2026-07-02T05:07:30.750956Z","end":"2026-07-02T05:07:33.861112Z","steps":["trace[132517302] 'agreement among raft nodes before linearized reading' (duration: 3.109899985s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.861184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.453711187s","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-02T05:07:33.861236Z","caller":"traceutil/trace.go:171","msg":"trace[1939958679] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:646; }","duration":"2.453792289s","start":"2026-07-02T05:07:31.407426Z","end":"2026-07-02T05:07:33.861219Z","steps":["trace[1939958679] 'agreement among raft nodes before linearized reading' (duration: 2.453694856s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.861248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:30.750933Z","time spent":"3.110304809s","remote":"127.0.0.1:38150","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-02T05:07:33.861087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.620855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-07-02T05:07:33.861458Z","caller":"traceutil/trace.go:171","msg":"trace[1669544500] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:646; }","duration":"197.991179ms","start":"2026-07-02T05:07:33.663456Z","end":"2026-07-02T05:07:33.861448Z","steps":["trace[1669544500] 'agreement among raft nodes before linearized reading' (duration: 197.588864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.861277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:31.407405Z","time spent":"2.453864632s","remote":"127.0.0.1:38150","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-02T05:07:33.861082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.464418196s","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-02T05:07:33.861604Z","caller":"traceutil/trace.go:171","msg":"trace[844367376] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:646; }","duration":"2.465005807s","start":"2026-07-02T05:07:31.396588Z","end":"2026-07-02T05:07:33.861594Z","steps":["trace[844367376] 'agreement among raft nodes before linearized reading' (duration: 2.464319042s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.861663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:31.396562Z","time spent":"2.46508147s","remote":"127.0.0.1:38150","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-02T05:07:33.861137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:32.719099Z","time spent":"1.141950356s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:33.861156Z","caller":"traceutil/trace.go:171","msg":"trace[1880906840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"591.521354ms","start":"2026-07-02T05:07:33.269615Z","end":"2026-07-02T05:07:33.861136Z","steps":["trace[1880906840] 'agreement among raft nodes before linearized reading' (duration: 591.487023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.862093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:33.269599Z","time spent":"592.483821ms","remote":"127.0.0.1:37854","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-02T05:07:33.860979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183811705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:33.862317Z","caller":"traceutil/trace.go:171","msg":"trace[1658454505] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"1.185206558s","start":"2026-07-02T05:07:32.677098Z","end":"2026-07-02T05:07:33.862304Z","steps":["trace[1658454505] 'agreement among raft nodes before linearized reading' (duration: 1.183794635s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.861295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.761592213s","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-02T05:07:33.862407Z","caller":"traceutil/trace.go:171","msg":"trace[1473898307] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:646; }","duration":"2.762733596s","start":"2026-07-02T05:07:31.099656Z","end":"2026-07-02T05:07:33.862389Z","steps":["trace[1473898307] 'agreement among raft nodes before linearized reading' (duration: 2.761531061s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:33.862434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:32.676886Z","time spent":"1.185490918s","remote":"127.0.0.1:37858","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-02T05:07:33.862463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:31.099637Z","time spent":"2.762811718s","remote":"127.0.0.1:38150","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":"info","ts":"2026-07-02T05:07:34.660716Z","caller":"traceutil/trace.go:171","msg":"trace[497711561] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"217.450467ms","start":"2026-07-02T05:07:34.443249Z","end":"2026-07-02T05:07:34.660699Z","steps":["trace[497711561] 'process raft request' (duration: 216.669797ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:34.944084Z","caller":"traceutil/trace.go:171","msg":"trace[1607994066] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"207.636807ms","start":"2026-07-02T05:07:34.736429Z","end":"2026-07-02T05:07:34.944066Z","steps":["trace[1607994066] 'process raft request' (duration: 207.541483ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.454461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.525039ms","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-02T05:07:36.454634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.394219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-02T05:07:36.454695Z","caller":"traceutil/trace.go:171","msg":"trace[389965366] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:671; }","duration":"130.497132ms","start":"2026-07-02T05:07:36.324183Z","end":"2026-07-02T05:07:36.45468Z","steps":["trace[389965366] 'range keys from in-memory index tree' (duration: 130.268814ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.454699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.548207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-02T05:07:36.454776Z","caller":"traceutil/trace.go:171","msg":"trace[749936446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:671; }","duration":"561.656742ms","start":"2026-07-02T05:07:35.893103Z","end":"2026-07-02T05:07:36.454759Z","steps":["trace[749936446] 'range keys from in-memory index tree' (duration: 561.470535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.454666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.83093ms","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-02T05:07:36.454834Z","caller":"traceutil/trace.go:171","msg":"trace[2123397713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:671; }","duration":"561.048739ms","start":"2026-07-02T05:07:35.893778Z","end":"2026-07-02T05:07:36.454826Z","steps":["trace[2123397713] 'range keys from in-memory index tree' (duration: 560.661934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.45486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:35.893756Z","time spent":"561.098221ms","remote":"127.0.0.1:38150","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-02T05:07:36.454826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:35.89307Z","time spent":"561.743585ms","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-02T05:07:36.454544Z","caller":"traceutil/trace.go:171","msg":"trace[341952371] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:671; }","duration":"560.626352ms","start":"2026-07-02T05:07:35.893901Z","end":"2026-07-02T05:07:36.454527Z","steps":["trace[341952371] 'range keys from in-memory index tree' (duration: 560.442936ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.454895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.343255ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:36.455032Z","caller":"traceutil/trace.go:171","msg":"trace[521486995] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:671; }","duration":"859.488821ms","start":"2026-07-02T05:07:35.59552Z","end":"2026-07-02T05:07:36.455008Z","steps":["trace[521486995] 'range keys from in-memory index tree' (duration: 859.326005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.454989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:35.893877Z","time spent":"561.096711ms","remote":"127.0.0.1:38150","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-02T05:07:36.455058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.637153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:36.455308Z","caller":"traceutil/trace.go:171","msg":"trace[523846812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:671; }","duration":"778.902014ms","start":"2026-07-02T05:07:35.676361Z","end":"2026-07-02T05:07:36.455263Z","steps":["trace[523846812] 'range keys from in-memory index tree' (duration: 778.560051ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.45537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:35.676305Z","time spent":"779.046229ms","remote":"127.0.0.1:37854","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-02T05:07:36.455084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.721415ms","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-02T05:07:36.455527Z","caller":"traceutil/trace.go:171","msg":"trace[2101500800] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:671; }","duration":"562.171532ms","start":"2026-07-02T05:07:35.893333Z","end":"2026-07-02T05:07:36.455504Z","steps":["trace[2101500800] 'range keys from in-memory index tree' (duration: 561.679203ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.455608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:35.893324Z","time spent":"562.265205ms","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-02T05:07:36.692954Z","caller":"traceutil/trace.go:171","msg":"trace[348181610] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"233.348661ms","start":"2026-07-02T05:07:36.459582Z","end":"2026-07-02T05:07:36.692931Z","steps":["trace[348181610] 'process raft request' (duration: 148.385141ms)","trace[348181610] 'compare' (duration: 84.787014ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:36.693212Z","caller":"traceutil/trace.go:171","msg":"trace[1967115862] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:700; }","duration":"220.474876ms","start":"2026-07-02T05:07:36.472718Z","end":"2026-07-02T05:07:36.693192Z","steps":["trace[1967115862] 'read index received' (duration: 58.001573ms)","trace[1967115862] 'applied index is now lower than readState.Index' (duration: 162.472483ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:36.693246Z","caller":"traceutil/trace.go:171","msg":"trace[1632476434] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"233.364682ms","start":"2026-07-02T05:07:36.459864Z","end":"2026-07-02T05:07:36.693229Z","steps":["trace[1632476434] 'process raft request' (duration: 233.003208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.69333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.597301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:36.693367Z","caller":"traceutil/trace.go:171","msg":"trace[310979172] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:675; }","duration":"220.678324ms","start":"2026-07-02T05:07:36.472679Z","end":"2026-07-02T05:07:36.693358Z","steps":["trace[310979172] 'agreement among raft nodes before linearized reading' (duration: 220.611371ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:36.693425Z","caller":"traceutil/trace.go:171","msg":"trace[150434236] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"233.348081ms","start":"2026-07-02T05:07:36.459922Z","end":"2026-07-02T05:07:36.69327Z","steps":["trace[150434236] 'process raft request' (duration: 233.204526ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:36.729671Z","caller":"traceutil/trace.go:171","msg":"trace[521725879] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"144.583025ms","start":"2026-07-02T05:07:36.585048Z","end":"2026-07-02T05:07:36.729631Z","steps":["trace[521725879] 'process raft request' (duration: 144.433879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:36.729737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.028759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c6dfq\" ","response":"range_response_count:1 size:17520"} {"level":"info","ts":"2026-07-02T05:07:36.729798Z","caller":"traceutil/trace.go:171","msg":"trace[60482450] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c6dfq; range_end:; response_count:1; response_revision:676; }","duration":"140.117203ms","start":"2026-07-02T05:07:36.589665Z","end":"2026-07-02T05:07:36.729782Z","steps":["trace[60482450] 'agreement among raft nodes before linearized reading' (duration: 139.924945ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:39.845847Z","caller":"traceutil/trace.go:171","msg":"trace[1706230467] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"140.179036ms","start":"2026-07-02T05:07:39.705629Z","end":"2026-07-02T05:07:39.845808Z","steps":["trace[1706230467] 'process raft request' (duration: 76.188084ms)","trace[1706230467] 'compare' (duration: 63.852096ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:40.651915Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289351141,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-02T05:07:40.910586Z","caller":"traceutil/trace.go:171","msg":"trace[1262923821] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"955.406079ms","start":"2026-07-02T05:07:39.955157Z","end":"2026-07-02T05:07:40.910563Z","steps":["trace[1262923821] 'process raft request' (duration: 955.210961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:40.910754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:39.955097Z","time spent":"955.571155ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:07:41.049353Z","caller":"traceutil/trace.go:171","msg":"trace[1047237006] linearizableReadLoop","detail":"{readStateIndex:761; appliedIndex:758; }","duration":"898.440441ms","start":"2026-07-02T05:07:40.150896Z","end":"2026-07-02T05:07:41.049336Z","steps":["trace[1047237006] 'read index received' (duration: 759.547304ms)","trace[1047237006] 'applied index is now lower than readState.Index' (duration: 138.892497ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:41.04968Z","caller":"traceutil/trace.go:171","msg":"trace[737104536] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"665.242142ms","start":"2026-07-02T05:07:40.38443Z","end":"2026-07-02T05:07:41.049672Z","steps":["trace[737104536] 'process raft request' (duration: 664.568565ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.049747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.384404Z","time spent":"665.301294ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:07:41.049975Z","caller":"traceutil/trace.go:171","msg":"trace[1997289409] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"461.115087ms","start":"2026-07-02T05:07:40.588826Z","end":"2026-07-02T05:07:41.049941Z","steps":["trace[1997289409] 'process raft request' (duration: 460.404518ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.050023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.102678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"info","ts":"2026-07-02T05:07:41.05008Z","caller":"traceutil/trace.go:171","msg":"trace[1668831957] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:730; }","duration":"899.210203ms","start":"2026-07-02T05:07:40.150856Z","end":"2026-07-02T05:07:41.050066Z","steps":["trace[1668831957] 'agreement among raft nodes before linearized reading' (duration: 899.005104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.050122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.150837Z","time spent":"899.277736ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-07-02T05:07:41.050129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.588808Z","time spent":"461.253823ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T05:07:41.197981Z","caller":"traceutil/trace.go:171","msg":"trace[209110881] linearizableReadLoop","detail":"{readStateIndex:762; appliedIndex:761; }","duration":"148.555164ms","start":"2026-07-02T05:07:41.049402Z","end":"2026-07-02T05:07:41.197957Z","steps":["trace[209110881] 'read index received' (duration: 148.364766ms)","trace[209110881] 'applied index is now lower than readState.Index' (duration: 189.558µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:41.198112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.943166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"warn","ts":"2026-07-02T05:07:41.198132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.966307ms","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-02T05:07:41.19819Z","caller":"traceutil/trace.go:171","msg":"trace[1271657596] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:731; }","duration":"448.01954ms","start":"2026-07-02T05:07:40.750126Z","end":"2026-07-02T05:07:41.198145Z","steps":["trace[1271657596] 'agreement among raft nodes before linearized reading' (duration: 447.879324ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:41.198205Z","caller":"traceutil/trace.go:171","msg":"trace[836565420] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:731; }","duration":"654.003439ms","start":"2026-07-02T05:07:40.544149Z","end":"2026-07-02T05:07:41.198153Z","steps":["trace[836565420] 'agreement among raft nodes before linearized reading' (duration: 653.894595ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.198224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.750115Z","time spent":"448.102503ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24267,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-07-02T05:07:41.19824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.544106Z","time spent":"654.125613ms","remote":"127.0.0.1:38150","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":"info","ts":"2026-07-02T05:07:41.198438Z","caller":"traceutil/trace.go:171","msg":"trace[949259760] transaction","detail":"{read_only:false; response_revision:731; number_of_response:1; }","duration":"279.914279ms","start":"2026-07-02T05:07:40.918512Z","end":"2026-07-02T05:07:41.198426Z","steps":["trace[949259760] 'process raft request' (duration: 279.324175ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.198533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.794922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-c6dfq\" ","response":"range_response_count:1 size:18333"} {"level":"info","ts":"2026-07-02T05:07:41.198573Z","caller":"traceutil/trace.go:171","msg":"trace[666980162] range","detail":"{range_begin:/registry/pods/kube-system/cilium-c6dfq; range_end:; response_count:1; response_revision:731; }","duration":"569.874805ms","start":"2026-07-02T05:07:40.628688Z","end":"2026-07-02T05:07:41.198563Z","steps":["trace[666980162] 'agreement among raft nodes before linearized reading' (duration: 569.717809ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.198544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.988982ms","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-02T05:07:41.198644Z","caller":"traceutil/trace.go:171","msg":"trace[8826246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:731; }","duration":"495.17762ms","start":"2026-07-02T05:07:40.703452Z","end":"2026-07-02T05:07:41.19863Z","steps":["trace[8826246] 'agreement among raft nodes before linearized reading' (duration: 494.93362ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.198677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.56141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-07-02T05:07:41.198691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.703441Z","time spent":"495.239643ms","remote":"127.0.0.1:38150","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-07-02T05:07:41.198708Z","caller":"traceutil/trace.go:171","msg":"trace[1431963402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:731; }","duration":"435.615792ms","start":"2026-07-02T05:07:40.763084Z","end":"2026-07-02T05:07:41.198699Z","steps":["trace[1431963402] 'agreement among raft nodes before linearized reading' (duration: 435.532949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.19873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.763072Z","time spent":"435.653014ms","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T05:07:41.198602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.628676Z","time spent":"569.919467ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":18356,"request content":"key:\"/registry/pods/kube-system/cilium-c6dfq\" "} {"level":"warn","ts":"2026-07-02T05:07:41.198933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.110837ms","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-02T05:07:41.198974Z","caller":"traceutil/trace.go:171","msg":"trace[576012466] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:731; }","duration":"493.15959ms","start":"2026-07-02T05:07:40.705805Z","end":"2026-07-02T05:07:41.198964Z","steps":["trace[576012466] 'agreement among raft nodes before linearized reading' (duration: 493.039335ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.199007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.705802Z","time spent":"493.196871ms","remote":"127.0.0.1:38150","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-07-02T05:07:41.198965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.150289ms","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-02T05:07:41.199116Z","caller":"traceutil/trace.go:171","msg":"trace[1503463325] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:731; }","duration":"493.268054ms","start":"2026-07-02T05:07:40.70578Z","end":"2026-07-02T05:07:41.199048Z","steps":["trace[1503463325] 'agreement among raft nodes before linearized reading' (duration: 493.025584ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.199151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:40.705775Z","time spent":"493.368728ms","remote":"127.0.0.1:38150","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-02T05:07:41.590331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.320803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:07:41.590568Z","caller":"traceutil/trace.go:171","msg":"trace[1674098013] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"380.952711ms","start":"2026-07-02T05:07:41.209561Z","end":"2026-07-02T05:07:41.590514Z","steps":["trace[1674098013] 'process raft request' (duration: 255.385828ms)","trace[1674098013] 'compare' (duration: 125.177327ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:41.590828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:41.209539Z","time spent":"381.170849ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:41.590679Z","caller":"traceutil/trace.go:171","msg":"trace[3052184] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"380.790164ms","start":"2026-07-02T05:07:41.209876Z","end":"2026-07-02T05:07:41.590666Z","steps":["trace[3052184] 'process raft request' (duration: 380.548395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.590956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:41.20986Z","time spent":"381.074236ms","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18502,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:07:41.639484Z","caller":"traceutil/trace.go:171","msg":"trace[1636738538] linearizableReadLoop","detail":"{readStateIndex:770; appliedIndex:767; }","duration":"374.118625ms","start":"2026-07-02T05:07:41.265348Z","end":"2026-07-02T05:07:41.639467Z","steps":["trace[1636738538] 'read index received' (duration: 199.707995ms)","trace[1636738538] 'applied index is now lower than readState.Index' (duration: 174.40985ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:07:41.639655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.286852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T05:07:41.639601Z","caller":"traceutil/trace.go:171","msg":"trace[1799961244] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"392.419476ms","start":"2026-07-02T05:07:41.247142Z","end":"2026-07-02T05:07:41.639561Z","steps":["trace[1799961244] 'process raft request' (duration: 392.162166ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:41.639682Z","caller":"traceutil/trace.go:171","msg":"trace[1086444737] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:739; }","duration":"374.359865ms","start":"2026-07-02T05:07:41.265314Z","end":"2026-07-02T05:07:41.639674Z","steps":["trace[1086444737] 'agreement among raft nodes before linearized reading' (duration: 374.2478ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.639704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:41.265299Z","time spent":"374.399057ms","remote":"127.0.0.1:38302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-07-02T05:07:41.639778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:41.247124Z","time spent":"392.570952ms","remote":"127.0.0.1:37908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:07:41.63993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.069741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T05:07:41.639955Z","caller":"traceutil/trace.go:171","msg":"trace[545626367] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:739; }","duration":"326.128193ms","start":"2026-07-02T05:07:41.313821Z","end":"2026-07-02T05:07:41.63995Z","steps":["trace[545626367] 'agreement among raft nodes before linearized reading' (duration: 326.05993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:41.639973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:41.313802Z","time spent":"326.166985ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":67,"response size":30,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-07-02T05:07:41.640341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.969296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-07-02T05:07:41.640377Z","caller":"traceutil/trace.go:171","msg":"trace[388238114] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:739; }","duration":"223.039549ms","start":"2026-07-02T05:07:41.41733Z","end":"2026-07-02T05:07:41.64037Z","steps":["trace[388238114] 'agreement among raft nodes before linearized reading' (duration: 222.986757ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:51.243299Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289351404,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:51.743659Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289351404,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:52.244671Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289351404,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:52.745366Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988152133289351404,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-02T05:07:52.752746Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.070401867s","expected-duration":"1s"} {"level":"info","ts":"2026-07-02T05:07:52.753147Z","caller":"traceutil/trace.go:171","msg":"trace[230704016] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:849; }","duration":"2.010804823s","start":"2026-07-02T05:07:50.742321Z","end":"2026-07-02T05:07:52.753126Z","steps":["trace[230704016] 'read index received' (duration: 2.010553682s)","trace[230704016] 'applied index is now lower than readState.Index' (duration: 250.341µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:52.753248Z","caller":"traceutil/trace.go:171","msg":"trace[1137171790] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"2.070982932s","start":"2026-07-02T05:07:50.682254Z","end":"2026-07-02T05:07:52.753236Z","steps":["trace[1137171790] 'process raft request' (duration: 2.07072704s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:52.753364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:50.682242Z","time spent":"2.071039405s","remote":"127.0.0.1:38054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4024,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T05:07:52.753613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.480798425s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-02T05:07:52.753517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.48001197s","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-02T05:07:52.753722Z","caller":"traceutil/trace.go:171","msg":"trace[546558851] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:816; }","duration":"1.480254552s","start":"2026-07-02T05:07:51.27345Z","end":"2026-07-02T05:07:52.753705Z","steps":["trace[546558851] 'agreement among raft nodes before linearized reading' (duration: 1.479884745s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:52.753768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:51.273432Z","time spent":"1.480325794s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-02T05:07:52.753578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.480259581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-02T05:07:52.753817Z","caller":"traceutil/trace.go:171","msg":"trace[389767645] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:816; }","duration":"1.480517263s","start":"2026-07-02T05:07:51.273286Z","end":"2026-07-02T05:07:52.753803Z","steps":["trace[389767645] 'agreement among raft nodes before linearized reading' (duration: 1.480155887s)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:52.753753Z","caller":"traceutil/trace.go:171","msg":"trace[880773742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:816; }","duration":"1.480930471s","start":"2026-07-02T05:07:51.272752Z","end":"2026-07-02T05:07:52.753683Z","steps":["trace[880773742] 'agreement among raft nodes before linearized reading' (duration: 1.480644848s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:52.753862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:51.27328Z","time spent":"1.480571825s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T05:07:52.753801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.01140607s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-02T05:07:52.754119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:51.272737Z","time spent":"1.481156461s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-02T05:07:52.753558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.482890637s","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-02T05:07:52.754155Z","caller":"traceutil/trace.go:171","msg":"trace[198476342] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:816; }","duration":"2.011850109s","start":"2026-07-02T05:07:50.742275Z","end":"2026-07-02T05:07:52.754125Z","steps":["trace[198476342] 'agreement among raft nodes before linearized reading' (duration: 2.011240922s)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:52.754236Z","caller":"traceutil/trace.go:171","msg":"trace[1698129643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"1.48363161s","start":"2026-07-02T05:07:51.270593Z","end":"2026-07-02T05:07:52.754225Z","steps":["trace[1698129643] 'agreement among raft nodes before linearized reading' (duration: 1.482813103s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:52.754259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:50.742256Z","time spent":"2.011990436s","remote":"127.0.0.1:38342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-07-02T05:07:52.754292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:51.27056Z","time spent":"1.483716144s","remote":"127.0.0.1:38150","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-02T05:07:52.754534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.496249776s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-07-02T05:07:52.754578Z","caller":"traceutil/trace.go:171","msg":"trace[41380633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:816; }","duration":"1.49635489s","start":"2026-07-02T05:07:51.258212Z","end":"2026-07-02T05:07:52.754567Z","steps":["trace[41380633] 'agreement among raft nodes before linearized reading' (duration: 1.495111105s)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:52.754639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:07:51.258197Z","time spent":"1.496433174s","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-02T05:07:52.869308Z","caller":"traceutil/trace.go:171","msg":"trace[1782153744] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"108.270631ms","start":"2026-07-02T05:07:52.761016Z","end":"2026-07-02T05:07:52.869287Z","steps":["trace[1782153744] 'process raft request' (duration: 108.212609ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:52.869452Z","caller":"traceutil/trace.go:171","msg":"trace[1397183916] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"109.181882ms","start":"2026-07-02T05:07:52.760201Z","end":"2026-07-02T05:07:52.869383Z","steps":["trace[1397183916] 'process raft request' (duration: 107.969738ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:52.869638Z","caller":"traceutil/trace.go:171","msg":"trace[1776083517] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"108.343215ms","start":"2026-07-02T05:07:52.761276Z","end":"2026-07-02T05:07:52.869619Z","steps":["trace[1776083517] 'process raft request' (duration: 107.977329ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:52.869711Z","caller":"traceutil/trace.go:171","msg":"trace[1624681801] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"109.216764ms","start":"2026-07-02T05:07:52.760286Z","end":"2026-07-02T05:07:52.869502Z","steps":["trace[1624681801] 'process raft request' (duration: 108.868529ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:54.977807Z","caller":"traceutil/trace.go:171","msg":"trace[422350348] linearizableReadLoop","detail":"{readStateIndex:860; appliedIndex:859; }","duration":"104.787473ms","start":"2026-07-02T05:07:54.873001Z","end":"2026-07-02T05:07:54.977788Z","steps":["trace[422350348] 'read index received' (duration: 104.540602ms)","trace[422350348] 'applied index is now lower than readState.Index' (duration: 246.001µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:54.977924Z","caller":"traceutil/trace.go:171","msg":"trace[266611035] transaction","detail":"{read_only:false; response_revision:825; number_of_response:1; }","duration":"159.057355ms","start":"2026-07-02T05:07:54.818833Z","end":"2026-07-02T05:07:54.97789Z","steps":["trace[266611035] 'process raft request' (duration: 158.805404ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:54.978051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.564294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-07-02T05:07:54.97809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.773919ms","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-02T05:07:54.978097Z","caller":"traceutil/trace.go:171","msg":"trace[1371957951] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:825; }","duration":"104.654108ms","start":"2026-07-02T05:07:54.87343Z","end":"2026-07-02T05:07:54.978084Z","steps":["trace[1371957951] 'agreement among raft nodes before linearized reading' (duration: 104.507491ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:54.978119Z","caller":"traceutil/trace.go:171","msg":"trace[1514993070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:825; }","duration":"103.8148ms","start":"2026-07-02T05:07:54.874297Z","end":"2026-07-02T05:07:54.978112Z","steps":["trace[1514993070] 'agreement among raft nodes before linearized reading' (duration: 103.747727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:54.978256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.098593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-02T05:07:54.978312Z","caller":"traceutil/trace.go:171","msg":"trace[670007065] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:825; }","duration":"104.187517ms","start":"2026-07-02T05:07:54.874109Z","end":"2026-07-02T05:07:54.978297Z","steps":["trace[670007065] 'agreement among raft nodes before linearized reading' (duration: 103.954907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:54.978387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.007604ms","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-02T05:07:54.978414Z","caller":"traceutil/trace.go:171","msg":"trace[1833437160] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:825; }","duration":"105.410162ms","start":"2026-07-02T05:07:54.872996Z","end":"2026-07-02T05:07:54.978406Z","steps":["trace[1833437160] 'agreement among raft nodes before linearized reading' (duration: 104.903039ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:56.91159Z","caller":"traceutil/trace.go:171","msg":"trace[887420815] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"128.021647ms","start":"2026-07-02T05:07:56.783545Z","end":"2026-07-02T05:07:56.911567Z","steps":["trace[887420815] 'process raft request' (duration: 127.884591ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:57.049456Z","caller":"traceutil/trace.go:171","msg":"trace[388576754] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"130.891462ms","start":"2026-07-02T05:07:56.918547Z","end":"2026-07-02T05:07:57.049438Z","steps":["trace[388576754] 'process raft request' (duration: 123.850069ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:57.229183Z","caller":"traceutil/trace.go:171","msg":"trace[189043208] linearizableReadLoop","detail":"{readStateIndex:869; appliedIndex:868; }","duration":"174.411626ms","start":"2026-07-02T05:07:57.054735Z","end":"2026-07-02T05:07:57.229146Z","steps":["trace[189043208] 'read index received' (duration: 167.926008ms)","trace[189043208] 'applied index is now lower than readState.Index' (duration: 6.484138ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:57.229248Z","caller":"traceutil/trace.go:171","msg":"trace[428402722] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"175.237573ms","start":"2026-07-02T05:07:57.053963Z","end":"2026-07-02T05:07:57.2292Z","steps":["trace[428402722] 'process raft request' (duration: 168.679212ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:57.229805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.028964ms","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-02T05:07:57.229878Z","caller":"traceutil/trace.go:171","msg":"trace[1949025189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:834; }","duration":"175.150849ms","start":"2026-07-02T05:07:57.054707Z","end":"2026-07-02T05:07:57.229857Z","steps":["trace[1949025189] 'agreement among raft nodes before linearized reading' (duration: 174.628555ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:57.278459Z","caller":"traceutil/trace.go:171","msg":"trace[363928380] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"222.65321ms","start":"2026-07-02T05:07:57.05579Z","end":"2026-07-02T05:07:57.278443Z","steps":["trace[363928380] 'process raft request' (duration: 222.628139ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:57.278708Z","caller":"traceutil/trace.go:171","msg":"trace[1096139241] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"223.76038ms","start":"2026-07-02T05:07:57.054933Z","end":"2026-07-02T05:07:57.278693Z","steps":["trace[1096139241] 'process raft request' (duration: 223.390583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:57.278872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.191495ms","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-02T05:07:57.278896Z","caller":"traceutil/trace.go:171","msg":"trace[337085307] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:836; }","duration":"223.237326ms","start":"2026-07-02T05:07:57.055651Z","end":"2026-07-02T05:07:57.278889Z","steps":["trace[337085307] 'agreement among raft nodes before linearized reading' (duration: 223.148322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:57.278971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.065745ms","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-02T05:07:57.279035Z","caller":"traceutil/trace.go:171","msg":"trace[1706567888] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:836; }","duration":"224.155128ms","start":"2026-07-02T05:07:57.054867Z","end":"2026-07-02T05:07:57.279022Z","steps":["trace[1706567888] 'agreement among raft nodes before linearized reading' (duration: 223.959019ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:57.438893Z","caller":"traceutil/trace.go:171","msg":"trace[1842729651] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"200.373107ms","start":"2026-07-02T05:07:57.238486Z","end":"2026-07-02T05:07:57.438859Z","steps":["trace[1842729651] 'process raft request' (duration: 116.490227ms)","trace[1842729651] 'compare' (duration: 83.542615ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:57.438887Z","caller":"traceutil/trace.go:171","msg":"trace[1735985004] linearizableReadLoop","detail":"{readStateIndex:873; appliedIndex:871; }","duration":"160.080267ms","start":"2026-07-02T05:07:57.278777Z","end":"2026-07-02T05:07:57.438857Z","steps":["trace[1735985004] 'read index received' (duration: 76.343764ms)","trace[1735985004] 'applied index is now lower than readState.Index' (duration: 83.735313ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:57.438924Z","caller":"traceutil/trace.go:171","msg":"trace[925403962] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"199.515488ms","start":"2026-07-02T05:07:57.23938Z","end":"2026-07-02T05:07:57.438896Z","steps":["trace[925403962] 'process raft request' (duration: 199.35303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:57.439139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.638995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:57.439187Z","caller":"traceutil/trace.go:171","msg":"trace[265415620] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"156.986766ms","start":"2026-07-02T05:07:57.282187Z","end":"2026-07-02T05:07:57.439174Z","steps":["trace[265415620] 'process raft request' (duration: 156.627769ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:57.439154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.769635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/envoy-gateway-system/\" range_end:\"/registry/resourcequotas/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:57.439229Z","caller":"traceutil/trace.go:171","msg":"trace[473721929] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:839; }","duration":"184.820393ms","start":"2026-07-02T05:07:57.25439Z","end":"2026-07-02T05:07:57.43921Z","steps":["trace[473721929] 'agreement among raft nodes before linearized reading' (duration: 184.52145ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:57.439244Z","caller":"traceutil/trace.go:171","msg":"trace[1464260472] range","detail":"{range_begin:/registry/resourcequotas/envoy-gateway-system/; range_end:/registry/resourcequotas/envoy-gateway-system0; response_count:0; response_revision:839; }","duration":"200.934992ms","start":"2026-07-02T05:07:57.238296Z","end":"2026-07-02T05:07:57.439231Z","steps":["trace[1464260472] 'agreement among raft nodes before linearized reading' (duration: 200.782555ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:57.439231Z","caller":"traceutil/trace.go:171","msg":"trace[872122748] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"156.905271ms","start":"2026-07-02T05:07:57.282301Z","end":"2026-07-02T05:07:57.439206Z","steps":["trace[872122748] 'process raft request' (duration: 156.709412ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:57.701529Z","caller":"traceutil/trace.go:171","msg":"trace[1829652898] transaction","detail":"{read_only:false; response_revision:842; number_of_response:1; }","duration":"239.505213ms","start":"2026-07-02T05:07:57.461988Z","end":"2026-07-02T05:07:57.701493Z","steps":["trace[1829652898] 'process raft request' (duration: 191.319031ms)","trace[1829652898] 'compare' (duration: 48.026315ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:57.826703Z","caller":"traceutil/trace.go:171","msg":"trace[676728459] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"121.704156ms","start":"2026-07-02T05:07:57.704979Z","end":"2026-07-02T05:07:57.826683Z","steps":["trace[676728459] 'process raft request' (duration: 110.592846ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:58.017763Z","caller":"traceutil/trace.go:171","msg":"trace[961484187] transaction","detail":"{read_only:false; response_revision:845; number_of_response:1; }","duration":"141.017087ms","start":"2026-07-02T05:07:57.876719Z","end":"2026-07-02T05:07:58.017736Z","steps":["trace[961484187] 'process raft request' (duration: 140.505493ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:58.028074Z","caller":"traceutil/trace.go:171","msg":"trace[159977582] transaction","detail":"{read_only:false; response_revision:846; number_of_response:1; }","duration":"150.956226ms","start":"2026-07-02T05:07:57.877098Z","end":"2026-07-02T05:07:58.028054Z","steps":["trace[159977582] 'process raft request' (duration: 150.846161ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:58.228917Z","caller":"traceutil/trace.go:171","msg":"trace[1930640346] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"115.60228ms","start":"2026-07-02T05:07:58.113266Z","end":"2026-07-02T05:07:58.228868Z","steps":["trace[1930640346] 'process raft request' (duration: 97.236622ms)","trace[1930640346] 'compare' (duration: 18.164339ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:58.423754Z","caller":"traceutil/trace.go:171","msg":"trace[348083219] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"126.090484ms","start":"2026-07-02T05:07:58.297636Z","end":"2026-07-02T05:07:58.423727Z","steps":["trace[348083219] 'process raft request' (duration: 53.554763ms)","trace[348083219] 'compare' (duration: 72.380094ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:58.431615Z","caller":"traceutil/trace.go:171","msg":"trace[613329723] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"132.002128ms","start":"2026-07-02T05:07:58.299595Z","end":"2026-07-02T05:07:58.431597Z","steps":["trace[613329723] 'process raft request' (duration: 131.959766ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:58.431671Z","caller":"traceutil/trace.go:171","msg":"trace[284739772] transaction","detail":"{read_only:false; response_revision:852; number_of_response:1; }","duration":"132.848977ms","start":"2026-07-02T05:07:58.29879Z","end":"2026-07-02T05:07:58.431639Z","steps":["trace[284739772] 'process raft request' (duration: 132.644757ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:58.630894Z","caller":"traceutil/trace.go:171","msg":"trace[394656163] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"200.299533ms","start":"2026-07-02T05:07:58.430565Z","end":"2026-07-02T05:07:58.630865Z","steps":["trace[394656163] 'process raft request' (duration: 186.953016ms)","trace[394656163] 'compare' (duration: 13.215741ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:58.823196Z","caller":"traceutil/trace.go:171","msg":"trace[291137309] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"101.545241ms","start":"2026-07-02T05:07:58.721632Z","end":"2026-07-02T05:07:58.823177Z","steps":["trace[291137309] 'process raft request' (duration: 101.411455ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:58.875044Z","caller":"traceutil/trace.go:171","msg":"trace[356037814] linearizableReadLoop","detail":"{readStateIndex:895; appliedIndex:892; }","duration":"151.358332ms","start":"2026-07-02T05:07:58.723669Z","end":"2026-07-02T05:07:58.875028Z","steps":["trace[356037814] 'read index received' (duration: 99.3462ms)","trace[356037814] 'applied index is now lower than readState.Index' (duration: 52.011562ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:58.875117Z","caller":"traceutil/trace.go:171","msg":"trace[1547619614] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"153.394396ms","start":"2026-07-02T05:07:58.721692Z","end":"2026-07-02T05:07:58.875086Z","steps":["trace[1547619614] 'process raft request' (duration: 153.220058ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:58.875275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.53144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:5266"} {"level":"info","ts":"2026-07-02T05:07:58.875132Z","caller":"traceutil/trace.go:171","msg":"trace[822043982] transaction","detail":"{read_only:false; response_revision:860; number_of_response:1; }","duration":"153.320633ms","start":"2026-07-02T05:07:58.721787Z","end":"2026-07-02T05:07:58.875108Z","steps":["trace[822043982] 'process raft request' (duration: 153.205638ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:58.875307Z","caller":"traceutil/trace.go:171","msg":"trace[432760598] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:860; }","duration":"151.652686ms","start":"2026-07-02T05:07:58.723642Z","end":"2026-07-02T05:07:58.875294Z","steps":["trace[432760598] 'agreement among raft nodes before linearized reading' (duration: 151.460397ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:59.030766Z","caller":"traceutil/trace.go:171","msg":"trace[1396481672] transaction","detail":"{read_only:false; response_revision:861; number_of_response:1; }","duration":"199.569727ms","start":"2026-07-02T05:07:58.831169Z","end":"2026-07-02T05:07:59.030739Z","steps":["trace[1396481672] 'process raft request' (duration: 199.261783ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:59.034355Z","caller":"traceutil/trace.go:171","msg":"trace[1105468632] linearizableReadLoop","detail":"{readStateIndex:897; appliedIndex:895; }","duration":"159.243025ms","start":"2026-07-02T05:07:58.875085Z","end":"2026-07-02T05:07:59.034328Z","steps":["trace[1105468632] 'read index received' (duration: 155.431738ms)","trace[1105468632] 'applied index is now lower than readState.Index' (duration: 3.810277ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:07:59.034444Z","caller":"traceutil/trace.go:171","msg":"trace[59933203] transaction","detail":"{read_only:false; response_revision:862; number_of_response:1; }","duration":"193.946068ms","start":"2026-07-02T05:07:58.840473Z","end":"2026-07-02T05:07:59.034419Z","steps":["trace[59933203] 'process raft request' (duration: 191.513045ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:59.034546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.526968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:07:59.034642Z","caller":"traceutil/trace.go:171","msg":"trace[1840786234] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:862; }","duration":"280.667854ms","start":"2026-07-02T05:07:58.753952Z","end":"2026-07-02T05:07:59.034619Z","steps":["trace[1840786234] 'agreement among raft nodes before linearized reading' (duration: 280.467664ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:07:59.04789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.775504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-qxw4z\" ","response":"range_response_count:1 size:4495"} {"level":"info","ts":"2026-07-02T05:07:59.047932Z","caller":"traceutil/trace.go:171","msg":"trace[993686956] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-qxw4z; range_end:; response_count:1; response_revision:864; }","duration":"167.846257ms","start":"2026-07-02T05:07:58.880074Z","end":"2026-07-02T05:07:59.04792Z","steps":["trace[993686956] 'agreement among raft nodes before linearized reading' (duration: 167.657618ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:59.048055Z","caller":"traceutil/trace.go:171","msg":"trace[2023914072] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"168.719747ms","start":"2026-07-02T05:07:58.879329Z","end":"2026-07-02T05:07:59.048048Z","steps":["trace[2023914072] 'process raft request' (duration: 168.299528ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:07:59.048234Z","caller":"traceutil/trace.go:171","msg":"trace[1700150799] transaction","detail":"{read_only:false; response_revision:864; number_of_response:1; }","duration":"166.143938ms","start":"2026-07-02T05:07:58.882082Z","end":"2026-07-02T05:07:59.048226Z","steps":["trace[1700150799] 'process raft request' (duration: 165.613884ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:00.144834Z","caller":"traceutil/trace.go:171","msg":"trace[565969023] linearizableReadLoop","detail":"{readStateIndex:916; appliedIndex:914; }","duration":"120.719276ms","start":"2026-07-02T05:08:00.024094Z","end":"2026-07-02T05:08:00.144813Z","steps":["trace[565969023] 'read index received' (duration: 35.884979ms)","trace[565969023] 'applied index is now lower than readState.Index' (duration: 84.831597ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:08:00.145069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.949317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:3 size:1862"} {"level":"info","ts":"2026-07-02T05:08:00.14511Z","caller":"traceutil/trace.go:171","msg":"trace[987600819] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:880; }","duration":"121.037811ms","start":"2026-07-02T05:08:00.02406Z","end":"2026-07-02T05:08:00.145097Z","steps":["trace[987600819] 'agreement among raft nodes before linearized reading' (duration: 120.846082ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:00.145146Z","caller":"traceutil/trace.go:171","msg":"trace[768339240] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"125.340352ms","start":"2026-07-02T05:08:00.019776Z","end":"2026-07-02T05:08:00.145116Z","steps":["trace[768339240] 'process raft request' (duration: 40.18976ms)","trace[768339240] 'compare' (duration: 84.572915ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:08:00.145353Z","caller":"traceutil/trace.go:171","msg":"trace[2127675044] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"125.473469ms","start":"2026-07-02T05:08:00.019859Z","end":"2026-07-02T05:08:00.145332Z","steps":["trace[2127675044] 'process raft request' (duration: 124.894051ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:00.401753Z","caller":"traceutil/trace.go:171","msg":"trace[103768931] transaction","detail":"{read_only:false; response_revision:881; number_of_response:1; }","duration":"182.783378ms","start":"2026-07-02T05:08:00.218948Z","end":"2026-07-02T05:08:00.401731Z","steps":["trace[103768931] 'process raft request' (duration: 108.2066ms)","trace[103768931] 'compare' (duration: 74.456843ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:08:01.842053Z","caller":"traceutil/trace.go:171","msg":"trace[1202848839] transaction","detail":"{read_only:false; response_revision:888; number_of_response:1; }","duration":"346.645191ms","start":"2026-07-02T05:08:01.495377Z","end":"2026-07-02T05:08:01.842022Z","steps":["trace[1202848839] 'process raft request' (duration: 346.432951ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:01.84228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:08:01.495363Z","time spent":"346.793558ms","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:08:01.857922Z","caller":"traceutil/trace.go:171","msg":"trace[1901314326] linearizableReadLoop","detail":"{readStateIndex:926; appliedIndex:923; }","duration":"180.696222ms","start":"2026-07-02T05:08:01.677204Z","end":"2026-07-02T05:08:01.8579Z","steps":["trace[1901314326] 'read index received' (duration: 164.533801ms)","trace[1901314326] 'applied index is now lower than readState.Index' (duration: 16.161561ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:08:01.858133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.921403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:08:01.858217Z","caller":"traceutil/trace.go:171","msg":"trace[1322701284] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:890; }","duration":"181.061299ms","start":"2026-07-02T05:08:01.677142Z","end":"2026-07-02T05:08:01.858203Z","steps":["trace[1322701284] 'agreement among raft nodes before linearized reading' (duration: 180.855599ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:01.858555Z","caller":"traceutil/trace.go:171","msg":"trace[526872411] transaction","detail":"{read_only:false; response_revision:889; number_of_response:1; }","duration":"362.488556ms","start":"2026-07-02T05:08:01.496054Z","end":"2026-07-02T05:08:01.858542Z","steps":["trace[526872411] 'process raft request' (duration: 361.71431ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:01.858693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:08:01.496032Z","time spent":"362.559019ms","remote":"127.0.0.1:38150","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-02T05:08:01.85902Z","caller":"traceutil/trace.go:171","msg":"trace[319900290] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"362.797281ms","start":"2026-07-02T05:08:01.49621Z","end":"2026-07-02T05:08:01.859007Z","steps":["trace[319900290] 'process raft request' (duration: 361.655757ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:01.859097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:08:01.496183Z","time spent":"362.879955ms","remote":"127.0.0.1:38150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T05:08:04.459829Z","caller":"traceutil/trace.go:171","msg":"trace[1657014722] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"292.562905ms","start":"2026-07-02T05:08:04.167237Z","end":"2026-07-02T05:08:04.459799Z","steps":["trace[1657014722] 'process raft request' (duration: 287.964785ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:07.824653Z","caller":"traceutil/trace.go:171","msg":"trace[72375782] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"121.581365ms","start":"2026-07-02T05:08:07.703048Z","end":"2026-07-02T05:08:07.82463Z","steps":["trace[72375782] 'process raft request' (duration: 121.407096ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:07.981044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.289129ms","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-02T05:08:07.981174Z","caller":"traceutil/trace.go:171","msg":"trace[1315707626] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:972; }","duration":"115.51638ms","start":"2026-07-02T05:08:07.865632Z","end":"2026-07-02T05:08:07.981148Z","steps":["trace[1315707626] 'range keys from in-memory index tree' (duration: 115.021176ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:08.36701Z","caller":"traceutil/trace.go:171","msg":"trace[661844711] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"380.952567ms","start":"2026-07-02T05:08:07.986035Z","end":"2026-07-02T05:08:08.366987Z","steps":["trace[661844711] 'process raft request' (duration: 380.905514ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:08.367037Z","caller":"traceutil/trace.go:171","msg":"trace[1970791200] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"381.85353ms","start":"2026-07-02T05:08:07.985157Z","end":"2026-07-02T05:08:08.36701Z","steps":["trace[1970791200] 'process raft request' (duration: 355.438998ms)","trace[1970791200] 'compare' (duration: 26.217872ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:08:08.367157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:08:07.985132Z","time spent":"381.958366ms","remote":"127.0.0.1:38150","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-02T05:08:08.367247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T05:08:07.986024Z","time spent":"381.059861ms","remote":"127.0.0.1:38150","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-02T05:08:08.629764Z","caller":"traceutil/trace.go:171","msg":"trace[789067467] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"108.831413ms","start":"2026-07-02T05:08:08.52091Z","end":"2026-07-02T05:08:08.629742Z","steps":["trace[789067467] 'process raft request' (duration: 89.166401ms)","trace[789067467] 'compare' (duration: 19.445991ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:08:11.54887Z","caller":"traceutil/trace.go:171","msg":"trace[1019228955] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"150.08782ms","start":"2026-07-02T05:08:11.398762Z","end":"2026-07-02T05:08:11.548849Z","steps":["trace[1019228955] 'process raft request' (duration: 149.960624ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:11.796073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.086205ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-02T05:08:11.796183Z","caller":"traceutil/trace.go:171","msg":"trace[1489411682] linearizableReadLoop","detail":"{readStateIndex:1033; appliedIndex:1032; }","duration":"118.170016ms","start":"2026-07-02T05:08:11.677997Z","end":"2026-07-02T05:08:11.796167Z","steps":["trace[1489411682] 'read index received' (duration: 45.792µs)","trace[1489411682] 'applied index is now lower than readState.Index' (duration: 118.123014ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:08:11.796241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.25193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:08:11.796309Z","caller":"traceutil/trace.go:171","msg":"trace[2114492180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:995; }","duration":"118.317013ms","start":"2026-07-02T05:08:11.677981Z","end":"2026-07-02T05:08:11.796298Z","steps":["trace[2114492180] 'agreement among raft nodes before linearized reading' (duration: 118.229199ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:11.796287Z","caller":"traceutil/trace.go:171","msg":"trace[199546712] transaction","detail":"{read_only:false; response_revision:995; number_of_response:1; }","duration":"218.18012ms","start":"2026-07-02T05:08:11.578075Z","end":"2026-07-02T05:08:11.796255Z","steps":["trace[199546712] 'process raft request' (duration: 80.829502ms)","trace[199546712] 'compare' (duration: 136.97674ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:08:12.50243Z","caller":"traceutil/trace.go:171","msg":"trace[2038372736] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"101.505102ms","start":"2026-07-02T05:08:12.400899Z","end":"2026-07-02T05:08:12.502404Z","steps":["trace[2038372736] 'read index received' (duration: 101.25217ms)","trace[2038372736] 'applied index is now lower than readState.Index' (duration: 251.632µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:08:12.502459Z","caller":"traceutil/trace.go:171","msg":"trace[353237837] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"116.176884ms","start":"2026-07-02T05:08:12.386265Z","end":"2026-07-02T05:08:12.502442Z","steps":["trace[353237837] 'process raft request' (duration: 115.983895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:12.502679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.742234ms","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-02T05:08:12.502784Z","caller":"traceutil/trace.go:171","msg":"trace[331844483] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:997; }","duration":"101.912403ms","start":"2026-07-02T05:08:12.400854Z","end":"2026-07-02T05:08:12.502766Z","steps":["trace[331844483] 'agreement among raft nodes before linearized reading' (duration: 101.637639ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:12.658427Z","caller":"traceutil/trace.go:171","msg":"trace[980504049] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"151.948449ms","start":"2026-07-02T05:08:12.506447Z","end":"2026-07-02T05:08:12.658395Z","steps":["trace[980504049] 'process raft request' (duration: 113.915672ms)","trace[980504049] 'compare' (duration: 37.182604ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T05:08:14.919829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.274937ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-02T05:08:14.920093Z","caller":"traceutil/trace.go:171","msg":"trace[1031112185] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"169.371725ms","start":"2026-07-02T05:08:14.750697Z","end":"2026-07-02T05:08:14.920069Z","steps":["trace[1031112185] 'process raft request' (duration: 169.230558ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:18.860303Z","caller":"traceutil/trace.go:171","msg":"trace[343708085] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"104.161956ms","start":"2026-07-02T05:08:18.756118Z","end":"2026-07-02T05:08:18.86028Z","steps":["trace[343708085] 'process raft request' (duration: 104.009718ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:19.661426Z","caller":"traceutil/trace.go:171","msg":"trace[1783463831] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"107.024604ms","start":"2026-07-02T05:08:19.554377Z","end":"2026-07-02T05:08:19.661401Z","steps":["trace[1783463831] 'process raft request' (duration: 38.790695ms)","trace[1783463831] 'compare' (duration: 68.131524ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:08:20.429194Z","caller":"traceutil/trace.go:171","msg":"trace[331497960] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"163.399419ms","start":"2026-07-02T05:08:20.265774Z","end":"2026-07-02T05:08:20.429174Z","steps":["trace[331497960] 'process raft request' (duration: 163.254561ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:24.991515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.19926ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-02T05:08:25.03068Z","caller":"traceutil/trace.go:171","msg":"trace[733367285] linearizableReadLoop","detail":"{readStateIndex:1085; appliedIndex:1084; }","duration":"122.228416ms","start":"2026-07-02T05:08:24.908426Z","end":"2026-07-02T05:08:25.030654Z","steps":["trace[733367285] 'read index received' (duration: 121.983393ms)","trace[733367285] 'applied index is now lower than readState.Index' (duration: 243.922µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T05:08:25.030715Z","caller":"traceutil/trace.go:171","msg":"trace[1600732996] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"174.249104ms","start":"2026-07-02T05:08:24.856449Z","end":"2026-07-02T05:08:25.030698Z","steps":["trace[1600732996] 'process raft request' (duration: 174.020392ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:08:25.030925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.485418ms","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-02T05:08:25.030977Z","caller":"traceutil/trace.go:171","msg":"trace[1703748539] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1044; }","duration":"122.578534ms","start":"2026-07-02T05:08:24.908383Z","end":"2026-07-02T05:08:25.030962Z","steps":["trace[1703748539] 'agreement among raft nodes before linearized reading' (duration: 122.362972ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:08:26.152567Z","caller":"traceutil/trace.go:171","msg":"trace[1337232717] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"137.207038ms","start":"2026-07-02T05:08:26.015338Z","end":"2026-07-02T05:08:26.152545Z","steps":["trace[1337232717] 'process raft request' (duration: 137.028159ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:09:07.461824Z","caller":"traceutil/trace.go:171","msg":"trace[2036071160] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"150.492127ms","start":"2026-07-02T05:09:07.311308Z","end":"2026-07-02T05:09:07.461801Z","steps":["trace[2036071160] 'process raft request' (duration: 150.36059ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T05:09:16.776036Z","caller":"traceutil/trace.go:171","msg":"trace[479488158] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"119.673663ms","start":"2026-07-02T05:09:16.656328Z","end":"2026-07-02T05:09:16.776001Z","steps":["trace[479488158] 'process raft request' (duration: 119.444449ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:09:35.232209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.721624ms","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-02T05:09:35.232316Z","caller":"traceutil/trace.go:171","msg":"trace[888138699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1294; }","duration":"160.865523ms","start":"2026-07-02T05:09:35.071427Z","end":"2026-07-02T05:09:35.232293Z","steps":["trace[888138699] 'range keys from in-memory index tree' (duration: 160.537104ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:09:40.019122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.663514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T05:09:40.019247Z","caller":"traceutil/trace.go:171","msg":"trace[368793250] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1327; }","duration":"182.812843ms","start":"2026-07-02T05:09:39.836406Z","end":"2026-07-02T05:09:40.019218Z","steps":["trace[368793250] 'count revisions from in-memory index tree' (duration: 182.60027ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:10:00.65126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.315711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:route-controller\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-07-02T05:10:00.651338Z","caller":"traceutil/trace.go:171","msg":"trace[506157590] range","detail":"{range_begin:/registry/clusterroles/system:controller:route-controller; range_end:; response_count:1; response_revision:1405; }","duration":"126.441998ms","start":"2026-07-02T05:10:00.52488Z","end":"2026-07-02T05:10:00.651323Z","steps":["trace[506157590] 'range keys from in-memory index tree' (duration: 126.202784ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:10:00.651276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.971047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller\" ","response":"range_response_count:1 size:807"} {"level":"info","ts":"2026-07-02T05:10:00.651419Z","caller":"traceutil/trace.go:171","msg":"trace[788466918] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:endpointslicemirroring-controller; range_end:; response_count:1; response_revision:1405; }","duration":"134.127496ms","start":"2026-07-02T05:10:00.517275Z","end":"2026-07-02T05:10:00.651402Z","steps":["trace[788466918] 'range keys from in-memory index tree' (duration: 133.854169ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:10:02.263248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.21553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-aggregator\" ","response":"range_response_count:1 size:595"} {"level":"info","ts":"2026-07-02T05:10:02.263343Z","caller":"traceutil/trace.go:171","msg":"trace[960738708] range","detail":"{range_begin:/registry/clusterroles/system:kube-aggregator; range_end:; response_count:1; response_revision:1410; }","duration":"114.347098ms","start":"2026-07-02T05:10:02.148975Z","end":"2026-07-02T05:10:02.263322Z","steps":["trace[960738708] 'range keys from in-memory index tree' (duration: 114.075702ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T05:10:02.263562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.641103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:771"} {"level":"info","ts":"2026-07-02T05:10:02.263655Z","caller":"traceutil/trace.go:171","msg":"trace[1149992049] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1410; }","duration":"112.76541ms","start":"2026-07-02T05:10:02.150865Z","end":"2026-07-02T05:10:02.263631Z","steps":["trace[1149992049] 'range keys from in-memory index tree' (duration: 112.556507ms)"],"step_count":1}