{"level":"warn","ts":"2026-10-15T06:26:40.890305Z","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-15T06:26:40.890421Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.163: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.19.213.163:2380","--initial-cluster=instance=https://199.19.213.163:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.163:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.163: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-15T06:26:40.890546Z","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-15T06:26:40.890561Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.163:2380"]} {"level":"info","ts":"2026-10-15T06:26:40.890583Z","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-15T06:26:40.892456Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"]} {"level":"info","ts":"2026-10-15T06:26:40.892565Z","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.19.213.163:2380"],"listen-peer-urls":["https://199.19.213.163:2380"],"advertise-client-urls":["https://199.19.213.163:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.163: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-15T06:26:40.897086Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.225732ms"} {"level":"info","ts":"2026-10-15T06:26:40.90255Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e7941a908d261618","cluster-id":"5b6cb15db6ea8c10"} {"level":"info","ts":"2026-10-15T06:26:40.902621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T06:26:40.902647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became follower at term 0"} {"level":"info","ts":"2026-10-15T06:26:40.902658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e7941a908d261618 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T06:26:40.902668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became follower at term 1"} {"level":"info","ts":"2026-10-15T06:26:40.902709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=(16686991727460226584)"} {"level":"warn","ts":"2026-10-15T06:26:40.910829Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T06:26:40.912139Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T06:26:40.91358Z","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-15T06:26:40.920398Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e7941a908d261618","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T06:26:40.920609Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e7941a908d261618","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T06:26:40.920946Z","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-15T06:26:40.921052Z","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-15T06:26:40.921068Z","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-15T06:26:40.922616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 switched to configuration voters=(16686991727460226584)"} {"level":"info","ts":"2026-10-15T06:26:40.922903Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5b6cb15db6ea8c10","local-member-id":"e7941a908d261618","added-peer-id":"e7941a908d261618","added-peer-peer-urls":["https://199.19.213.163:2380"]} {"level":"info","ts":"2026-10-15T06:26:40.92525Z","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-15T06:26:40.925475Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e7941a908d261618","initial-advertise-peer-urls":["https://199.19.213.163:2380"],"listen-peer-urls":["https://199.19.213.163:2380"],"advertise-client-urls":["https://199.19.213.163:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.163:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T06:26:40.925511Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T06:26:40.925805Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.163:2380"} {"level":"info","ts":"2026-10-15T06:26:40.925861Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.163:2380"} {"level":"info","ts":"2026-10-15T06:26:41.504839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T06:26:41.504919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T06:26:41.504954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 received MsgPreVoteResp from e7941a908d261618 at term 1"} {"level":"info","ts":"2026-10-15T06:26:41.504976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became candidate at term 2"} {"level":"info","ts":"2026-10-15T06:26:41.504987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 received MsgVoteResp from e7941a908d261618 at term 2"} {"level":"info","ts":"2026-10-15T06:26:41.505002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7941a908d261618 became leader at term 2"} {"level":"info","ts":"2026-10-15T06:26:41.505016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e7941a908d261618 elected leader e7941a908d261618 at term 2"} {"level":"info","ts":"2026-10-15T06:26:41.508485Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e7941a908d261618","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.163:2379]}","request-path":"/0/members/e7941a908d261618/attributes","cluster-id":"5b6cb15db6ea8c10","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T06:26:41.508689Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:26:41.508581Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:26:41.508822Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T06:26:41.511361Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.163:2379"} {"level":"info","ts":"2026-10-15T06:26:41.511534Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T06:26:41.511559Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T06:26:41.513188Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T06:26:41.513962Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5b6cb15db6ea8c10","local-member-id":"e7941a908d261618","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:26:41.514197Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:26:41.514293Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T06:26:45.176061Z","caller":"traceutil/trace.go:171","msg":"trace[1407354250] transaction","detail":"{read_only:false; response_revision:180; number_of_response:1; }","duration":"114.457759ms","start":"2026-10-15T06:26:45.061553Z","end":"2026-10-15T06:26:45.176011Z","steps":["trace[1407354250] 'process raft request' (duration: 109.632472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:48.338933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.027774ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:26:48.339081Z","caller":"traceutil/trace.go:171","msg":"trace[2016429984] linearizableReadLoop","detail":"{readStateIndex:314; appliedIndex:313; }","duration":"120.625486ms","start":"2026-10-15T06:26:48.218435Z","end":"2026-10-15T06:26:48.339061Z","steps":["trace[2016429984] 'read index received' (duration: 29.871µs)","trace[2016429984] 'applied index is now lower than readState.Index' (duration: 120.594265ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:26:48.3392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.760803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-10-15T06:26:48.339257Z","caller":"traceutil/trace.go:171","msg":"trace[1274594290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:304; }","duration":"120.881358ms","start":"2026-10-15T06:26:48.218365Z","end":"2026-10-15T06:26:48.339246Z","steps":["trace[1274594290] 'agreement among raft nodes before linearized reading' (duration: 120.749272ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:26:48.339267Z","caller":"traceutil/trace.go:171","msg":"trace[1232394938] transaction","detail":"{read_only:false; response_revision:304; number_of_response:1; }","duration":"342.056338ms","start":"2026-10-15T06:26:47.997126Z","end":"2026-10-15T06:26:48.339182Z","steps":["trace[1232394938] 'process raft request' (duration: 122.113202ms)","trace[1232394938] 'compare' (duration: 218.836065ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:26:48.339503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:47.9971Z","time spent":"342.261388ms","remote":"127.0.0.1:41112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":209,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T06:26:48.692307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.33055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T06:26:48.692539Z","caller":"traceutil/trace.go:171","msg":"trace[1422066339] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:314; }","duration":"346.724143ms","start":"2026-10-15T06:26:48.345789Z","end":"2026-10-15T06:26:48.692513Z","steps":["trace[1422066339] 'read index received' (duration: 184.840738ms)","trace[1422066339] 'applied index is now lower than readState.Index' (duration: 161.881895ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:26:48.692721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.89812ms","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-15T06:26:48.692833Z","caller":"traceutil/trace.go:171","msg":"trace[1220562967] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:305; }","duration":"347.030736ms","start":"2026-10-15T06:26:48.345785Z","end":"2026-10-15T06:26:48.692816Z","steps":["trace[1220562967] 'agreement among raft nodes before linearized reading' (duration: 346.842338ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:48.69292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:48.345757Z","time spent":"347.146802ms","remote":"127.0.0.1:41034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-10-15T06:26:48.692721Z","caller":"traceutil/trace.go:171","msg":"trace[2063756051] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"348.578538ms","start":"2026-10-15T06:26:48.343954Z","end":"2026-10-15T06:26:48.692533Z","steps":["trace[2063756051] 'process raft request' (duration: 186.692923ms)","trace[2063756051] 'compare' (duration: 161.11477ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:26:48.693118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:48.343937Z","time spent":"349.127254ms","remote":"127.0.0.1:41174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:26:48.867306Z","caller":"traceutil/trace.go:171","msg":"trace[694127242] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"169.964137ms","start":"2026-10-15T06:26:48.697317Z","end":"2026-10-15T06:26:48.867281Z","steps":["trace[694127242] 'process raft request' (duration: 169.853412ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:26:48.867828Z","caller":"traceutil/trace.go:171","msg":"trace[782926796] transaction","detail":"{read_only:false; number_of_response:0; response_revision:305; }","duration":"291.747475ms","start":"2026-10-15T06:26:48.57607Z","end":"2026-10-15T06:26:48.867817Z","steps":["trace[782926796] 'process raft request' (duration: 246.282192ms)","trace[782926796] 'compare' (duration: 44.734ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:26:48.868105Z","caller":"traceutil/trace.go:171","msg":"trace[589920228] linearizableReadLoop","detail":"{readStateIndex:316; appliedIndex:315; }","duration":"175.516871ms","start":"2026-10-15T06:26:48.692578Z","end":"2026-10-15T06:26:48.868095Z","steps":["trace[589920228] 'read index received' (duration: 130.005476ms)","trace[589920228] 'applied index is now lower than readState.Index' (duration: 45.510165ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:26:48.868328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.498643ms","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-15T06:26:48.868366Z","caller":"traceutil/trace.go:171","msg":"trace[1235160765] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:306; }","duration":"463.592977ms","start":"2026-10-15T06:26:48.404762Z","end":"2026-10-15T06:26:48.868355Z","steps":["trace[1235160765] 'agreement among raft nodes before linearized reading' (duration: 463.367417ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:26:48.868531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:26:48.404736Z","time spent":"463.782096ms","remote":"127.0.0.1:41174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-15T06:26:48.868705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.377865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-10-15T06:26:48.868743Z","caller":"traceutil/trace.go:171","msg":"trace[2034390842] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:306; }","duration":"294.511332ms","start":"2026-10-15T06:26:48.57422Z","end":"2026-10-15T06:26:48.868731Z","steps":["trace[2034390842] 'agreement among raft nodes before linearized reading' (duration: 294.369525ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:27:26.135368Z","caller":"traceutil/trace.go:171","msg":"trace[687819471] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"110.292329ms","start":"2026-10-15T06:27:26.025038Z","end":"2026-10-15T06:27:26.13533Z","steps":["trace[687819471] 'process raft request' (duration: 110.027205ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:31.12586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.661931ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-10-15T06:27:36.944119Z","caller":"traceutil/trace.go:171","msg":"trace[49060522] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"264.045327ms","start":"2026-10-15T06:27:36.680034Z","end":"2026-10-15T06:27:36.944079Z","steps":["trace[49060522] 'process raft request' (duration: 206.277101ms)","trace[49060522] 'compare' (duration: 56.759309ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:27:39.530588Z","caller":"traceutil/trace.go:171","msg":"trace[2099736875] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"493.082116ms","start":"2026-10-15T06:27:39.037478Z","end":"2026-10-15T06:27:39.53056Z","steps":["trace[2099736875] 'process raft request' (duration: 492.912656ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:39.53077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:39.03743Z","time spent":"493.252926ms","remote":"127.0.0.1:41174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:27:39.592169Z","caller":"traceutil/trace.go:171","msg":"trace[1535404143] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:691; }","duration":"349.280052ms","start":"2026-10-15T06:27:39.242855Z","end":"2026-10-15T06:27:39.592135Z","steps":["trace[1535404143] 'read index received' (duration: 287.540143ms)","trace[1535404143] 'applied index is now lower than readState.Index' (duration: 61.739009ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:27:39.592287Z","caller":"traceutil/trace.go:171","msg":"trace[32960253] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"437.67329ms","start":"2026-10-15T06:27:39.154579Z","end":"2026-10-15T06:27:39.592252Z","steps":["trace[32960253] 'process raft request' (duration: 437.440837ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:39.59247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.563329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-10-15T06:27:39.592443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:39.15454Z","time spent":"437.838459ms","remote":"127.0.0.1:41410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T06:27:39.592509Z","caller":"traceutil/trace.go:171","msg":"trace[1420502798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:666; }","duration":"349.717887ms","start":"2026-10-15T06:27:39.24278Z","end":"2026-10-15T06:27:39.592497Z","steps":["trace[1420502798] 'agreement among raft nodes before linearized reading' (duration: 349.470913ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:39.592651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:39.242756Z","time spent":"349.883167ms","remote":"127.0.0.1:41174","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-15T06:27:39.902064Z","caller":"traceutil/trace.go:171","msg":"trace[126433428] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"297.219018ms","start":"2026-10-15T06:27:39.604812Z","end":"2026-10-15T06:27:39.902031Z","steps":["trace[126433428] 'read index received' (duration: 214.246262ms)","trace[126433428] 'applied index is now lower than readState.Index' (duration: 82.971466ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T06:27:39.902181Z","caller":"traceutil/trace.go:171","msg":"trace[2067274297] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"304.386369ms","start":"2026-10-15T06:27:39.597726Z","end":"2026-10-15T06:27:39.902113Z","steps":["trace[2067274297] 'process raft request' (duration: 221.393101ms)","trace[2067274297] 'compare' (duration: 82.725593ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:27:39.902299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.437211ms","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-10-15T06:27:39.902367Z","caller":"traceutil/trace.go:171","msg":"trace[1248141278] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:667; }","duration":"297.576988ms","start":"2026-10-15T06:27:39.604772Z","end":"2026-10-15T06:27:39.902349Z","steps":["trace[1248141278] 'agreement among raft nodes before linearized reading' (duration: 297.403959ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:27:39.902436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T06:27:39.597707Z","time spent":"304.623252ms","remote":"127.0.0.1:41174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T06:27:55.810885Z","caller":"traceutil/trace.go:171","msg":"trace[835973321] transaction","detail":"{read_only:false; response_revision:831; number_of_response:1; }","duration":"170.733233ms","start":"2026-10-15T06:27:55.640127Z","end":"2026-10-15T06:27:55.810861Z","steps":["trace[835973321] 'process raft request' (duration: 170.527031ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:27:56.028912Z","caller":"traceutil/trace.go:171","msg":"trace[1566098665] linearizableReadLoop","detail":"{readStateIndex:866; appliedIndex:865; }","duration":"185.859674ms","start":"2026-10-15T06:27:55.843007Z","end":"2026-10-15T06:27:56.028866Z","steps":["trace[1566098665] 'read index received' (duration: 184.914588ms)","trace[1566098665] 'applied index is now lower than readState.Index' (duration: 943.236µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T06:27:56.029133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.094698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T06:27:56.029198Z","caller":"traceutil/trace.go:171","msg":"trace[528086020] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:832; }","duration":"186.181183ms","start":"2026-10-15T06:27:55.843Z","end":"2026-10-15T06:27:56.029181Z","steps":["trace[528086020] 'agreement among raft nodes before linearized reading' (duration: 186.058566ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T06:27:56.029033Z","caller":"traceutil/trace.go:171","msg":"trace[570901878] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"195.320977ms","start":"2026-10-15T06:27:55.833677Z","end":"2026-10-15T06:27:56.028998Z","steps":["trace[570901878] 'process raft request' (duration: 194.370329ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T06:28:01.222549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.441637ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"}