{"level":"warn","ts":"2026-06-12T03:07:48.304185Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-12T03:07:48.30426Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250: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-06-12T03:07:48.304318Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-12T03:07:48.304327Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-06-12T03:07:48.304345Z","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-06-12T03:07:48.3059Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-06-12T03:07:48.305978Z","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.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250: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-06-12T03:07:48.309974Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.792663ms"} {"level":"info","ts":"2026-06-12T03:07:48.32174Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-06-12T03:07:48.321809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-06-12T03:07:48.32186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-06-12T03:07:48.321881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-12T03:07:48.32189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-06-12T03:07:48.321945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-06-12T03:07:48.328871Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-12T03:07:48.330231Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-12T03:07:48.331504Z","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-06-12T03:07:48.335672Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-12T03:07:48.335924Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-12T03:07:48.33635Z","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-06-12T03:07:48.336891Z","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-06-12T03:07:48.336965Z","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-06-12T03:07:48.338851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-06-12T03:07:48.339231Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-06-12T03:07:48.340297Z","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-06-12T03:07:48.341305Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-12T03:07:48.341335Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-12T03:07:48.34148Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-06-12T03:07:48.341493Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-06-12T03:07:48.92259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-06-12T03:07:48.922645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-12T03:07:48.922685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-06-12T03:07:48.922704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-06-12T03:07:48.922715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-06-12T03:07:48.922731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-06-12T03:07:48.922744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-06-12T03:07:48.923892Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T03:07:48.924796Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-06-12T03:07:48.924861Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-12T03:07:48.925036Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-12T03:07:48.925208Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T03:07:48.925304Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-12T03:07:48.925311Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T03:07:48.925332Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-12T03:07:48.925346Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T03:07:48.929467Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-06-12T03:07:48.930228Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-12T03:07:52.226593Z","caller":"traceutil/trace.go:171","msg":"trace[1579983633] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"346.545513ms","start":"2026-06-12T03:07:51.880017Z","end":"2026-06-12T03:07:52.226562Z","steps":["trace[1579983633] 'process raft request' (duration: 346.391487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:52.227757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:51.879988Z","time spent":"346.690098ms","remote":"127.0.0.1:34748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:07:52.232006Z","caller":"traceutil/trace.go:171","msg":"trace[1770063554] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"127.062736ms","start":"2026-06-12T03:07:52.104929Z","end":"2026-06-12T03:07:52.231992Z","steps":["trace[1770063554] 'process raft request' (duration: 127.033785ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:07:52.23215Z","caller":"traceutil/trace.go:171","msg":"trace[1052210113] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"316.045708ms","start":"2026-06-12T03:07:51.916066Z","end":"2026-06-12T03:07:52.232112Z","steps":["trace[1052210113] 'process raft request' (duration: 315.805039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:52.232347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:51.916036Z","time spent":"316.259856ms","remote":"127.0.0.1:34772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1069,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:07:53.255142Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186920266163250,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-12T03:07:53.430148Z","caller":"traceutil/trace.go:171","msg":"trace[219857505] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"720.296805ms","start":"2026-06-12T03:07:52.709828Z","end":"2026-06-12T03:07:53.430125Z","steps":["trace[219857505] 'process raft request' (duration: 720.14672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:53.430407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:52.709812Z","time spent":"720.507142ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:07:54.759517Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.32952643s","expected-duration":"1s"} {"level":"info","ts":"2026-06-12T03:07:54.759872Z","caller":"traceutil/trace.go:171","msg":"trace[1294867346] linearizableReadLoop","detail":"{readStateIndex:253; appliedIndex:251; }","duration":"2.005738704s","start":"2026-06-12T03:07:52.754105Z","end":"2026-06-12T03:07:54.759844Z","steps":["trace[1294867346] 'read index received' (duration: 675.887174ms)","trace[1294867346] 'applied index is now lower than readState.Index' (duration: 1.3298505s)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:07:54.76003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.878050916s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:07:54.760085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.314138085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:07:54.760097Z","caller":"traceutil/trace.go:171","msg":"trace[414149271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:247; }","duration":"1.878182631s","start":"2026-06-12T03:07:52.881902Z","end":"2026-06-12T03:07:54.760084Z","steps":["trace[414149271] 'agreement among raft nodes before linearized reading' (duration: 1.878044767s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.760098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.005974863s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"info","ts":"2026-06-12T03:07:54.760139Z","caller":"traceutil/trace.go:171","msg":"trace[709959444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:247; }","duration":"1.314192416s","start":"2026-06-12T03:07:53.445931Z","end":"2026-06-12T03:07:54.760123Z","steps":["trace[709959444] 'agreement among raft nodes before linearized reading' (duration: 1.314099103s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.760113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.650393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:07:54.760178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.445885Z","time spent":"1.314285389s","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-12T03:07:54.76019Z","caller":"traceutil/trace.go:171","msg":"trace[1379230795] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:247; }","duration":"2.006077366s","start":"2026-06-12T03:07:52.754086Z","end":"2026-06-12T03:07:54.760163Z","steps":["trace[1379230795] 'agreement among raft nodes before linearized reading' (duration: 2.005865119s)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:07:54.760219Z","caller":"traceutil/trace.go:171","msg":"trace[55655064] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:247; }","duration":"436.792747ms","start":"2026-06-12T03:07:54.323399Z","end":"2026-06-12T03:07:54.760192Z","steps":["trace[55655064] 'agreement among raft nodes before linearized reading' (duration: 436.602891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.760238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:52.753968Z","time spent":"2.006262192s","remote":"127.0.0.1:34820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3516,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-12T03:07:54.760276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:54.323386Z","time spent":"436.88012ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T03:07:54.760142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:52.88188Z","time spent":"1.878253473s","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-12T03:07:54.760394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325110592s","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-06-12T03:07:54.760491Z","caller":"traceutil/trace.go:171","msg":"trace[526212574] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:247; }","duration":"1.325203315s","start":"2026-06-12T03:07:53.435228Z","end":"2026-06-12T03:07:54.760431Z","steps":["trace[526212574] 'agreement among raft nodes before linearized reading' (duration: 1.324818992s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.760579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:53.43521Z","time spent":"1.32536157s","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-12T03:07:54.75993Z","caller":"traceutil/trace.go:171","msg":"trace[102783325] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"1.995116815s","start":"2026-06-12T03:07:52.764761Z","end":"2026-06-12T03:07:54.759878Z","steps":["trace[102783325] 'process raft request' (duration: 1.99495637s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:54.760799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:52.764735Z","time spent":"1.996006605s","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:07:55.217246Z","caller":"traceutil/trace.go:171","msg":"trace[396083516] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"416.758264ms","start":"2026-06-12T03:07:54.800462Z","end":"2026-06-12T03:07:55.21722Z","steps":["trace[396083516] 'process raft request' (duration: 416.709822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:55.217413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:54.800453Z","time spent":"416.878397ms","remote":"127.0.0.1:34820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:07:55.217435Z","caller":"traceutil/trace.go:171","msg":"trace[316187994] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"418.721848ms","start":"2026-06-12T03:07:54.798656Z","end":"2026-06-12T03:07:55.217378Z","steps":["trace[316187994] 'process raft request' (duration: 418.330705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:07:55.217582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:54.798639Z","time spent":"418.866132ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:07:55.217518Z","caller":"traceutil/trace.go:171","msg":"trace[754534574] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"417.811798ms","start":"2026-06-12T03:07:54.799589Z","end":"2026-06-12T03:07:55.217401Z","steps":["trace[754534574] 'process raft request' (duration: 417.528758ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:07:55.217656Z","caller":"traceutil/trace.go:171","msg":"trace[40167958] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"418.910354ms","start":"2026-06-12T03:07:54.798703Z","end":"2026-06-12T03:07:55.217614Z","steps":["trace[40167958] 'process raft request' (duration: 418.380986ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:07:55.217771Z","caller":"traceutil/trace.go:171","msg":"trace[34717130] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"420.206177ms","start":"2026-06-12T03:07:54.797525Z","end":"2026-06-12T03:07:55.217731Z","steps":["trace[34717130] 'process raft request' (duration: 405.566777ms)","trace[34717130] 'compare' (duration: 13.377349ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:07:55.217826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:54.799566Z","time spent":"418.128478ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:07:55.217862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:54.7987Z","time spent":"419.076909ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:07:55.217956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:07:54.797509Z","time spent":"420.357112ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:28.27729Z","caller":"traceutil/trace.go:171","msg":"trace[63128683] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"644.751879ms","start":"2026-06-12T03:08:27.632451Z","end":"2026-06-12T03:08:28.277203Z","steps":["trace[63128683] 'process raft request' (duration: 644.557104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.277694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.632426Z","time spent":"645.143039ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:28.430017Z","caller":"traceutil/trace.go:171","msg":"trace[127027079] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"793.070945ms","start":"2026-06-12T03:08:27.636906Z","end":"2026-06-12T03:08:28.429976Z","steps":["trace[127027079] 'process raft request' (duration: 792.84192ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:28.430279Z","caller":"traceutil/trace.go:171","msg":"trace[1891890362] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"781.89013ms","start":"2026-06-12T03:08:27.648252Z","end":"2026-06-12T03:08:28.430142Z","steps":["trace[1891890362] 'process raft request' (duration: 781.707266ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:28.430291Z","caller":"traceutil/trace.go:171","msg":"trace[242990811] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"782.331512ms","start":"2026-06-12T03:08:27.647897Z","end":"2026-06-12T03:08:28.430229Z","steps":["trace[242990811] 'process raft request' (duration: 782.015284ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:28.430286Z","caller":"traceutil/trace.go:171","msg":"trace[2131447866] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"778.877037ms","start":"2026-06-12T03:08:27.65136Z","end":"2026-06-12T03:08:28.430237Z","steps":["trace[2131447866] 'process raft request' (duration: 778.696902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.430455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.647886Z","time spent":"782.481205ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:28.430569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.651344Z","time spent":"779.121992ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:28.430653Z","caller":"traceutil/trace.go:171","msg":"trace[2126657460] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"779.275046ms","start":"2026-06-12T03:08:27.651367Z","end":"2026-06-12T03:08:28.430642Z","steps":["trace[2126657460] 'process raft request' (duration: 778.740054ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:28.430661Z","caller":"traceutil/trace.go:171","msg":"trace[552730248] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"608.63362ms","start":"2026-06-12T03:08:27.822001Z","end":"2026-06-12T03:08:28.430634Z","steps":["trace[552730248] 'process raft request' (duration: 608.518718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.430695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.651355Z","time spent":"779.320677ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:28.430741Z","caller":"traceutil/trace.go:171","msg":"trace[1226915683] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"779.272376ms","start":"2026-06-12T03:08:27.651438Z","end":"2026-06-12T03:08:28.430711Z","steps":["trace[1226915683] 'process raft request' (duration: 778.706473ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:28.430778Z","caller":"traceutil/trace.go:171","msg":"trace[1037590852] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"751.875353ms","start":"2026-06-12T03:08:27.678895Z","end":"2026-06-12T03:08:28.430771Z","steps":["trace[1037590852] 'process raft request' (duration: 751.35289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.430799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.821975Z","time spent":"608.760134ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:28.430818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.678875Z","time spent":"751.924793ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:28.430864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.651433Z","time spent":"779.347158ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:28.430917Z","caller":"traceutil/trace.go:171","msg":"trace[1574488058] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"732.721971ms","start":"2026-06-12T03:08:27.698188Z","end":"2026-06-12T03:08:28.43091Z","steps":["trace[1574488058] 'process raft request' (duration: 732.120336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.430951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.698168Z","time spent":"732.769773ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:28.430984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.636883Z","time spent":"793.308822ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:28.43101Z","caller":"traceutil/trace.go:171","msg":"trace[1026211384] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"772.328775ms","start":"2026-06-12T03:08:27.658307Z","end":"2026-06-12T03:08:28.430635Z","steps":["trace[1026211384] 'process raft request' (duration: 771.886725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.431038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.658284Z","time spent":"772.741106ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:28.430069Z","caller":"traceutil/trace.go:171","msg":"trace[868484372] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"793.057126ms","start":"2026-06-12T03:08:27.63697Z","end":"2026-06-12T03:08:28.430027Z","steps":["trace[868484372] 'process raft request' (duration: 792.895552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.431123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.636965Z","time spent":"794.139512ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:28.431016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:27.64822Z","time spent":"782.110546ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:28.991549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.895987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:08:28.991771Z","caller":"traceutil/trace.go:171","msg":"trace[888044930] linearizableReadLoop","detail":"{readStateIndex:565; appliedIndex:553; }","duration":"610.844689ms","start":"2026-06-12T03:08:28.38091Z","end":"2026-06-12T03:08:28.991755Z","steps":["trace[888044930] 'read index received' (duration: 48.992356ms)","trace[888044930] 'applied index is now lower than readState.Index' (duration: 561.851463ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:28.991833Z","caller":"traceutil/trace.go:171","msg":"trace[1860052528] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"708.791078ms","start":"2026-06-12T03:08:28.282952Z","end":"2026-06-12T03:08:28.991743Z","steps":["trace[1860052528] 'process raft request' (duration: 223.498292ms)","trace[1860052528] 'compare' (duration: 484.728042ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:28.991907Z","caller":"traceutil/trace.go:171","msg":"trace[639942743] transaction","detail":"{read_only:false; number_of_response:1; response_revision:545; }","duration":"706.178114ms","start":"2026-06-12T03:08:28.285705Z","end":"2026-06-12T03:08:28.991883Z","steps":["trace[639942743] 'process raft request' (duration: 706.00593ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:28.991893Z","caller":"traceutil/trace.go:171","msg":"trace[1619817671] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"706.545943ms","start":"2026-06-12T03:08:28.285313Z","end":"2026-06-12T03:08:28.991859Z","steps":["trace[1619817671] 'process raft request' (duration: 706.335088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.99187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.963252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:28.992072Z","caller":"traceutil/trace.go:171","msg":"trace[698080453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:545; }","duration":"611.246979ms","start":"2026-06-12T03:08:28.380807Z","end":"2026-06-12T03:08:28.992054Z","steps":["trace[698080453] 'agreement among raft nodes before linearized reading' (duration: 610.997632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:28.992111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.380789Z","time spent":"611.313542ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T03:08:28.992091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.285695Z","time spent":"706.271247ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7367,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:28.992177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.282932Z","time spent":"709.014555ms","remote":"127.0.0.1:35126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:28.992182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.285301Z","time spent":"706.747239ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:29.312484Z","caller":"traceutil/trace.go:171","msg":"trace[340259765] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"871.590479ms","start":"2026-06-12T03:08:28.440861Z","end":"2026-06-12T03:08:29.312452Z","steps":["trace[340259765] 'process raft request' (duration: 860.725686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.312658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.440843Z","time spent":"871.747022ms","remote":"127.0.0.1:35126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:29.313006Z","caller":"traceutil/trace.go:171","msg":"trace[1383408218] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"871.579258ms","start":"2026-06-12T03:08:28.441357Z","end":"2026-06-12T03:08:29.312936Z","steps":["trace[1383408218] 'process raft request' (duration: 871.071086ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:29.313068Z","caller":"traceutil/trace.go:171","msg":"trace[373149342] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"871.819834ms","start":"2026-06-12T03:08:28.441233Z","end":"2026-06-12T03:08:29.313053Z","steps":["trace[373149342] 'process raft request' (duration: 871.153538ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.313135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.441227Z","time spent":"871.878475ms","remote":"127.0.0.1:35126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:29.313269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.441352Z","time spent":"871.770303ms","remote":"127.0.0.1:35126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:29.313314Z","caller":"traceutil/trace.go:171","msg":"trace[1838915531] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"868.317159ms","start":"2026-06-12T03:08:28.444972Z","end":"2026-06-12T03:08:29.313289Z","steps":["trace[1838915531] 'process raft request' (duration: 867.484159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.313416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.44496Z","time spent":"868.416541ms","remote":"127.0.0.1:35126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:29.313458Z","caller":"traceutil/trace.go:171","msg":"trace[1968299988] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"864.920676ms","start":"2026-06-12T03:08:28.448528Z","end":"2026-06-12T03:08:29.313448Z","steps":["trace[1968299988] 'process raft request' (duration: 864.27677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.313536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.448505Z","time spent":"864.983426ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:29.313576Z","caller":"traceutil/trace.go:171","msg":"trace[1172233695] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"863.423349ms","start":"2026-06-12T03:08:28.450128Z","end":"2026-06-12T03:08:29.313551Z","steps":["trace[1172233695] 'process raft request' (duration: 862.859696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.313677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.45012Z","time spent":"863.497931ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:29.313795Z","caller":"traceutil/trace.go:171","msg":"trace[1202491600] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"863.205384ms","start":"2026-06-12T03:08:28.45058Z","end":"2026-06-12T03:08:29.313785Z","steps":["trace[1202491600] 'process raft request' (duration: 862.477786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.313841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.45056Z","time spent":"863.257235ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:29.313903Z","caller":"traceutil/trace.go:171","msg":"trace[1605766794] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"811.630325ms","start":"2026-06-12T03:08:28.502262Z","end":"2026-06-12T03:08:29.313892Z","steps":["trace[1605766794] 'process raft request' (duration: 810.865097ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:29.313778Z","caller":"traceutil/trace.go:171","msg":"trace[310235952] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"310.942855ms","start":"2026-06-12T03:08:29.002765Z","end":"2026-06-12T03:08:29.313707Z","steps":["trace[310235952] 'process raft request' (duration: 310.803291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.313964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.502232Z","time spent":"811.711207ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T03:08:29.313979Z","caller":"traceutil/trace.go:171","msg":"trace[772288644] linearizableReadLoop","detail":"{readStateIndex:577; appliedIndex:565; }","duration":"172.011962ms","start":"2026-06-12T03:08:29.141936Z","end":"2026-06-12T03:08:29.313948Z","steps":["trace[772288644] 'read index received' (duration: 159.594482ms)","trace[772288644] 'applied index is now lower than readState.Index' (duration: 12.41612ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:29.314019Z","caller":"traceutil/trace.go:171","msg":"trace[1764885198] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"307.338766ms","start":"2026-06-12T03:08:29.006672Z","end":"2026-06-12T03:08:29.314011Z","steps":["trace[1764885198] 'process raft request' (duration: 306.981747ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:29.314061Z","caller":"traceutil/trace.go:171","msg":"trace[979728852] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"294.978768ms","start":"2026-06-12T03:08:29.019076Z","end":"2026-06-12T03:08:29.314054Z","steps":["trace[979728852] 'process raft request' (duration: 294.758773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.3141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:29.002736Z","time spent":"311.255941ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:29.314168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.245749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:29.314406Z","caller":"traceutil/trace.go:171","msg":"trace[428953378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:557; }","duration":"172.537275ms","start":"2026-06-12T03:08:29.141856Z","end":"2026-06-12T03:08:29.314394Z","steps":["trace[428953378] 'agreement among raft nodes before linearized reading' (duration: 172.259078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.314157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:29.00665Z","time spent":"307.421368ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:29.319467Z","caller":"traceutil/trace.go:171","msg":"trace[1731615092] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"874.406636ms","start":"2026-06-12T03:08:28.445043Z","end":"2026-06-12T03:08:29.319449Z","steps":["trace[1731615092] 'process raft request' (duration: 867.513809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:29.319569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:28.445034Z","time spent":"874.482697ms","remote":"127.0.0.1:34736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:35.495537Z","caller":"traceutil/trace.go:171","msg":"trace[1989222849] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:662; }","duration":"354.008267ms","start":"2026-06-12T03:08:35.141508Z","end":"2026-06-12T03:08:35.495516Z","steps":["trace[1989222849] 'read index received' (duration: 273.213271ms)","trace[1989222849] 'applied index is now lower than readState.Index' (duration: 80.793926ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:08:35.495769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.682583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hmk8j\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-12T03:08:35.4958Z","caller":"traceutil/trace.go:171","msg":"trace[1654037616] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hmk8j; range_end:; response_count:1; response_revision:639; }","duration":"131.800455ms","start":"2026-06-12T03:08:35.363991Z","end":"2026-06-12T03:08:35.495792Z","steps":["trace[1654037616] 'agreement among raft nodes before linearized reading' (duration: 131.653051ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:35.496064Z","caller":"traceutil/trace.go:171","msg":"trace[1858394716] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"355.189126ms","start":"2026-06-12T03:08:35.140841Z","end":"2026-06-12T03:08:35.49603Z","steps":["trace[1858394716] 'process raft request' (duration: 273.96214ms)","trace[1858394716] 'compare' (duration: 80.472399ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:08:35.496216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:35.140819Z","time spent":"355.309878ms","remote":"127.0.0.1:35108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T03:08:35.496094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.56846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:35.497111Z","caller":"traceutil/trace.go:171","msg":"trace[2125800459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"355.609845ms","start":"2026-06-12T03:08:35.14148Z","end":"2026-06-12T03:08:35.49709Z","steps":["trace[2125800459] 'agreement among raft nodes before linearized reading' (duration: 354.55191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:35.497143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:35.141466Z","time spent":"355.667876ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T03:08:36.0066Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186920266164088,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-12T03:08:36.197379Z","caller":"traceutil/trace.go:171","msg":"trace[557121694] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"697.316796ms","start":"2026-06-12T03:08:35.500043Z","end":"2026-06-12T03:08:36.197359Z","steps":["trace[557121694] 'process raft request' (duration: 697.193013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:36.197519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:35.500029Z","time spent":"697.410867ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:36.301149Z","caller":"traceutil/trace.go:171","msg":"trace[2066913063] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"800.636995ms","start":"2026-06-12T03:08:35.50049Z","end":"2026-06-12T03:08:36.301127Z","steps":["trace[2066913063] 'process raft request' (duration: 800.549423ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:36.301149Z","caller":"traceutil/trace.go:171","msg":"trace[1569996480] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"800.952951ms","start":"2026-06-12T03:08:35.500159Z","end":"2026-06-12T03:08:36.301111Z","steps":["trace[1569996480] 'process raft request' (duration: 795.072796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:36.301315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:35.500481Z","time spent":"800.740527ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:36.301338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:35.500144Z","time spent":"801.096924ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:36.301449Z","caller":"traceutil/trace.go:171","msg":"trace[560188753] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:663; }","duration":"795.762671ms","start":"2026-06-12T03:08:35.505643Z","end":"2026-06-12T03:08:36.301406Z","steps":["trace[560188753] 'read index received' (duration: 691.614463ms)","trace[560188753] 'applied index is now lower than readState.Index' (duration: 104.146748ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:36.301495Z","caller":"traceutil/trace.go:171","msg":"trace[1395694833] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"801.225837ms","start":"2026-06-12T03:08:35.500232Z","end":"2026-06-12T03:08:36.301458Z","steps":["trace[1395694833] 'process raft request' (duration: 800.766147ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:36.301518Z","caller":"traceutil/trace.go:171","msg":"trace[2112852318] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"792.22443ms","start":"2026-06-12T03:08:35.509272Z","end":"2026-06-12T03:08:36.301496Z","steps":["trace[2112852318] 'process raft request' (duration: 791.80508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:36.301597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.914995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T03:08:36.301649Z","caller":"traceutil/trace.go:171","msg":"trace[1628302064] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:644; }","duration":"796.007827ms","start":"2026-06-12T03:08:35.505625Z","end":"2026-06-12T03:08:36.301632Z","steps":["trace[1628302064] 'agreement among raft nodes before linearized reading' (duration: 795.893084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:36.301672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:35.50022Z","time spent":"801.404602ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:36.301662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:35.509262Z","time spent":"792.321812ms","remote":"127.0.0.1:34824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:36.301692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:35.505616Z","time spent":"796.061828ms","remote":"127.0.0.1:34890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-12T03:08:37.640625Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14208186920266164095,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T03:08:37.96827Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.155508929s","expected-duration":"1s"} {"level":"info","ts":"2026-06-12T03:08:37.969141Z","caller":"traceutil/trace.go:171","msg":"trace[196954401] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.163072862s","start":"2026-06-12T03:08:36.806046Z","end":"2026-06-12T03:08:37.969118Z","steps":["trace[196954401] 'process raft request' (duration: 1.162618291s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:37.969287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:36.806014Z","time spent":"1.163194835s","remote":"127.0.0.1:34770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:38.014249Z","caller":"traceutil/trace.go:171","msg":"trace[1764448717] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:668; }","duration":"873.919147ms","start":"2026-06-12T03:08:37.140302Z","end":"2026-06-12T03:08:38.014221Z","steps":["trace[1764448717] 'read index received' (duration: 828.215449ms)","trace[1764448717] 'applied index is now lower than readState.Index' (duration: 45.702528ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:38.014424Z","caller":"traceutil/trace.go:171","msg":"trace[1662219538] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"631.123201ms","start":"2026-06-12T03:08:37.383164Z","end":"2026-06-12T03:08:38.014287Z","steps":["trace[1662219538] 'process raft request' (duration: 630.888265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:38.01455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.207013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T03:08:38.014703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:37.383142Z","time spent":"631.424698ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:08:38.014764Z","caller":"traceutil/trace.go:171","msg":"trace[857253947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"874.47165ms","start":"2026-06-12T03:08:37.140265Z","end":"2026-06-12T03:08:38.014736Z","steps":["trace[857253947] 'agreement among raft nodes before linearized reading' (duration: 874.0643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:38.014933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:37.140248Z","time spent":"874.674044ms","remote":"127.0.0.1:34668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-12T03:08:39.901639Z","caller":"traceutil/trace.go:171","msg":"trace[1156858301] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"160.864058ms","start":"2026-06-12T03:08:39.740745Z","end":"2026-06-12T03:08:39.901609Z","steps":["trace[1156858301] 'process raft request' (duration: 160.735245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:42.654246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.930342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-06-12T03:08:42.654368Z","caller":"traceutil/trace.go:171","msg":"trace[856816743] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:724; }","duration":"115.051796ms","start":"2026-06-12T03:08:42.539269Z","end":"2026-06-12T03:08:42.654321Z","steps":["trace[856816743] 'range keys from in-memory index tree' (duration: 114.654265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:52.217228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:51.883023Z","time spent":"334.200717ms","remote":"127.0.0.1:34712","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-12T03:08:52.749685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.337939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T03:08:52.749791Z","caller":"traceutil/trace.go:171","msg":"trace[402638460] linearizableReadLoop","detail":"{readStateIndex:829; appliedIndex:828; }","duration":"486.137706ms","start":"2026-06-12T03:08:52.263638Z","end":"2026-06-12T03:08:52.749776Z","steps":["trace[402638460] 'read index received' (duration: 338.726845ms)","trace[402638460] 'applied index is now lower than readState.Index' (duration: 147.409101ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:08:52.749857Z","caller":"traceutil/trace.go:171","msg":"trace[1735008915] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"531.543486ms","start":"2026-06-12T03:08:52.218302Z","end":"2026-06-12T03:08:52.749845Z","steps":["trace[1735008915] 'process raft request' (duration: 383.958702ms)","trace[1735008915] 'compare' (duration: 146.921891ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T03:08:52.749913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.218283Z","time spent":"531.598267ms","remote":"127.0.0.1:34712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T03:08:52.750133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.483343ms","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-06-12T03:08:52.750206Z","caller":"traceutil/trace.go:171","msg":"trace[1030554185] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:799; }","duration":"486.583024ms","start":"2026-06-12T03:08:52.263601Z","end":"2026-06-12T03:08:52.750184Z","steps":["trace[1030554185] 'agreement among raft nodes before linearized reading' (duration: 486.343289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:52.750257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.263581Z","time spent":"486.665927ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-12T03:08:52.75076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.975301ms","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-06-12T03:08:52.750838Z","caller":"traceutil/trace.go:171","msg":"trace[463941093] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:800; }","duration":"380.084563ms","start":"2026-06-12T03:08:52.370733Z","end":"2026-06-12T03:08:52.750817Z","steps":["trace[463941093] 'agreement among raft nodes before linearized reading' (duration: 379.91844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:52.7509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.370712Z","time spent":"380.173614ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T03:08:52.750897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.414675ms","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-06-12T03:08:52.750948Z","caller":"traceutil/trace.go:171","msg":"trace[1170664172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:800; }","duration":"372.483486ms","start":"2026-06-12T03:08:52.378449Z","end":"2026-06-12T03:08:52.750933Z","steps":["trace[1170664172] 'agreement among raft nodes before linearized reading' (duration: 372.337453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:52.750997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.378441Z","time spent":"372.545617ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T03:08:52.751084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.049778ms","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-06-12T03:08:52.751267Z","caller":"traceutil/trace.go:171","msg":"trace[1057430186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:800; }","duration":"373.203061ms","start":"2026-06-12T03:08:52.377924Z","end":"2026-06-12T03:08:52.751127Z","steps":["trace[1057430186] 'agreement among raft nodes before linearized reading' (duration: 372.880105ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:08:52.750757Z","caller":"traceutil/trace.go:171","msg":"trace[921511617] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"269.144667ms","start":"2026-06-12T03:08:52.481587Z","end":"2026-06-12T03:08:52.750732Z","steps":["trace[921511617] 'process raft request' (duration: 268.964464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:08:52.751356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:08:52.377914Z","time spent":"373.425406ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-12T03:10:39.513464Z","caller":"traceutil/trace.go:171","msg":"trace[1280709690] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1369; }","duration":"199.93253ms","start":"2026-06-12T03:10:39.313496Z","end":"2026-06-12T03:10:39.513428Z","steps":["trace[1280709690] 'read index received' (duration: 199.800289ms)","trace[1280709690] 'applied index is now lower than readState.Index' (duration: 131.091µs)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:10:39.513532Z","caller":"traceutil/trace.go:171","msg":"trace[1438809757] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"200.855092ms","start":"2026-06-12T03:10:39.312633Z","end":"2026-06-12T03:10:39.513488Z","steps":["trace[1438809757] 'process raft request' (duration: 200.458467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:39.513781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.252455ms","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-06-12T03:10:39.513836Z","caller":"traceutil/trace.go:171","msg":"trace[1178171167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1317; }","duration":"200.354086ms","start":"2026-06-12T03:10:39.313471Z","end":"2026-06-12T03:10:39.513825Z","steps":["trace[1178171167] 'agreement among raft nodes before linearized reading' (duration: 200.141933ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:39.670461Z","caller":"traceutil/trace.go:171","msg":"trace[1582446467] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"356.912196ms","start":"2026-06-12T03:10:39.313509Z","end":"2026-06-12T03:10:39.670421Z","steps":["trace[1582446467] 'process raft request' (duration: 356.441319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:39.670647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:39.313483Z","time spent":"357.070467ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:39.670852Z","caller":"traceutil/trace.go:171","msg":"trace[1145677319] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"356.401728ms","start":"2026-06-12T03:10:39.314422Z","end":"2026-06-12T03:10:39.670824Z","steps":["trace[1145677319] 'process raft request' (duration: 355.77619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T03:10:39.671007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T03:10:39.314397Z","time spent":"356.530259ms","remote":"127.0.0.1:34910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T03:10:39.67193Z","caller":"traceutil/trace.go:171","msg":"trace[1908297890] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"152.364532ms","start":"2026-06-12T03:10:39.519531Z","end":"2026-06-12T03:10:39.671896Z","steps":["trace[1908297890] 'process raft request' (duration: 152.242091ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:45.674493Z","caller":"traceutil/trace.go:171","msg":"trace[271398778] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"130.281551ms","start":"2026-06-12T03:10:45.544178Z","end":"2026-06-12T03:10:45.674459Z","steps":["trace[271398778] 'process raft request' (duration: 130.055748ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:45.871232Z","caller":"traceutil/trace.go:171","msg":"trace[2118908] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"160.107495ms","start":"2026-06-12T03:10:45.711094Z","end":"2026-06-12T03:10:45.871201Z","steps":["trace[2118908] 'process raft request' (duration: 85.916706ms)","trace[2118908] 'compare' (duration: 73.236826ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T03:10:45.87159Z","caller":"traceutil/trace.go:171","msg":"trace[228426923] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"156.261493ms","start":"2026-06-12T03:10:45.715304Z","end":"2026-06-12T03:10:45.871566Z","steps":["trace[228426923] 'process raft request' (duration: 156.172512ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T03:10:45.871748Z","caller":"traceutil/trace.go:171","msg":"trace[330135629] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"155.992759ms","start":"2026-06-12T03:10:45.715708Z","end":"2026-06-12T03:10:45.871701Z","steps":["trace[330135629] 'process raft request' (duration: 155.816967ms)"],"step_count":1}