{"level":"warn","ts":"2026-05-05T11:21:15.022664Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T11:21:15.022785Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.30: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.30:2380","--initial-cluster=instance=https://199.19.213.30:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.30:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.30: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-05-05T11:21:15.022872Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T11:21:15.022887Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.30:2380"]} {"level":"info","ts":"2026-05-05T11:21:15.022913Z","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-05-05T11:21:15.023592Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"]} {"level":"info","ts":"2026-05-05T11:21:15.023676Z","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.30:2380"],"listen-peer-urls":["https://199.19.213.30:2380"],"advertise-client-urls":["https://199.19.213.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.30: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-05-05T11:21:15.02788Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.98613ms"} {"level":"info","ts":"2026-05-05T11:21:15.033092Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e2b5783e11defe7e","cluster-id":"5210a9231a779bf0"} {"level":"info","ts":"2026-05-05T11:21:15.0332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T11:21:15.03323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became follower at term 0"} {"level":"info","ts":"2026-05-05T11:21:15.033249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e2b5783e11defe7e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T11:21:15.033283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became follower at term 1"} {"level":"info","ts":"2026-05-05T11:21:15.03333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=(16336095431339474558)"} {"level":"warn","ts":"2026-05-05T11:21:15.041713Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T11:21:15.047291Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T11:21:15.048636Z","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-05-05T11:21:15.051683Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e2b5783e11defe7e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T11:21:15.051815Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e2b5783e11defe7e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T11:21:15.052046Z","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-05-05T11:21:15.052127Z","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-05-05T11:21:15.052153Z","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-05-05T11:21:15.052604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=(16336095431339474558)"} {"level":"info","ts":"2026-05-05T11:21:15.052755Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5210a9231a779bf0","local-member-id":"e2b5783e11defe7e","added-peer-id":"e2b5783e11defe7e","added-peer-peer-urls":["https://199.19.213.30:2380"]} {"level":"info","ts":"2026-05-05T11:21:15.057912Z","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-05-05T11:21:15.05838Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e2b5783e11defe7e","initial-advertise-peer-urls":["https://199.19.213.30:2380"],"listen-peer-urls":["https://199.19.213.30:2380"],"advertise-client-urls":["https://199.19.213.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T11:21:15.058458Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T11:21:15.058652Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.30:2380"} {"level":"info","ts":"2026-05-05T11:21:15.058762Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.30:2380"} {"level":"info","ts":"2026-05-05T11:21:15.634202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T11:21:15.634274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T11:21:15.634309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e received MsgPreVoteResp from e2b5783e11defe7e at term 1"} {"level":"info","ts":"2026-05-05T11:21:15.63434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became candidate at term 2"} {"level":"info","ts":"2026-05-05T11:21:15.634351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e received MsgVoteResp from e2b5783e11defe7e at term 2"} {"level":"info","ts":"2026-05-05T11:21:15.634369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became leader at term 2"} {"level":"info","ts":"2026-05-05T11:21:15.634389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e2b5783e11defe7e elected leader e2b5783e11defe7e at term 2"} {"level":"info","ts":"2026-05-05T11:21:15.635231Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:21:15.635999Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e2b5783e11defe7e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.30:2379]}","request-path":"/0/members/e2b5783e11defe7e/attributes","cluster-id":"5210a9231a779bf0","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T11:21:15.636131Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T11:21:15.636357Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T11:21:15.636382Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T11:21:15.636268Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T11:21:15.636575Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5210a9231a779bf0","local-member-id":"e2b5783e11defe7e","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:21:15.636705Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:21:15.636744Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T11:21:15.639968Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T11:21:15.650404Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.30:2379"} {"level":"warn","ts":"2026-05-05T11:21:18.330386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.194206ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-05T11:21:18.330699Z","caller":"traceutil/trace.go:171","msg":"trace[1766738096] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"226.567241ms","start":"2026-05-05T11:21:18.10411Z","end":"2026-05-05T11:21:18.330677Z","steps":["trace[1766738096] 'process raft request' (duration: 86.467857ms)","trace[1766738096] 'compare' (duration: 139.002892ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:21:20.846802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.414457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:21:20.847039Z","caller":"traceutil/trace.go:171","msg":"trace[694579221] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"237.410648ms","start":"2026-05-05T11:21:20.609613Z","end":"2026-05-05T11:21:20.847023Z","steps":["trace[694579221] 'process raft request' (duration: 129.699955ms)","trace[694579221] 'compare' (duration: 107.283614ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:20.846975Z","caller":"traceutil/trace.go:171","msg":"trace[1430012672] linearizableReadLoop","detail":"{readStateIndex:229; appliedIndex:228; }","duration":"209.807724ms","start":"2026-05-05T11:21:20.63715Z","end":"2026-05-05T11:21:20.846957Z","steps":["trace[1430012672] 'read index received' (duration: 102.245343ms)","trace[1430012672] 'applied index is now lower than readState.Index' (duration: 107.56132ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:21:20.847232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.049779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:21:20.847297Z","caller":"traceutil/trace.go:171","msg":"trace[17255070] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:224; }","duration":"210.168131ms","start":"2026-05-05T11:21:20.637115Z","end":"2026-05-05T11:21:20.847283Z","steps":["trace[17255070] 'agreement among raft nodes before linearized reading' (duration: 210.023969ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:20.991662Z","caller":"traceutil/trace.go:171","msg":"trace[1080438969] transaction","detail":"{read_only:false; number_of_response:0; response_revision:224; }","duration":"253.844698ms","start":"2026-05-05T11:21:20.737791Z","end":"2026-05-05T11:21:20.991635Z","steps":["trace[1080438969] 'process raft request' (duration: 253.783797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:20.991683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:20.637155Z","time spent":"354.5181ms","remote":"127.0.0.1:39990","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-05T11:21:20.997483Z","caller":"traceutil/trace.go:171","msg":"trace[1941704813] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"245.243485ms","start":"2026-05-05T11:21:20.752213Z","end":"2026-05-05T11:21:20.997457Z","steps":["trace[1941704813] 'process raft request' (duration: 245.081352ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:20.997522Z","caller":"traceutil/trace.go:171","msg":"trace[479361162] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"244.248516ms","start":"2026-05-05T11:21:20.753243Z","end":"2026-05-05T11:21:20.997491Z","steps":["trace[479361162] 'process raft request' (duration: 244.163884ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:20.997596Z","caller":"traceutil/trace.go:171","msg":"trace[474832500] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"244.027371ms","start":"2026-05-05T11:21:20.753517Z","end":"2026-05-05T11:21:20.997545Z","steps":["trace[474832500] 'process raft request' (duration: 243.914579ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:20.997583Z","caller":"traceutil/trace.go:171","msg":"trace[757416392] linearizableReadLoop","detail":"{readStateIndex:236; appliedIndex:229; }","duration":"150.339099ms","start":"2026-05-05T11:21:20.847224Z","end":"2026-05-05T11:21:20.997563Z","steps":["trace[757416392] 'read index received' (duration: 144.221076ms)","trace[757416392] 'applied index is now lower than readState.Index' (duration: 6.116953ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:20.997672Z","caller":"traceutil/trace.go:171","msg":"trace[689966560] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"243.158834ms","start":"2026-05-05T11:21:20.754505Z","end":"2026-05-05T11:21:20.997664Z","steps":["trace[689966560] 'process raft request' (duration: 242.97283ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:20.997743Z","caller":"traceutil/trace.go:171","msg":"trace[1873291538] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"146.551563ms","start":"2026-05-05T11:21:20.851175Z","end":"2026-05-05T11:21:20.997726Z","steps":["trace[1873291538] 'process raft request' (duration: 146.35883ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:20.997747Z","caller":"traceutil/trace.go:171","msg":"trace[1074611183] transaction","detail":"{read_only:false; number_of_response:0; response_revision:227; }","duration":"243.821227ms","start":"2026-05-05T11:21:20.753917Z","end":"2026-05-05T11:21:20.997738Z","steps":["trace[1074611183] 'process raft request' (duration: 243.534361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:20.997821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.577331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-05T11:21:20.997861Z","caller":"traceutil/trace.go:171","msg":"trace[2061228320] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:229; }","duration":"360.646733ms","start":"2026-05-05T11:21:20.637198Z","end":"2026-05-05T11:21:20.997845Z","steps":["trace[2061228320] 'agreement among raft nodes before linearized reading' (duration: 360.536771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:20.997887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:20.637156Z","time spent":"360.725654ms","remote":"127.0.0.1:40296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-05T11:21:20.999338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.297859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-05-05T11:21:20.999385Z","caller":"traceutil/trace.go:171","msg":"trace[1508920324] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:230; }","duration":"148.38723ms","start":"2026-05-05T11:21:20.850985Z","end":"2026-05-05T11:21:20.999373Z","steps":["trace[1508920324] 'agreement among raft nodes before linearized reading' (duration: 147.454781ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:44.064696Z","caller":"traceutil/trace.go:171","msg":"trace[261167747] transaction","detail":"{read_only:false; number_of_response:1; response_revision:477; }","duration":"102.235218ms","start":"2026-05-05T11:21:43.962429Z","end":"2026-05-05T11:21:44.064664Z","steps":["trace[261167747] 'process raft request' (duration: 101.831119ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:44.472915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.00989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:21:44.473274Z","caller":"traceutil/trace.go:171","msg":"trace[606281560] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"126.8356ms","start":"2026-05-05T11:21:44.3464Z","end":"2026-05-05T11:21:44.473235Z","steps":["trace[606281560] 'process raft request' (duration: 16.486003ms)","trace[606281560] 'compare' (duration: 108.899068ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:44.474359Z","caller":"traceutil/trace.go:171","msg":"trace[621826413] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"107.653532ms","start":"2026-05-05T11:21:44.366692Z","end":"2026-05-05T11:21:44.474345Z","steps":["trace[621826413] 'process raft request' (duration: 107.501929ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:49.435811Z","caller":"traceutil/trace.go:171","msg":"trace[756478495] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"322.584525ms","start":"2026-05-05T11:21:49.113196Z","end":"2026-05-05T11:21:49.43578Z","steps":["trace[756478495] 'process raft request' (duration: 320.814098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:49.435977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:49.113175Z","time spent":"322.715418ms","remote":"127.0.0.1:39998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T11:21:50.504643Z","caller":"traceutil/trace.go:171","msg":"trace[1291024246] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"111.733486ms","start":"2026-05-05T11:21:50.392881Z","end":"2026-05-05T11:21:50.504614Z","steps":["trace[1291024246] 'process raft request' (duration: 111.186065ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:50.840704Z","caller":"traceutil/trace.go:171","msg":"trace[194702070] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"273.806099ms","start":"2026-05-05T11:21:50.566876Z","end":"2026-05-05T11:21:50.840682Z","steps":["trace[194702070] 'process raft request' (duration: 273.264298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:51.384931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.373146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:21:51.38511Z","caller":"traceutil/trace.go:171","msg":"trace[136052636] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"531.408442ms","start":"2026-05-05T11:21:50.853681Z","end":"2026-05-05T11:21:51.385089Z","steps":["trace[136052636] 'read index received' (duration: 274.620527ms)","trace[136052636] 'applied index is now lower than readState.Index' (duration: 256.786005ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:51.385148Z","caller":"traceutil/trace.go:171","msg":"trace[1603283575] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"531.905143ms","start":"2026-05-05T11:21:50.853208Z","end":"2026-05-05T11:21:51.385113Z","steps":["trace[1603283575] 'process raft request' (duration: 275.187089ms)","trace[1603283575] 'compare' (duration: 256.148821ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:21:51.385244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.557055ms","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":"warn","ts":"2026-05-05T11:21:51.38528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.058862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T11:21:51.385289Z","caller":"traceutil/trace.go:171","msg":"trace[835688336] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:575; }","duration":"531.629427ms","start":"2026-05-05T11:21:50.853638Z","end":"2026-05-05T11:21:51.385267Z","steps":["trace[835688336] 'agreement among raft nodes before linearized reading' (duration: 531.549205ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:51.38532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:50.853184Z","time spent":"532.053955ms","remote":"127.0.0.1:40104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T11:21:51.385356Z","caller":"traceutil/trace.go:171","msg":"trace[1156513947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"502.155234ms","start":"2026-05-05T11:21:50.883169Z","end":"2026-05-05T11:21:51.385325Z","steps":["trace[1156513947] 'agreement among raft nodes before linearized reading' (duration: 502.053932ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:51.385361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:50.853622Z","time spent":"531.723528ms","remote":"127.0.0.1:40158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-05T11:21:51.385393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:50.883152Z","time spent":"502.232475ms","remote":"127.0.0.1:39926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T11:21:51.943Z","caller":"traceutil/trace.go:171","msg":"trace[722648198] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"189.400472ms","start":"2026-05-05T11:21:51.75358Z","end":"2026-05-05T11:21:51.94298Z","steps":["trace[722648198] 'process raft request' (duration: 189.26101ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:51.958713Z","caller":"traceutil/trace.go:171","msg":"trace[1041862599] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"196.159723ms","start":"2026-05-05T11:21:51.76254Z","end":"2026-05-05T11:21:51.9587Z","steps":["trace[1041862599] 'process raft request' (duration: 195.963789ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:51.95882Z","caller":"traceutil/trace.go:171","msg":"trace[1174003051] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"195.406407ms","start":"2026-05-05T11:21:51.763394Z","end":"2026-05-05T11:21:51.958801Z","steps":["trace[1174003051] 'read index received' (duration: 179.848164ms)","trace[1174003051] 'applied index is now lower than readState.Index' (duration: 15.555663ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:21:51.958997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.587662ms","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-05-05T11:21:51.95903Z","caller":"traceutil/trace.go:171","msg":"trace[1914362261] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"195.664374ms","start":"2026-05-05T11:21:51.763354Z","end":"2026-05-05T11:21:51.959019Z","steps":["trace[1914362261] 'agreement among raft nodes before linearized reading' (duration: 195.50952ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:51.959793Z","caller":"traceutil/trace.go:171","msg":"trace[443034877] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"147.085372ms","start":"2026-05-05T11:21:51.812682Z","end":"2026-05-05T11:21:51.959768Z","steps":["trace[443034877] 'process raft request' (duration: 146.220283ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:51.959975Z","caller":"traceutil/trace.go:171","msg":"trace[484531618] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"102.262169ms","start":"2026-05-05T11:21:51.857698Z","end":"2026-05-05T11:21:51.95996Z","steps":["trace[484531618] 'process raft request' (duration: 102.002034ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:52.88611Z","caller":"traceutil/trace.go:171","msg":"trace[1071445937] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"117.823732ms","start":"2026-05-05T11:21:52.768226Z","end":"2026-05-05T11:21:52.88605Z","steps":["trace[1071445937] 'process raft request' (duration: 115.849342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:21:53.678024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.501664ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:21:53.678177Z","caller":"traceutil/trace.go:171","msg":"trace[539864391] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"110.149933ms","start":"2026-05-05T11:21:53.568008Z","end":"2026-05-05T11:21:53.678157Z","steps":["trace[539864391] 'read index received' (duration: 42.271µs)","trace[539864391] 'applied index is now lower than readState.Index' (duration: 110.104462ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:21:53.678271Z","caller":"traceutil/trace.go:171","msg":"trace[703798492] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"379.314236ms","start":"2026-05-05T11:21:53.298942Z","end":"2026-05-05T11:21:53.678256Z","steps":["trace[703798492] 'process raft request' (duration: 238.500245ms)","trace[703798492] 'compare' (duration: 140.213098ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:21:53.67834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:21:53.29891Z","time spent":"379.393808ms","remote":"127.0.0.1:39990","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T11:21:53.678645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.637842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-05T11:21:53.678699Z","caller":"traceutil/trace.go:171","msg":"trace[481946545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:597; }","duration":"110.734784ms","start":"2026-05-05T11:21:53.567948Z","end":"2026-05-05T11:21:53.678683Z","steps":["trace[481946545] 'agreement among raft nodes before linearized reading' (duration: 110.571221ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:21:54.016737Z","caller":"traceutil/trace.go:171","msg":"trace[496905822] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"136.439881ms","start":"2026-05-05T11:21:53.880277Z","end":"2026-05-05T11:21:54.016717Z","steps":["trace[496905822] 'process raft request' (duration: 135.89347ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:22:06.468573Z","caller":"traceutil/trace.go:171","msg":"trace[1943474671] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"195.619312ms","start":"2026-05-05T11:22:06.27292Z","end":"2026-05-05T11:22:06.468539Z","steps":["trace[1943474671] 'process raft request' (duration: 138.728038ms)","trace[1943474671] 'compare' (duration: 56.498946ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T11:23:05.158488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.960955ms","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-05-05T11:23:05.158596Z","caller":"traceutil/trace.go:171","msg":"trace[983551127] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1031; }","duration":"231.149389ms","start":"2026-05-05T11:23:04.927424Z","end":"2026-05-05T11:23:05.158573Z","steps":["trace[983551127] 'range keys from in-memory index tree' (duration: 230.704319ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:23:20.676666Z","caller":"traceutil/trace.go:171","msg":"trace[1553370575] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"401.264495ms","start":"2026-05-05T11:23:20.275379Z","end":"2026-05-05T11:23:20.676643Z","steps":["trace[1553370575] 'process raft request' (duration: 401.133942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:23:20.676806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:23:20.27536Z","time spent":"401.376497ms","remote":"127.0.0.1:40182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T11:23:20.709982Z","caller":"traceutil/trace.go:171","msg":"trace[986843725] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"433.757387ms","start":"2026-05-05T11:23:20.276197Z","end":"2026-05-05T11:23:20.709954Z","steps":["trace[986843725] 'process raft request' (duration: 433.582444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T11:23:20.710143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T11:23:20.276182Z","time spent":"433.862419ms","remote":"127.0.0.1:40182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T11:23:36.36475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.879234ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T11:23:36.364982Z","caller":"traceutil/trace.go:171","msg":"trace[1832768134] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"134.651773ms","start":"2026-05-05T11:23:36.230315Z","end":"2026-05-05T11:23:36.364967Z","steps":["trace[1832768134] 'process raft request' (duration: 134.612402ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:23:36.365187Z","caller":"traceutil/trace.go:171","msg":"trace[1735434498] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"261.196511ms","start":"2026-05-05T11:23:36.103945Z","end":"2026-05-05T11:23:36.365142Z","steps":["trace[1735434498] 'process raft request' (duration: 260.936016ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:23:36.364986Z","caller":"traceutil/trace.go:171","msg":"trace[1244800154] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"270.240495ms","start":"2026-05-05T11:23:36.094703Z","end":"2026-05-05T11:23:36.364944Z","steps":["trace[1244800154] 'process raft request' (duration: 118.083925ms)","trace[1244800154] 'compare' (duration: 151.780582ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:23:36.973886Z","caller":"traceutil/trace.go:171","msg":"trace[499138059] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"187.608042ms","start":"2026-05-05T11:23:36.786227Z","end":"2026-05-05T11:23:36.973835Z","steps":["trace[499138059] 'process raft request' (duration: 135.283006ms)","trace[499138059] 'compare' (duration: 52.155402ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T11:23:37.12401Z","caller":"traceutil/trace.go:171","msg":"trace[989535197] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"127.679011ms","start":"2026-05-05T11:23:36.996297Z","end":"2026-05-05T11:23:37.123976Z","steps":["trace[989535197] 'process raft request' (duration: 123.880684ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T11:23:49.359166Z","caller":"traceutil/trace.go:171","msg":"trace[813352949] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"172.211968ms","start":"2026-05-05T11:23:49.186913Z","end":"2026-05-05T11:23:49.359125Z","steps":["trace[813352949] 'process raft request' (duration: 171.959453ms)"],"step_count":1}