{"level":"warn","ts":"2026-10-15T11:09:33.562517Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T11:09:33.5626Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.36: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.36:2380","--initial-cluster=instance=https://199.204.45.36:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.36:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.36: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-10-15T11:09:33.562838Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T11:09:33.562856Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.36:2380"]} {"level":"info","ts":"2026-10-15T11:09:33.562967Z","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-10-15T11:09:33.563964Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.36:2379"]} {"level":"info","ts":"2026-10-15T11:09:33.564145Z","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.36:2380"],"listen-peer-urls":["https://199.204.45.36:2380"],"advertise-client-urls":["https://199.204.45.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.36: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-10-15T11:09:33.570355Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.851553ms"} {"level":"info","ts":"2026-10-15T11:09:33.582663Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a30ca6eb95c95e8","cluster-id":"3edbb69a95d624a9"} {"level":"info","ts":"2026-10-15T11:09:33.58274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T11:09:33.582766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 became follower at term 0"} {"level":"info","ts":"2026-10-15T11:09:33.582807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a30ca6eb95c95e8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T11:09:33.582823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 became follower at term 1"} {"level":"info","ts":"2026-10-15T11:09:33.582884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 switched to configuration voters=(7651838343807538664)"} {"level":"warn","ts":"2026-10-15T11:09:33.59211Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T11:09:33.596107Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T11:09:33.597703Z","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-10-15T11:09:33.600404Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a30ca6eb95c95e8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T11:09:33.60054Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a30ca6eb95c95e8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T11:09:33.600691Z","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-10-15T11:09:33.600749Z","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-10-15T11:09:33.600774Z","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-10-15T11:09:33.602032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 switched to configuration voters=(7651838343807538664)"} {"level":"info","ts":"2026-10-15T11:09:33.602705Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3edbb69a95d624a9","local-member-id":"6a30ca6eb95c95e8","added-peer-id":"6a30ca6eb95c95e8","added-peer-peer-urls":["https://199.204.45.36:2380"]} {"level":"info","ts":"2026-10-15T11:09:33.603876Z","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-10-15T11:09:33.604015Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.36:2380"} {"level":"info","ts":"2026-10-15T11:09:33.604038Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.36:2380"} {"level":"info","ts":"2026-10-15T11:09:33.604153Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a30ca6eb95c95e8","initial-advertise-peer-urls":["https://199.204.45.36:2380"],"listen-peer-urls":["https://199.204.45.36:2380"],"advertise-client-urls":["https://199.204.45.36:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.36:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T11:09:33.60418Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T11:09:33.883655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T11:09:33.883855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T11:09:33.883972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 received MsgPreVoteResp from 6a30ca6eb95c95e8 at term 1"} {"level":"info","ts":"2026-10-15T11:09:33.884034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 became candidate at term 2"} {"level":"info","ts":"2026-10-15T11:09:33.884095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 received MsgVoteResp from 6a30ca6eb95c95e8 at term 2"} {"level":"info","ts":"2026-10-15T11:09:33.88415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a30ca6eb95c95e8 became leader at term 2"} {"level":"info","ts":"2026-10-15T11:09:33.884199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a30ca6eb95c95e8 elected leader 6a30ca6eb95c95e8 at term 2"} {"level":"info","ts":"2026-10-15T11:09:33.885507Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:09:33.886408Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a30ca6eb95c95e8","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.36:2379]}","request-path":"/0/members/6a30ca6eb95c95e8/attributes","cluster-id":"3edbb69a95d624a9","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T11:09:33.886449Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T11:09:33.886534Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T11:09:33.887057Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3edbb69a95d624a9","local-member-id":"6a30ca6eb95c95e8","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:09:33.88729Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:09:33.887379Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T11:09:33.887135Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T11:09:33.887477Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T11:09:33.890002Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T11:09:33.890784Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.36:2379"} {"level":"info","ts":"2026-10-15T11:09:38.904385Z","caller":"traceutil/trace.go:171","msg":"trace[2037830592] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"174.258556ms","start":"2026-10-15T11:09:38.730085Z","end":"2026-10-15T11:09:38.904343Z","steps":["trace[2037830592] 'process raft request' (duration: 173.597092ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:09:40.848112Z","caller":"traceutil/trace.go:171","msg":"trace[747840476] linearizableReadLoop","detail":"{readStateIndex:328; appliedIndex:327; }","duration":"255.560718ms","start":"2026-10-15T11:09:40.592527Z","end":"2026-10-15T11:09:40.848087Z","steps":["trace[747840476] 'read index received' (duration: 255.360763ms)","trace[747840476] 'applied index is now lower than readState.Index' (duration: 199.085µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:09:40.848202Z","caller":"traceutil/trace.go:171","msg":"trace[1837963787] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"314.54663ms","start":"2026-10-15T11:09:40.533627Z","end":"2026-10-15T11:09:40.848173Z","steps":["trace[1837963787] 'process raft request' (duration: 314.339026ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:40.848383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.350912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5892"} {"level":"info","ts":"2026-10-15T11:09:40.848503Z","caller":"traceutil/trace.go:171","msg":"trace[1835268393] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:317; }","duration":"254.495385ms","start":"2026-10-15T11:09:40.593994Z","end":"2026-10-15T11:09:40.848489Z","steps":["trace[1835268393] 'agreement among raft nodes before linearized reading' (duration: 254.326103ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:40.848534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.653138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-10-15T11:09:40.848587Z","caller":"traceutil/trace.go:171","msg":"trace[927506529] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:317; }","duration":"254.700019ms","start":"2026-10-15T11:09:40.59387Z","end":"2026-10-15T11:09:40.84857Z","steps":["trace[927506529] 'agreement among raft nodes before linearized reading' (duration: 254.629067ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:40.84838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.504075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"info","ts":"2026-10-15T11:09:40.848624Z","caller":"traceutil/trace.go:171","msg":"trace[131706201] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:317; }","duration":"254.793451ms","start":"2026-10-15T11:09:40.593822Z","end":"2026-10-15T11:09:40.848616Z","steps":["trace[131706201] 'agreement among raft nodes before linearized reading' (duration: 254.477945ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:40.848711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.440001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-10-15T11:09:40.848743Z","caller":"traceutil/trace.go:171","msg":"trace[834326404] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:317; }","duration":"318.983451ms","start":"2026-10-15T11:09:40.529751Z","end":"2026-10-15T11:09:40.848734Z","steps":["trace[834326404] 'agreement among raft nodes before linearized reading' (duration: 318.455441ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:40.848797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:09:40.529731Z","time spent":"319.056963ms","remote":"127.0.0.1:58620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-15T11:09:40.84894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:09:40.533603Z","time spent":"314.658082ms","remote":"127.0.0.1:58694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4307,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:09:41.083678Z","caller":"traceutil/trace.go:171","msg":"trace[163311394] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"149.668799ms","start":"2026-10-15T11:09:40.93398Z","end":"2026-10-15T11:09:41.083649Z","steps":["trace[163311394] 'process raft request' (duration: 112.329988ms)","trace[163311394] 'compare' (duration: 37.129878ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:09:41.166129Z","caller":"traceutil/trace.go:171","msg":"trace[1670666568] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"224.428486ms","start":"2026-10-15T11:09:40.941675Z","end":"2026-10-15T11:09:41.166103Z","steps":["trace[1670666568] 'process raft request' (duration: 224.241872ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:41.968714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.312858ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:09:41.968823Z","caller":"traceutil/trace.go:171","msg":"trace[252434732] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"793.349953ms","start":"2026-10-15T11:09:41.175452Z","end":"2026-10-15T11:09:41.968802Z","steps":["trace[252434732] 'process raft request' (duration: 136.708238ms)","trace[252434732] 'compare' (duration: 656.138554ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:09:41.968879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:09:41.17544Z","time spent":"793.415004ms","remote":"127.0.0.1:58708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":201,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T11:09:42.060504Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10802060999290261717,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-15T11:09:42.12033Z","caller":"traceutil/trace.go:171","msg":"trace[1814411462] linearizableReadLoop","detail":"{readStateIndex:334; appliedIndex:333; }","duration":"560.825059ms","start":"2026-10-15T11:09:41.559481Z","end":"2026-10-15T11:09:42.120306Z","steps":["trace[1814411462] 'read index received' (duration: 548.232499ms)","trace[1814411462] 'applied index is now lower than readState.Index' (duration: 12.59173ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:09:42.120435Z","caller":"traceutil/trace.go:171","msg":"trace[1399895046] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"941.507474ms","start":"2026-10-15T11:09:41.178867Z","end":"2026-10-15T11:09:42.120375Z","steps":["trace[1399895046] 'process raft request' (duration: 928.937975ms)","trace[1399895046] 'compare' (duration: 12.395395ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:09:42.120536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.041333ms","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-10-15T11:09:42.120581Z","caller":"traceutil/trace.go:171","msg":"trace[782934193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:323; }","duration":"561.136254ms","start":"2026-10-15T11:09:41.559435Z","end":"2026-10-15T11:09:42.120572Z","steps":["trace[782934193] 'agreement among raft nodes before linearized reading' (duration: 561.044272ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:42.120631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:09:41.559416Z","time spent":"561.207075ms","remote":"127.0.0.1:37928","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-10-15T11:09:42.120627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:09:41.178847Z","time spent":"941.690507ms","remote":"127.0.0.1:58694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7087,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:09:42.120807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.919624ms","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-10-15T11:09:42.12088Z","caller":"traceutil/trace.go:171","msg":"trace[1292861260] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:323; }","duration":"321.028316ms","start":"2026-10-15T11:09:41.799833Z","end":"2026-10-15T11:09:42.120862Z","steps":["trace[1292861260] 'agreement among raft nodes before linearized reading' (duration: 320.915794ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:42.12093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:09:41.799812Z","time spent":"321.105178ms","remote":"127.0.0.1:37928","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-10-15T11:09:42.121055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.646061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pv-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:09:42.121114Z","caller":"traceutil/trace.go:171","msg":"trace[935549926] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pv-protection-controller; range_end:; response_count:0; response_revision:323; }","duration":"148.739813ms","start":"2026-10-15T11:09:41.972358Z","end":"2026-10-15T11:09:42.121098Z","steps":["trace[935549926] 'agreement among raft nodes before linearized reading' (duration: 148.654961ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:09:43.594783Z","caller":"traceutil/trace.go:171","msg":"trace[156492462] linearizableReadLoop","detail":"{readStateIndex:377; appliedIndex:373; }","duration":"113.203243ms","start":"2026-10-15T11:09:43.481556Z","end":"2026-10-15T11:09:43.594759Z","steps":["trace[156492462] 'read index received' (duration: 29.254553ms)","trace[156492462] 'applied index is now lower than readState.Index' (duration: 83.94795ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:09:43.594847Z","caller":"traceutil/trace.go:171","msg":"trace[44749746] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"146.246954ms","start":"2026-10-15T11:09:43.448561Z","end":"2026-10-15T11:09:43.594808Z","steps":["trace[44749746] 'process raft request' (duration: 146.132323ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:09:43.595301Z","caller":"traceutil/trace.go:171","msg":"trace[334995345] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"146.762934ms","start":"2026-10-15T11:09:43.44801Z","end":"2026-10-15T11:09:43.594773Z","steps":["trace[334995345] 'process raft request' (duration: 146.649663ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:09:43.594875Z","caller":"traceutil/trace.go:171","msg":"trace[1072632422] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"146.865347ms","start":"2026-10-15T11:09:43.447981Z","end":"2026-10-15T11:09:43.594846Z","steps":["trace[1072632422] 'process raft request' (duration: 62.817034ms)","trace[1072632422] 'compare' (duration: 83.735977ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:09:43.597919Z","caller":"traceutil/trace.go:171","msg":"trace[543556463] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"142.598249ms","start":"2026-10-15T11:09:43.455085Z","end":"2026-10-15T11:09:43.597683Z","steps":["trace[543556463] 'process raft request' (duration: 139.646068ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:09:43.598858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.287687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-10-15T11:09:43.60011Z","caller":"traceutil/trace.go:171","msg":"trace[968015306] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:366; }","duration":"118.520493ms","start":"2026-10-15T11:09:43.481502Z","end":"2026-10-15T11:09:43.600023Z","steps":["trace[968015306] 'agreement among raft nodes before linearized reading' (duration: 113.702493ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:16.483564Z","caller":"traceutil/trace.go:171","msg":"trace[1968786940] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"108.098143ms","start":"2026-10-15T11:10:16.375441Z","end":"2026-10-15T11:10:16.483539Z","steps":["trace[1968786940] 'read index received' (duration: 107.93816ms)","trace[1968786940] 'applied index is now lower than readState.Index' (duration: 158.883µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:10:16.483663Z","caller":"traceutil/trace.go:171","msg":"trace[830961473] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"118.459656ms","start":"2026-10-15T11:10:16.365145Z","end":"2026-10-15T11:10:16.483605Z","steps":["trace[830961473] 'process raft request' (duration: 118.218922ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:16.483772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.306967ms","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-10-15T11:10:16.483841Z","caller":"traceutil/trace.go:171","msg":"trace[703925755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:532; }","duration":"108.43712ms","start":"2026-10-15T11:10:16.375387Z","end":"2026-10-15T11:10:16.483824Z","steps":["trace[703925755] 'agreement among raft nodes before linearized reading' (duration: 108.315337ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:16.48385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.137353ms","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-10-15T11:10:16.484069Z","caller":"traceutil/trace.go:171","msg":"trace[1222571851] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:532; }","duration":"108.373888ms","start":"2026-10-15T11:10:16.375673Z","end":"2026-10-15T11:10:16.484047Z","steps":["trace[1222571851] 'agreement among raft nodes before linearized reading' (duration: 108.135733ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:16.722464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.487944ms","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-10-15T11:10:16.722553Z","caller":"traceutil/trace.go:171","msg":"trace[1901249749] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:534; }","duration":"124.614026ms","start":"2026-10-15T11:10:16.597924Z","end":"2026-10-15T11:10:16.722538Z","steps":["trace[1901249749] 'range keys from in-memory index tree' (duration: 124.389772ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:17.908689Z","caller":"traceutil/trace.go:171","msg":"trace[906439622] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"115.710358ms","start":"2026-10-15T11:10:17.792956Z","end":"2026-10-15T11:10:17.908667Z","steps":["trace[906439622] 'process raft request' (duration: 115.040226ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:17.908982Z","caller":"traceutil/trace.go:171","msg":"trace[685917763] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"109.013027ms","start":"2026-10-15T11:10:17.799951Z","end":"2026-10-15T11:10:17.908964Z","steps":["trace[685917763] 'process raft request' (duration: 108.155741ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:17.909141Z","caller":"traceutil/trace.go:171","msg":"trace[821616344] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"105.877817ms","start":"2026-10-15T11:10:17.803254Z","end":"2026-10-15T11:10:17.909132Z","steps":["trace[821616344] 'process raft request' (duration: 104.921909ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:17.909238Z","caller":"traceutil/trace.go:171","msg":"trace[1142774921] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"105.294355ms","start":"2026-10-15T11:10:17.803936Z","end":"2026-10-15T11:10:17.909231Z","steps":["trace[1142774921] 'process raft request' (duration: 104.336557ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.432917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.245726ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:10:18.433399Z","caller":"traceutil/trace.go:171","msg":"trace[133979421] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"413.678934ms","start":"2026-10-15T11:10:18.019328Z","end":"2026-10-15T11:10:18.433007Z","steps":["trace[133979421] 'process raft request' (duration: 173.266024ms)","trace[133979421] 'compare' (duration: 240.032442ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:10:18.433516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.019321Z","time spent":"414.119012ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:10:18.441117Z","caller":"traceutil/trace.go:171","msg":"trace[1216914452] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"376.668509ms","start":"2026-10-15T11:10:18.064417Z","end":"2026-10-15T11:10:18.441085Z","steps":["trace[1216914452] 'process raft request' (duration: 376.332412ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.441293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.064399Z","time spent":"376.811561ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:10:18.441658Z","caller":"traceutil/trace.go:171","msg":"trace[964493567] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"369.336315ms","start":"2026-10-15T11:10:18.072305Z","end":"2026-10-15T11:10:18.441641Z","steps":["trace[964493567] 'process raft request' (duration: 368.59848ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.441737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.072284Z","time spent":"369.417047ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T11:10:18.442516Z","caller":"traceutil/trace.go:171","msg":"trace[566942387] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"337.706286ms","start":"2026-10-15T11:10:18.104794Z","end":"2026-10-15T11:10:18.4425Z","steps":["trace[566942387] 'process raft request' (duration: 337.361589ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.442607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.10477Z","time spent":"337.792648ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:10:18.80152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.697731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-15T11:10:18.801769Z","caller":"traceutil/trace.go:171","msg":"trace[11820571] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:593; }","duration":"311.748377ms","start":"2026-10-15T11:10:18.489972Z","end":"2026-10-15T11:10:18.80172Z","steps":["trace[11820571] 'read index received' (duration: 9.063138ms)","trace[11820571] 'applied index is now lower than readState.Index' (duration: 302.684299ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:10:18.801755Z","caller":"traceutil/trace.go:171","msg":"trace[1715066040] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"343.239325ms","start":"2026-10-15T11:10:18.458465Z","end":"2026-10-15T11:10:18.801705Z","steps":["trace[1715066040] 'process raft request' (duration: 89.27662ms)","trace[1715066040] 'compare' (duration: 253.478886ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:10:18.801883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.458436Z","time spent":"343.386457ms","remote":"127.0.0.1:38192","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T11:10:18.802077Z","caller":"traceutil/trace.go:171","msg":"trace[1969877833] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"332.884701ms","start":"2026-10-15T11:10:18.469179Z","end":"2026-10-15T11:10:18.802063Z","steps":["trace[1969877833] 'process raft request' (duration: 332.458514ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.802223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.469156Z","time spent":"332.985703ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:10:18.802346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.322138ms","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-10-15T11:10:18.80243Z","caller":"traceutil/trace.go:171","msg":"trace[15611790] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:573; }","duration":"312.489221ms","start":"2026-10-15T11:10:18.489924Z","end":"2026-10-15T11:10:18.802413Z","steps":["trace[15611790] 'agreement among raft nodes before linearized reading' (duration: 312.314228ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.802553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.489902Z","time spent":"312.559042ms","remote":"127.0.0.1:37928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-15T11:10:18.95768Z","caller":"traceutil/trace.go:171","msg":"trace[287548422] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"440.159983ms","start":"2026-10-15T11:10:18.517491Z","end":"2026-10-15T11:10:18.957651Z","steps":["trace[287548422] 'process raft request' (duration: 408.247337ms)","trace[287548422] 'compare' (duration: 31.675001ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:10:18.957732Z","caller":"traceutil/trace.go:171","msg":"trace[1540418744] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"399.416846ms","start":"2026-10-15T11:10:18.558273Z","end":"2026-10-15T11:10:18.95769Z","steps":["trace[1540418744] 'process raft request' (duration: 399.296383ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.957851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.517466Z","time spent":"440.308266ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T11:10:18.957873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.558251Z","time spent":"399.556008ms","remote":"127.0.0.1:58550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T11:10:18.95812Z","caller":"traceutil/trace.go:171","msg":"trace[571545930] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"156.292523ms","start":"2026-10-15T11:10:18.801806Z","end":"2026-10-15T11:10:18.958099Z","steps":["trace[571545930] 'read index received' (duration: 123.980049ms)","trace[571545930] 'applied index is now lower than readState.Index' (duration: 32.311674ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:10:18.958224Z","caller":"traceutil/trace.go:171","msg":"trace[183937356] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"146.329137ms","start":"2026-10-15T11:10:18.811886Z","end":"2026-10-15T11:10:18.958215Z","steps":["trace[183937356] 'process raft request' (duration: 146.122353ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:18.958302Z","caller":"traceutil/trace.go:171","msg":"trace[1395825616] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"151.307015ms","start":"2026-10-15T11:10:18.806974Z","end":"2026-10-15T11:10:18.958281Z","steps":["trace[1395825616] 'process raft request' (duration: 150.656212ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.958326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.569706ms","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-10-15T11:10:18.958376Z","caller":"traceutil/trace.go:171","msg":"trace[1674313329] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"210.666417ms","start":"2026-10-15T11:10:18.747696Z","end":"2026-10-15T11:10:18.958362Z","steps":["trace[1674313329] 'agreement among raft nodes before linearized reading' (duration: 210.555905ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.958829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.559603ms","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-10-15T11:10:18.958859Z","caller":"traceutil/trace.go:171","msg":"trace[1757075839] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"431.621235ms","start":"2026-10-15T11:10:18.52723Z","end":"2026-10-15T11:10:18.958852Z","steps":["trace[1757075839] 'agreement among raft nodes before linearized reading' (duration: 431.571134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.958875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.527186Z","time spent":"431.684306ms","remote":"127.0.0.1:37928","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-10-15T11:10:18.958908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.903515ms","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-10-15T11:10:18.958984Z","caller":"traceutil/trace.go:171","msg":"trace[920709108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"446.008716ms","start":"2026-10-15T11:10:18.512955Z","end":"2026-10-15T11:10:18.958964Z","steps":["trace[920709108] 'agreement among raft nodes before linearized reading' (duration: 445.888664ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:18.959034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:18.512937Z","time spent":"446.085528ms","remote":"127.0.0.1:37928","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":"info","ts":"2026-10-15T11:10:25.031809Z","caller":"traceutil/trace.go:171","msg":"trace[321856599] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"155.293262ms","start":"2026-10-15T11:10:24.876492Z","end":"2026-10-15T11:10:25.031785Z","steps":["trace[321856599] 'read index received' (duration: 153.944296ms)","trace[321856599] 'applied index is now lower than readState.Index' (duration: 1.347996ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:10:25.031908Z","caller":"traceutil/trace.go:171","msg":"trace[272239426] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"246.342645ms","start":"2026-10-15T11:10:24.785537Z","end":"2026-10-15T11:10:25.03188Z","steps":["trace[272239426] 'process raft request' (duration: 245.330425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:25.032016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.494396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:10:25.032082Z","caller":"traceutil/trace.go:171","msg":"trace[349984531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"155.612928ms","start":"2026-10-15T11:10:24.876451Z","end":"2026-10-15T11:10:25.032064Z","steps":["trace[349984531] 'agreement among raft nodes before linearized reading' (duration: 155.488736ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:25.666285Z","caller":"traceutil/trace.go:171","msg":"trace[921147109] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"627.992191ms","start":"2026-10-15T11:10:25.038261Z","end":"2026-10-15T11:10:25.666253Z","steps":["trace[921147109] 'process raft request' (duration: 607.189657ms)","trace[921147109] 'compare' (duration: 20.440508ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T11:10:25.666422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:25.038237Z","time spent":"628.114933ms","remote":"127.0.0.1:37928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:10:25.666397Z","caller":"traceutil/trace.go:171","msg":"trace[1370059869] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"628.014641ms","start":"2026-10-15T11:10:25.038357Z","end":"2026-10-15T11:10:25.666372Z","steps":["trace[1370059869] 'process raft request' (duration: 627.766047ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:25.667356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:25.038329Z","time spent":"628.942999ms","remote":"127.0.0.1:37928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T11:10:25.673695Z","caller":"traceutil/trace.go:171","msg":"trace[1918623498] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"580.507598ms","start":"2026-10-15T11:10:25.093073Z","end":"2026-10-15T11:10:25.673581Z","steps":["trace[1918623498] 'process raft request' (duration: 580.344895ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:25.67387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T11:10:25.093044Z","time spent":"580.737833ms","remote":"127.0.0.1:38168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T11:10:41.828831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.045962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nxsc6\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-10-15T11:10:41.829515Z","caller":"traceutil/trace.go:171","msg":"trace[1917948077] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nxsc6; range_end:; response_count:1; response_revision:814; }","duration":"107.765986ms","start":"2026-10-15T11:10:41.721717Z","end":"2026-10-15T11:10:41.829483Z","steps":["trace[1917948077] 'range keys from in-memory index tree' (duration: 106.865388ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:42.017564Z","caller":"traceutil/trace.go:171","msg":"trace[718474956] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"183.990477ms","start":"2026-10-15T11:10:41.83355Z","end":"2026-10-15T11:10:42.017541Z","steps":["trace[718474956] 'process raft request' (duration: 183.862574ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:42.088541Z","caller":"traceutil/trace.go:171","msg":"trace[1910281839] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"253.299714ms","start":"2026-10-15T11:10:41.835211Z","end":"2026-10-15T11:10:42.088511Z","steps":["trace[1910281839] 'process raft request' (duration: 253.059049ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:42.088825Z","caller":"traceutil/trace.go:171","msg":"trace[875990332] linearizableReadLoop","detail":"{readStateIndex:846; appliedIndex:844; }","duration":"212.638714ms","start":"2026-10-15T11:10:41.876163Z","end":"2026-10-15T11:10:42.088802Z","steps":["trace[875990332] 'read index received' (duration: 141.38764ms)","trace[875990332] 'applied index is now lower than readState.Index' (duration: 71.249814ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T11:10:42.088918Z","caller":"traceutil/trace.go:171","msg":"trace[1897838612] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"251.088191ms","start":"2026-10-15T11:10:41.837812Z","end":"2026-10-15T11:10:42.0889Z","steps":["trace[1897838612] 'process raft request' (duration: 250.635113ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T11:10:42.088944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.764227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T11:10:42.088975Z","caller":"traceutil/trace.go:171","msg":"trace[240710504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:817; }","duration":"212.841289ms","start":"2026-10-15T11:10:41.876123Z","end":"2026-10-15T11:10:42.088964Z","steps":["trace[240710504] 'agreement among raft nodes before linearized reading' (duration: 212.762837ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T11:10:54.41314Z","caller":"traceutil/trace.go:171","msg":"trace[1762930220] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"101.712952ms","start":"2026-10-15T11:10:54.311396Z","end":"2026-10-15T11:10:54.413109Z","steps":["trace[1762930220] 'process raft request' (duration: 101.539998ms)"],"step_count":1}