{"level":"warn","ts":"2026-07-25T08:16:12.301676Z","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-25T08:16:12.301758Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-25T08:16:12.301845Z","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-25T08:16:12.301859Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-25T08:16:12.301875Z","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-25T08:16:12.302862Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-07-25T08:16:12.302958Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-25T08:16:12.307151Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.961379ms"} {"level":"info","ts":"2026-07-25T08:16:12.313478Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-07-25T08:16:12.313549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T08:16:12.313574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-07-25T08:16:12.313588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T08:16:12.313596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-07-25T08:16:12.313635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-07-25T08:16:12.319258Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T08:16:12.320319Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T08:16:12.321301Z","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-25T08:16:12.327581Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T08:16:12.32976Z","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-25T08:16:12.32983Z","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-25T08:16:12.329851Z","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-25T08:16:12.329985Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T08:16:12.330968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-07-25T08:16:12.331294Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-07-25T08:16:12.334529Z","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-25T08:16:12.334762Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T08:16:12.334796Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T08:16:12.335322Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-25T08:16:12.335337Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-07-25T08:16:13.214402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T08:16:13.214492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T08:16:13.214535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-07-25T08:16:13.214556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-07-25T08:16:13.214567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-25T08:16:13.214584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-07-25T08:16:13.214598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-07-25T08:16:13.362294Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T08:16:13.362324Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T08:16:13.362636Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T08:16:13.362983Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T08:16:13.363018Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T08:16:13.363179Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T08:16:13.368288Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-07-25T08:16:13.369471Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-25T08:16:13.60962Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T08:16:13.609775Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T08:16:13.60983Z","caller":"traceutil/trace.go:171","msg":"trace[1898779901] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"196.106484ms","start":"2026-07-25T08:16:13.413706Z","end":"2026-07-25T08:16:13.609813Z","steps":["trace[1898779901] 'read index received' (duration: 195.847704ms)","trace[1898779901] 'applied index is now lower than readState.Index' (duration: 257.39µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:16:13.609853Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-25T08:16:13.610029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.28226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T08:16:13.610114Z","caller":"traceutil/trace.go:171","msg":"trace[655452545] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"196.403294ms","start":"2026-07-25T08:16:13.413699Z","end":"2026-07-25T08:16:13.610102Z","steps":["trace[655452545] 'agreement among raft nodes before linearized reading' (duration: 196.193367ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:13.610036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.216348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T08:16:13.610186Z","caller":"traceutil/trace.go:171","msg":"trace[373760942] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"196.390424ms","start":"2026-07-25T08:16:13.41378Z","end":"2026-07-25T08:16:13.61017Z","steps":["trace[373760942] 'agreement among raft nodes before linearized reading' (duration: 196.215348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:13.610359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.918306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T08:16:13.610401Z","caller":"traceutil/trace.go:171","msg":"trace[1237774575] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"122.961698ms","start":"2026-07-25T08:16:13.48743Z","end":"2026-07-25T08:16:13.610391Z","steps":["trace[1237774575] 'agreement among raft nodes before linearized reading' (duration: 122.907635ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:13.610471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.103188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T08:16:13.610535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.271293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T08:16:13.610571Z","caller":"traceutil/trace.go:171","msg":"trace[1886490480] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"111.317155ms","start":"2026-07-25T08:16:13.499242Z","end":"2026-07-25T08:16:13.61056Z","steps":["trace[1886490480] 'agreement among raft nodes before linearized reading' (duration: 111.260273ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:13.610548Z","caller":"traceutil/trace.go:171","msg":"trace[1240402870] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"135.205892ms","start":"2026-07-25T08:16:13.475332Z","end":"2026-07-25T08:16:13.610538Z","steps":["trace[1240402870] 'agreement among raft nodes before linearized reading' (duration: 135.007795ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:13.610674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.433648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T08:16:13.610588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.335056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T08:16:13.610482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.193721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T08:16:13.611009Z","caller":"traceutil/trace.go:171","msg":"trace[1138389836] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"111.725859ms","start":"2026-07-25T08:16:13.499273Z","end":"2026-07-25T08:16:13.610999Z","steps":["trace[1138389836] 'agreement among raft nodes before linearized reading' (duration: 111.19109ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:13.610915Z","caller":"traceutil/trace.go:171","msg":"trace[1317892904] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"146.720099ms","start":"2026-07-25T08:16:13.464152Z","end":"2026-07-25T08:16:13.610872Z","steps":["trace[1317892904] 'agreement among raft nodes before linearized reading' (duration: 146.313844ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:13.611105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.923278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-07-25T08:16:13.611194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.024383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T08:16:13.611247Z","caller":"traceutil/trace.go:171","msg":"trace[191472136] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"157.081865ms","start":"2026-07-25T08:16:13.454153Z","end":"2026-07-25T08:16:13.611234Z","steps":["trace[191472136] 'agreement among raft nodes before linearized reading' (duration: 157.001052ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:13.611347Z","caller":"traceutil/trace.go:171","msg":"trace[2110640864] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"147.079243ms","start":"2026-07-25T08:16:13.464141Z","end":"2026-07-25T08:16:13.61122Z","steps":["trace[2110640864] 'agreement among raft nodes before linearized reading' (duration: 146.789472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:13.61168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.329263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-25T08:16:13.611737Z","caller":"traceutil/trace.go:171","msg":"trace[1787451656] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"136.407186ms","start":"2026-07-25T08:16:13.475314Z","end":"2026-07-25T08:16:13.611721Z","steps":["trace[1787451656] 'agreement among raft nodes before linearized reading' (duration: 136.308553ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:13.610705Z","caller":"traceutil/trace.go:171","msg":"trace[933866785] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"122.466279ms","start":"2026-07-25T08:16:13.488232Z","end":"2026-07-25T08:16:13.610698Z","steps":["trace[933866785] 'agreement among raft nodes before linearized reading' (duration: 122.417777ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:25.14257Z","caller":"traceutil/trace.go:171","msg":"trace[1671090426] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"111.290818ms","start":"2026-07-25T08:16:25.031249Z","end":"2026-07-25T08:16:25.14254Z","steps":["trace[1671090426] 'process raft request' (duration: 108.886158ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:25.144851Z","caller":"traceutil/trace.go:171","msg":"trace[1324349052] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"106.311604ms","start":"2026-07-25T08:16:25.038497Z","end":"2026-07-25T08:16:25.144808Z","steps":["trace[1324349052] 'process raft request' (duration: 106.056586ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:25.363314Z","caller":"traceutil/trace.go:171","msg":"trace[404879034] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"131.820954ms","start":"2026-07-25T08:16:25.231468Z","end":"2026-07-25T08:16:25.363289Z","steps":["trace[404879034] 'process raft request' (duration: 88.191866ms)","trace[404879034] 'compare' (duration: 43.503514ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:16:47.598387Z","caller":"traceutil/trace.go:171","msg":"trace[1412228830] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"131.896269ms","start":"2026-07-25T08:16:47.466465Z","end":"2026-07-25T08:16:47.598361Z","steps":["trace[1412228830] 'process raft request' (duration: 131.656363ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:56.782556Z","caller":"traceutil/trace.go:171","msg":"trace[1416944585] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"473.681857ms","start":"2026-07-25T08:16:56.308843Z","end":"2026-07-25T08:16:56.782525Z","steps":["trace[1416944585] 'process raft request' (duration: 473.538753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.783301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.30882Z","time spent":"473.838521ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.791524Z","caller":"traceutil/trace.go:171","msg":"trace[1167187166] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"477.426571ms","start":"2026-07-25T08:16:56.314071Z","end":"2026-07-25T08:16:56.791497Z","steps":["trace[1167187166] 'process raft request' (duration: 477.253577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.79164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.314056Z","time spent":"477.533184ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.791625Z","caller":"traceutil/trace.go:171","msg":"trace[10928630] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"477.366329ms","start":"2026-07-25T08:16:56.314244Z","end":"2026-07-25T08:16:56.79161Z","steps":["trace[10928630] 'process raft request' (duration: 477.187534ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.791793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.314238Z","time spent":"477.493322ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.791872Z","caller":"traceutil/trace.go:171","msg":"trace[455276500] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"470.352074ms","start":"2026-07-25T08:16:56.321512Z","end":"2026-07-25T08:16:56.791864Z","steps":["trace[455276500] 'process raft request' (duration: 470.084636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.791914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.321505Z","time spent":"470.389874ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.792019Z","caller":"traceutil/trace.go:171","msg":"trace[1520415148] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"468.170439ms","start":"2026-07-25T08:16:56.323784Z","end":"2026-07-25T08:16:56.791954Z","steps":["trace[1520415148] 'process raft request' (duration: 467.895512ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:56.791988Z","caller":"traceutil/trace.go:171","msg":"trace[141802579] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"469.82122ms","start":"2026-07-25T08:16:56.322127Z","end":"2026-07-25T08:16:56.791948Z","steps":["trace[141802579] 'process raft request' (duration: 469.513311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.79211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.323777Z","time spent":"468.292712ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T08:16:56.792181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.322119Z","time spent":"469.998865ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.792303Z","caller":"traceutil/trace.go:171","msg":"trace[371902948] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"471.923933ms","start":"2026-07-25T08:16:56.320366Z","end":"2026-07-25T08:16:56.79229Z","steps":["trace[371902948] 'process raft request' (duration: 471.120963ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.792371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.320308Z","time spent":"472.041045ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.792497Z","caller":"traceutil/trace.go:171","msg":"trace[551535120] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"467.853841ms","start":"2026-07-25T08:16:56.324632Z","end":"2026-07-25T08:16:56.792486Z","steps":["trace[551535120] 'process raft request' (duration: 467.089102ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.792553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.324626Z","time spent":"467.902982ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.792717Z","caller":"traceutil/trace.go:171","msg":"trace[159477161] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"462.179148ms","start":"2026-07-25T08:16:56.330528Z","end":"2026-07-25T08:16:56.792707Z","steps":["trace[159477161] 'process raft request' (duration: 461.260225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.792757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.330511Z","time spent":"462.226608ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.792792Z","caller":"traceutil/trace.go:171","msg":"trace[738833495] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"454.890024ms","start":"2026-07-25T08:16:56.337894Z","end":"2026-07-25T08:16:56.792784Z","steps":["trace[738833495] 'process raft request' (duration: 454.729771ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.792824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.337887Z","time spent":"454.922265ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.792879Z","caller":"traceutil/trace.go:171","msg":"trace[1319338001] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"434.016939ms","start":"2026-07-25T08:16:56.358857Z","end":"2026-07-25T08:16:56.792874Z","steps":["trace[1319338001] 'process raft request' (duration: 433.858355ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.792909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.358842Z","time spent":"434.054849ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.792928Z","caller":"traceutil/trace.go:171","msg":"trace[2076320313] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"309.191705ms","start":"2026-07-25T08:16:56.483726Z","end":"2026-07-25T08:16:56.792917Z","steps":["trace[2076320313] 'process raft request' (duration: 309.076432ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.792993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.483706Z","time spent":"309.246396ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T08:16:56.793062Z","caller":"traceutil/trace.go:171","msg":"trace[856292656] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:520; }","duration":"331.034335ms","start":"2026-07-25T08:16:56.462014Z","end":"2026-07-25T08:16:56.793048Z","steps":["trace[856292656] 'read index received' (duration: 320.947021ms)","trace[856292656] 'applied index is now lower than readState.Index' (duration: 10.086524ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:16:56.793256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.22514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-25T08:16:56.793301Z","caller":"traceutil/trace.go:171","msg":"trace[2048910260] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:511; }","duration":"331.317583ms","start":"2026-07-25T08:16:56.461976Z","end":"2026-07-25T08:16:56.793294Z","steps":["trace[2048910260] 'agreement among raft nodes before linearized reading' (duration: 331.153729ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:16:56.793329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:16:56.461957Z","time spent":"331.365003ms","remote":"127.0.0.1:58842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.205\" "} {"level":"warn","ts":"2026-07-25T08:16:56.795186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.854858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:16:56.795229Z","caller":"traceutil/trace.go:171","msg":"trace[945145939] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"260.93359ms","start":"2026-07-25T08:16:56.534284Z","end":"2026-07-25T08:16:56.795218Z","steps":["trace[945145939] 'agreement among raft nodes before linearized reading' (duration: 260.834687ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:16:57.673032Z","caller":"traceutil/trace.go:171","msg":"trace[1460474095] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"113.67369ms","start":"2026-07-25T08:16:57.559338Z","end":"2026-07-25T08:16:57.673011Z","steps":["trace[1460474095] 'process raft request' (duration: 109.980818ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:01.841905Z","caller":"traceutil/trace.go:171","msg":"trace[1054670152] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"135.755162ms","start":"2026-07-25T08:17:01.706125Z","end":"2026-07-25T08:17:01.84188Z","steps":["trace[1054670152] 'read index received' (duration: 134.549442ms)","trace[1054670152] 'applied index is now lower than readState.Index' (duration: 1.20469ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:17:01.841965Z","caller":"traceutil/trace.go:171","msg":"trace[1142532579] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"157.714133ms","start":"2026-07-25T08:17:01.684218Z","end":"2026-07-25T08:17:01.841933Z","steps":["trace[1142532579] 'process raft request' (duration: 156.816722ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:17:01.842097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.944786ms","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-25T08:17:01.842154Z","caller":"traceutil/trace.go:171","msg":"trace[428704083] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:594; }","duration":"136.06181ms","start":"2026-07-25T08:17:01.706076Z","end":"2026-07-25T08:17:01.842138Z","steps":["trace[428704083] 'agreement among raft nodes before linearized reading' (duration: 135.951636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:17:01.842561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.443156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-25T08:17:01.842619Z","caller":"traceutil/trace.go:171","msg":"trace[1311072085] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:594; }","duration":"133.525028ms","start":"2026-07-25T08:17:01.70908Z","end":"2026-07-25T08:17:01.842605Z","steps":["trace[1311072085] 'agreement among raft nodes before linearized reading' (duration: 133.337553ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:03.963862Z","caller":"traceutil/trace.go:171","msg":"trace[751746376] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:633; }","duration":"101.392042ms","start":"2026-07-25T08:17:03.862436Z","end":"2026-07-25T08:17:03.963828Z","steps":["trace[751746376] 'read index received' (duration: 100.350668ms)","trace[751746376] 'applied index is now lower than readState.Index' (duration: 1.040194ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:17:03.963996Z","caller":"traceutil/trace.go:171","msg":"trace[1447180492] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"153.133328ms","start":"2026-07-25T08:17:03.810851Z","end":"2026-07-25T08:17:03.963984Z","steps":["trace[1447180492] 'process raft request' (duration: 152.244937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:17:03.964294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.854203ms","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-25T08:17:03.964336Z","caller":"traceutil/trace.go:171","msg":"trace[996438086] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:609; }","duration":"101.909645ms","start":"2026-07-25T08:17:03.862414Z","end":"2026-07-25T08:17:03.964324Z","steps":["trace[996438086] 'agreement among raft nodes before linearized reading' (duration: 101.766902ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:04.219003Z","caller":"traceutil/trace.go:171","msg":"trace[780446618] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"249.039223ms","start":"2026-07-25T08:17:03.969926Z","end":"2026-07-25T08:17:04.218966Z","steps":["trace[780446618] 'process raft request' (duration: 248.849688ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:04.261247Z","caller":"traceutil/trace.go:171","msg":"trace[474695957] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:634; }","duration":"156.434031ms","start":"2026-07-25T08:17:04.104789Z","end":"2026-07-25T08:17:04.261223Z","steps":["trace[474695957] 'read index received' (duration: 114.036695ms)","trace[474695957] 'applied index is now lower than readState.Index' (duration: 42.396236ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:17:04.261364Z","caller":"traceutil/trace.go:171","msg":"trace[754321044] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"291.141551ms","start":"2026-07-25T08:17:03.970198Z","end":"2026-07-25T08:17:04.26134Z","steps":["trace[754321044] 'process raft request' (duration: 290.953687ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:17:04.261558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.756188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-b8gkn\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-25T08:17:04.261572Z","caller":"traceutil/trace.go:171","msg":"trace[1257153252] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"291.440788ms","start":"2026-07-25T08:17:03.969973Z","end":"2026-07-25T08:17:04.261414Z","steps":["trace[1257153252] 'process raft request' (duration: 291.06935ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:04.261615Z","caller":"traceutil/trace.go:171","msg":"trace[2063482644] range","detail":"{range_begin:/registry/pods/kube-system/cilium-b8gkn; range_end:; response_count:1; response_revision:613; }","duration":"156.87131ms","start":"2026-07-25T08:17:04.10473Z","end":"2026-07-25T08:17:04.261602Z","steps":["trace[2063482644] 'agreement among raft nodes before linearized reading' (duration: 156.644725ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:04.261742Z","caller":"traceutil/trace.go:171","msg":"trace[1013183581] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"232.72896ms","start":"2026-07-25T08:17:04.02867Z","end":"2026-07-25T08:17:04.261399Z","steps":["trace[1013183581] 'process raft request' (duration: 232.518205ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:17:04.775763Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844984463072803,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-25T08:17:05.300132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.962574ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-25T08:17:05.300246Z","caller":"traceutil/trace.go:171","msg":"trace[1862956756] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"1.025434411s","start":"2026-07-25T08:17:04.274795Z","end":"2026-07-25T08:17:05.300229Z","steps":["trace[1862956756] 'read index received' (duration: 560.441393ms)","trace[1862956756] 'applied index is now lower than readState.Index' (duration: 464.991248ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:17:05.300348Z","caller":"traceutil/trace.go:171","msg":"trace[2080592165] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.025615554s","start":"2026-07-25T08:17:04.274718Z","end":"2026-07-25T08:17:05.300333Z","steps":["trace[2080592165] 'process raft request' (duration: 560.614346ms)","trace[2080592165] 'compare' (duration: 463.757518ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:17:05.300427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:17:04.274681Z","time spent":"1.025707466s","remote":"127.0.0.1:58990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-25T08:17:05.300613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.178521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:17:05.300714Z","caller":"traceutil/trace.go:171","msg":"trace[2033092107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:614; }","duration":"766.293045ms","start":"2026-07-25T08:17:04.534401Z","end":"2026-07-25T08:17:05.300694Z","steps":["trace[2033092107] 'agreement among raft nodes before linearized reading' (duration: 766.136621ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:17:05.300848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:17:04.53434Z","time spent":"766.493899ms","remote":"127.0.0.1:58812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-25T08:17:05.300923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.026089526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T08:17:05.301025Z","caller":"traceutil/trace.go:171","msg":"trace[1476609873] range","detail":"{range_begin:/registry/limitranges/envoy-gateway-system/; range_end:/registry/limitranges/envoy-gateway-system0; response_count:0; response_revision:614; }","duration":"1.026203799s","start":"2026-07-25T08:17:04.274792Z","end":"2026-07-25T08:17:05.300996Z","steps":["trace[1476609873] 'agreement among raft nodes before linearized reading' (duration: 1.025995014s)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:17:05.301081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T08:17:04.274766Z","time spent":"1.02630055s","remote":"127.0.0.1:58962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/envoy-gateway-system/\" range_end:\"/registry/limitranges/envoy-gateway-system0\" "} {"level":"warn","ts":"2026-07-25T08:17:05.301087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.746491ms","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-25T08:17:05.301146Z","caller":"traceutil/trace.go:171","msg":"trace[1894856059] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:614; }","duration":"252.825244ms","start":"2026-07-25T08:17:05.048302Z","end":"2026-07-25T08:17:05.301127Z","steps":["trace[1894856059] 'agreement among raft nodes before linearized reading' (duration: 252.552568ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:06.40807Z","caller":"traceutil/trace.go:171","msg":"trace[2018827257] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"143.605567ms","start":"2026-07-25T08:17:06.264436Z","end":"2026-07-25T08:17:06.408042Z","steps":["trace[2018827257] 'read index received' (duration: 69.602598ms)","trace[2018827257] 'applied index is now lower than readState.Index' (duration: 74.001739ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:17:06.408346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.904715ms","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-25T08:17:06.408381Z","caller":"traceutil/trace.go:171","msg":"trace[1883340442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"143.995697ms","start":"2026-07-25T08:17:06.264377Z","end":"2026-07-25T08:17:06.408373Z","steps":["trace[1883340442] 'agreement among raft nodes before linearized reading' (duration: 143.912295ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:06.408459Z","caller":"traceutil/trace.go:171","msg":"trace[1930731516] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"179.876976ms","start":"2026-07-25T08:17:06.228559Z","end":"2026-07-25T08:17:06.408436Z","steps":["trace[1930731516] 'process raft request' (duration: 105.477967ms)","trace[1930731516] 'compare' (duration: 73.884137ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:17:06.408504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.316611ms","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-25T08:17:06.408587Z","caller":"traceutil/trace.go:171","msg":"trace[1604228336] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"143.471624ms","start":"2026-07-25T08:17:06.265097Z","end":"2026-07-25T08:17:06.408569Z","steps":["trace[1604228336] 'agreement among raft nodes before linearized reading' (duration: 143.27743ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:20.450875Z","caller":"traceutil/trace.go:171","msg":"trace[652920596] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"243.27817ms","start":"2026-07-25T08:17:20.207574Z","end":"2026-07-25T08:17:20.450853Z","steps":["trace[652920596] 'process raft request' (duration: 243.099347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T08:17:53.704425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.273004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-25T08:17:53.704454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.496629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-25T08:17:53.704503Z","caller":"traceutil/trace.go:171","msg":"trace[660721052] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1010; }","duration":"169.398685ms","start":"2026-07-25T08:17:53.535091Z","end":"2026-07-25T08:17:53.704489Z","steps":["trace[660721052] 'range keys from in-memory index tree' (duration: 169.118531ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:53.704537Z","caller":"traceutil/trace.go:171","msg":"trace[437049617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1010; }","duration":"154.650202ms","start":"2026-07-25T08:17:53.549867Z","end":"2026-07-25T08:17:53.704518Z","steps":["trace[437049617] 'range keys from in-memory index tree' (duration: 154.289436ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:17:54.244801Z","caller":"traceutil/trace.go:171","msg":"trace[1225456579] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"110.936463ms","start":"2026-07-25T08:17:54.133842Z","end":"2026-07-25T08:17:54.244779Z","steps":["trace[1225456579] 'process raft request' (duration: 107.005853ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:18:45.31306Z","caller":"traceutil/trace.go:171","msg":"trace[579565701] linearizableReadLoop","detail":"{readStateIndex:1230; appliedIndex:1229; }","duration":"139.306836ms","start":"2026-07-25T08:18:45.173728Z","end":"2026-07-25T08:18:45.313035Z","steps":["trace[579565701] 'read index received' (duration: 106.382811ms)","trace[579565701] 'applied index is now lower than readState.Index' (duration: 32.922925ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:18:45.313315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.54254ms","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-25T08:18:45.313359Z","caller":"traceutil/trace.go:171","msg":"trace[2003839654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1182; }","duration":"139.636411ms","start":"2026-07-25T08:18:45.173709Z","end":"2026-07-25T08:18:45.313345Z","steps":["trace[2003839654] 'agreement among raft nodes before linearized reading' (duration: 139.430467ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:18:45.313433Z","caller":"traceutil/trace.go:171","msg":"trace[116101518] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"140.211209ms","start":"2026-07-25T08:18:45.1732Z","end":"2026-07-25T08:18:45.313412Z","steps":["trace[116101518] 'process raft request' (duration: 106.922618ms)","trace[116101518] 'compare' (duration: 32.653121ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:18:54.208864Z","caller":"traceutil/trace.go:171","msg":"trace[573856240] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"103.350905ms","start":"2026-07-25T08:18:54.105482Z","end":"2026-07-25T08:18:54.208833Z","steps":["trace[573856240] 'process raft request' (duration: 103.185393ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:19:17.940335Z","caller":"traceutil/trace.go:171","msg":"trace[2033294173] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"105.652886ms","start":"2026-07-25T08:19:17.834651Z","end":"2026-07-25T08:19:17.940304Z","steps":["trace[2033294173] 'process raft request' (duration: 105.296791ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:19:29.818541Z","caller":"traceutil/trace.go:171","msg":"trace[582739591] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"105.691792ms","start":"2026-07-25T08:19:29.71279Z","end":"2026-07-25T08:19:29.818482Z","steps":["trace[582739591] 'process raft request' (duration: 90.364079ms)","trace[582739591] 'compare' (duration: 15.072049ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:19:30.047652Z","caller":"traceutil/trace.go:171","msg":"trace[1217987712] linearizableReadLoop","detail":"{readStateIndex:1393; appliedIndex:1392; }","duration":"146.979938ms","start":"2026-07-25T08:19:29.900646Z","end":"2026-07-25T08:19:30.047626Z","steps":["trace[1217987712] 'read index received' (duration: 63.313512ms)","trace[1217987712] 'applied index is now lower than readState.Index' (duration: 83.665236ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T08:19:30.047711Z","caller":"traceutil/trace.go:171","msg":"trace[2077522519] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"147.364392ms","start":"2026-07-25T08:19:29.900303Z","end":"2026-07-25T08:19:30.047668Z","steps":["trace[2077522519] 'process raft request' (duration: 63.599025ms)","trace[2077522519] 'compare' (duration: 83.606515ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T08:19:30.047975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.303542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5548"} {"level":"info","ts":"2026-07-25T08:19:30.048192Z","caller":"traceutil/trace.go:171","msg":"trace[1766177653] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1335; }","duration":"147.562476ms","start":"2026-07-25T08:19:29.900612Z","end":"2026-07-25T08:19:30.048175Z","steps":["trace[1766177653] 'agreement among raft nodes before linearized reading' (duration: 147.17624ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T08:19:46.281701Z","caller":"traceutil/trace.go:171","msg":"trace[764906373] transaction","detail":"{read_only:false; response_revision:1421; number_of_response:1; }","duration":"106.905343ms","start":"2026-07-25T08:19:46.174764Z","end":"2026-07-25T08:19:46.281669Z","steps":["trace[764906373] 'process raft request' (duration: 100.598576ms)"],"step_count":1}