{"level":"warn","ts":"2026-04-16T09:15:01.661495Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T09:15:01.661686Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240: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.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-04-16T09:15:01.661765Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T09:15:01.661774Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-04-16T09:15:01.66261Z","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-04-16T09:15:01.663407Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-04-16T09:15:01.663662Z","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.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-04-16T09:15:01.667927Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.930202ms"} {"level":"info","ts":"2026-04-16T09:15:01.673818Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-04-16T09:15:01.673901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T09:15:01.673926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-04-16T09:15:01.673937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T09:15:01.673947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-04-16T09:15:01.673995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-04-16T09:15:01.68027Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T09:15:01.681595Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T09:15:01.682784Z","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-04-16T09:15:01.685566Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T09:15:01.686547Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T09:15:01.685869Z","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-04-16T09:15:01.687063Z","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-04-16T09:15:01.687193Z","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-04-16T09:15:01.687087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-04-16T09:15:01.687686Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-04-16T09:15:01.691798Z","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-04-16T09:15:01.692021Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-04-16T09:15:01.692083Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-04-16T09:15:01.693661Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T09:15:01.693704Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T09:15:01.975655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T09:15:01.975729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T09:15:01.975767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-04-16T09:15:01.975782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-04-16T09:15:01.97579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-04-16T09:15:01.975803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-04-16T09:15:01.975813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-04-16T09:15:01.977964Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T09:15:01.979105Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T09:15:01.97916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T09:15:01.979871Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T09:15:01.979918Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T09:15:01.980128Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T09:15:01.980172Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T09:15:01.980322Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T09:15:01.980436Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T09:15:01.987968Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-04-16T09:15:01.988493Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T09:15:05.51173Z","caller":"traceutil/trace.go:171","msg":"trace[501923092] transaction","detail":"{read_only:false; response_revision:132; number_of_response:1; }","duration":"105.002593ms","start":"2026-04-16T09:15:05.406691Z","end":"2026-04-16T09:15:05.511693Z","steps":["trace[501923092] 'process raft request' (duration: 75.105743ms)","trace[501923092] 'compare' (duration: 29.728357ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:15:07.120104Z","caller":"traceutil/trace.go:171","msg":"trace[578018576] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:210; }","duration":"220.41259ms","start":"2026-04-16T09:15:06.899636Z","end":"2026-04-16T09:15:07.120049Z","steps":["trace[578018576] 'read index received' (duration: 220.356298ms)","trace[578018576] 'applied index is now lower than readState.Index' (duration: 52.682µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:07.120049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:06.720002Z","time spent":"400.040753ms","remote":"127.0.0.1:54632","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-16T09:15:07.120286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.621423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"info","ts":"2026-04-16T09:15:07.120434Z","caller":"traceutil/trace.go:171","msg":"trace[1839854397] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:205; }","duration":"220.845407ms","start":"2026-04-16T09:15:06.899553Z","end":"2026-04-16T09:15:07.120399Z","steps":["trace[1839854397] 'agreement among raft nodes before linearized reading' (duration: 220.588603ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:07.141331Z","caller":"traceutil/trace.go:171","msg":"trace[1798730680] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"197.755022ms","start":"2026-04-16T09:15:06.94335Z","end":"2026-04-16T09:15:07.141105Z","steps":["trace[1798730680] 'process raft request' (duration: 197.534698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:07.404377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.604976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-ik1usy\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:15:07.404523Z","caller":"traceutil/trace.go:171","msg":"trace[890785403] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-ik1usy; range_end:; response_count:0; response_revision:208; }","duration":"186.81343ms","start":"2026-04-16T09:15:07.217668Z","end":"2026-04-16T09:15:07.404481Z","steps":["trace[890785403] 'range keys from in-memory index tree' (duration: 186.455714ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:07.404482Z","caller":"traceutil/trace.go:171","msg":"trace[900233572] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"186.338531ms","start":"2026-04-16T09:15:07.218103Z","end":"2026-04-16T09:15:07.404441Z","steps":["trace[900233572] 'process raft request' (duration: 113.142097ms)","trace[900233572] 'compare' (duration: 73.015351ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:07.782008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.551502ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T09:15:07.782124Z","caller":"traceutil/trace.go:171","msg":"trace[807340079] linearizableReadLoop","detail":"{readStateIndex:220; appliedIndex:218; }","duration":"316.34234ms","start":"2026-04-16T09:15:07.465762Z","end":"2026-04-16T09:15:07.782105Z","steps":["trace[807340079] 'read index received' (duration: 370.216µs)","trace[807340079] 'applied index is now lower than readState.Index' (duration: 315.970794ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:15:07.782152Z","caller":"traceutil/trace.go:171","msg":"trace[1509185845] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"353.481893ms","start":"2026-04-16T09:15:07.428642Z","end":"2026-04-16T09:15:07.782124Z","steps":["trace[1509185845] 'process raft request' (duration: 231.253598ms)","trace[1509185845] 'compare' (duration: 121.332358ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:07.782262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:07.428624Z","time spent":"353.577605ms","remote":"127.0.0.1:54650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11436,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T09:15:07.782294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.534904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:15:07.782331Z","caller":"traceutil/trace.go:171","msg":"trace[2104818258] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:214; }","duration":"316.634926ms","start":"2026-04-16T09:15:07.465685Z","end":"2026-04-16T09:15:07.78232Z","steps":["trace[2104818258] 'agreement among raft nodes before linearized reading' (duration: 316.519744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:07.782363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:07.465657Z","time spent":"316.699897ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T09:15:07.782371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.665114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/default/instance.18a6cb8af365edaa\" ","response":"range_response_count:1 size:657"} {"level":"info","ts":"2026-04-16T09:15:07.78247Z","caller":"traceutil/trace.go:171","msg":"trace[1676233786] range","detail":"{range_begin:/registry/events/default/instance.18a6cb8af365edaa; range_end:; response_count:1; response_revision:214; }","duration":"312.795606ms","start":"2026-04-16T09:15:07.469647Z","end":"2026-04-16T09:15:07.782443Z","steps":["trace[1676233786] 'agreement among raft nodes before linearized reading' (duration: 312.575342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:07.782556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:07.469635Z","time spent":"312.869167ms","remote":"127.0.0.1:54632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":680,"request content":"key:\"/registry/events/default/instance.18a6cb8af365edaa\" "} {"level":"info","ts":"2026-04-16T09:15:07.974744Z","caller":"traceutil/trace.go:171","msg":"trace[39278434] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"188.008823ms","start":"2026-04-16T09:15:07.786695Z","end":"2026-04-16T09:15:07.974704Z","steps":["trace[39278434] 'process raft request' (duration: 122.279196ms)","trace[39278434] 'compare' (duration: 65.33943ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:15:07.974797Z","caller":"traceutil/trace.go:171","msg":"trace[1794894309] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"160.549878ms","start":"2026-04-16T09:15:07.81421Z","end":"2026-04-16T09:15:07.97476Z","steps":["trace[1794894309] 'process raft request' (duration: 160.473177ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:07.97482Z","caller":"traceutil/trace.go:171","msg":"trace[1611835069] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"187.723858ms","start":"2026-04-16T09:15:07.787064Z","end":"2026-04-16T09:15:07.974788Z","steps":["trace[1611835069] 'process raft request' (duration: 187.486393ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:08.174993Z","caller":"traceutil/trace.go:171","msg":"trace[476349447] transaction","detail":"{read_only:false; response_revision:221; number_of_response:1; }","duration":"147.410163ms","start":"2026-04-16T09:15:08.027552Z","end":"2026-04-16T09:15:08.174962Z","steps":["trace[476349447] 'process raft request' (duration: 55.815153ms)","trace[476349447] 'compare' (duration: 91.422537ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:15:08.175001Z","caller":"traceutil/trace.go:171","msg":"trace[1833083547] linearizableReadLoop","detail":"{readStateIndex:227; appliedIndex:225; }","duration":"118.603115ms","start":"2026-04-16T09:15:08.056353Z","end":"2026-04-16T09:15:08.174957Z","steps":["trace[1833083547] 'read index received' (duration: 8.141059ms)","trace[1833083547] 'applied index is now lower than readState.Index' (duration: 110.460316ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:08.175261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.891471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:15:08.175309Z","caller":"traceutil/trace.go:171","msg":"trace[2142236323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:221; }","duration":"119.003103ms","start":"2026-04-16T09:15:08.056293Z","end":"2026-04-16T09:15:08.175296Z","steps":["trace[2142236323] 'agreement among raft nodes before linearized reading' (duration: 118.852691ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:10.190754Z","caller":"traceutil/trace.go:171","msg":"trace[1355270073] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"141.940848ms","start":"2026-04-16T09:15:10.048788Z","end":"2026-04-16T09:15:10.190729Z","steps":["trace[1355270073] 'process raft request' (duration: 141.790535ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:10.394182Z","caller":"traceutil/trace.go:171","msg":"trace[1302185677] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:325; }","duration":"325.411715ms","start":"2026-04-16T09:15:10.068727Z","end":"2026-04-16T09:15:10.394138Z","steps":["trace[1302185677] 'read index received' (duration: 121.881601ms)","trace[1302185677] 'applied index is now lower than readState.Index' (duration: 203.527924ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:15:10.394329Z","caller":"traceutil/trace.go:171","msg":"trace[338308927] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"337.841833ms","start":"2026-04-16T09:15:10.056433Z","end":"2026-04-16T09:15:10.394274Z","steps":["trace[338308927] 'process raft request' (duration: 337.431795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:10.394463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.7172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-16T09:15:10.394499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.218771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-16T09:15:10.394528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.513503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/pod-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:15:10.394555Z","caller":"traceutil/trace.go:171","msg":"trace[70823159] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:312; }","duration":"325.857174ms","start":"2026-04-16T09:15:10.068674Z","end":"2026-04-16T09:15:10.394531Z","steps":["trace[70823159] 'agreement among raft nodes before linearized reading' (duration: 325.688981ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:10.394613Z","caller":"traceutil/trace.go:171","msg":"trace[1860333856] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/pod-garbage-collector; range_end:; response_count:0; response_revision:312; }","duration":"198.657675ms","start":"2026-04-16T09:15:10.195919Z","end":"2026-04-16T09:15:10.394577Z","steps":["trace[1860333856] 'agreement among raft nodes before linearized reading' (duration: 198.502022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:10.394627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:10.068653Z","time spent":"325.964165ms","remote":"127.0.0.1:54824","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-04-16T09:15:10.394643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.405909ms","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-04-16T09:15:10.394672Z","caller":"traceutil/trace.go:171","msg":"trace[1957414663] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:312; }","duration":"187.447901ms","start":"2026-04-16T09:15:10.207214Z","end":"2026-04-16T09:15:10.394662Z","steps":["trace[1957414663] 'agreement among raft nodes before linearized reading' (duration: 187.40208ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:10.394558Z","caller":"traceutil/trace.go:171","msg":"trace[2117318159] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:312; }","duration":"184.286173ms","start":"2026-04-16T09:15:10.210255Z","end":"2026-04-16T09:15:10.394541Z","steps":["trace[2117318159] 'agreement among raft nodes before linearized reading' (duration: 184.191801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:10.394924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:10.056405Z","time spent":"338.038076ms","remote":"127.0.0.1:54742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T09:15:10.910289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.172765ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T09:15:10.910451Z","caller":"traceutil/trace.go:171","msg":"trace[1111617521] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"413.807103ms","start":"2026-04-16T09:15:10.496605Z","end":"2026-04-16T09:15:10.910412Z","steps":["trace[1111617521] 'process raft request' (duration: 202.410854ms)","trace[1111617521] 'compare' (duration: 210.94774ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:10.910528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:10.496589Z","time spent":"413.915025ms","remote":"127.0.0.1:54756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":186,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T09:15:10.945423Z","caller":"traceutil/trace.go:171","msg":"trace[1346967753] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:334; }","duration":"292.732058ms","start":"2026-04-16T09:15:10.652671Z","end":"2026-04-16T09:15:10.945403Z","steps":["trace[1346967753] 'read index received' (duration: 46.353899ms)","trace[1346967753] 'applied index is now lower than readState.Index' (duration: 246.376969ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:15:10.945492Z","caller":"traceutil/trace.go:171","msg":"trace[999363146] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"443.357343ms","start":"2026-04-16T09:15:10.502095Z","end":"2026-04-16T09:15:10.945452Z","steps":["trace[999363146] 'process raft request' (duration: 443.17315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:10.945598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.920091ms","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-04-16T09:15:10.945638Z","caller":"traceutil/trace.go:171","msg":"trace[1488487840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:321; }","duration":"292.973102ms","start":"2026-04-16T09:15:10.652651Z","end":"2026-04-16T09:15:10.945624Z","steps":["trace[1488487840] 'agreement among raft nodes before linearized reading' (duration: 292.87937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:10.945709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:10.502066Z","time spent":"443.511617ms","remote":"127.0.0.1:54742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:15:11.121339Z","caller":"traceutil/trace.go:171","msg":"trace[615532526] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"135.119179ms","start":"2026-04-16T09:15:10.98618Z","end":"2026-04-16T09:15:11.1213Z","steps":["trace[615532526] 'process raft request' (duration: 135.054659ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:11.121344Z","caller":"traceutil/trace.go:171","msg":"trace[997422144] transaction","detail":"{read_only:false; response_revision:323; number_of_response:1; }","duration":"164.115571ms","start":"2026-04-16T09:15:10.957195Z","end":"2026-04-16T09:15:11.12131Z","steps":["trace[997422144] 'process raft request' (duration: 127.92133ms)","trace[997422144] 'compare' (duration: 35.940027ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:15:11.304304Z","caller":"traceutil/trace.go:171","msg":"trace[34133252] linearizableReadLoop","detail":"{readStateIndex:340; appliedIndex:339; }","duration":"168.584072ms","start":"2026-04-16T09:15:11.135682Z","end":"2026-04-16T09:15:11.304266Z","steps":["trace[34133252] 'read index received' (duration: 122.461739ms)","trace[34133252] 'applied index is now lower than readState.Index' (duration: 46.120693ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:11.304563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.812156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-16T09:15:11.304598Z","caller":"traceutil/trace.go:171","msg":"trace[1386550706] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:325; }","duration":"168.922467ms","start":"2026-04-16T09:15:11.135661Z","end":"2026-04-16T09:15:11.304583Z","steps":["trace[1386550706] 'agreement among raft nodes before linearized reading' (duration: 168.742603ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:11.304591Z","caller":"traceutil/trace.go:171","msg":"trace[148974973] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"169.912606ms","start":"2026-04-16T09:15:11.134586Z","end":"2026-04-16T09:15:11.304498Z","steps":["trace[148974973] 'process raft request' (duration: 123.676231ms)","trace[148974973] 'compare' (duration: 45.848068ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:21.352742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.036735ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T09:15:21.35289Z","caller":"traceutil/trace.go:171","msg":"trace[909054722] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"873.494997ms","start":"2026-04-16T09:15:20.479378Z","end":"2026-04-16T09:15:21.352873Z","steps":["trace[909054722] 'process raft request' (duration: 377.24116ms)","trace[909054722] 'compare' (duration: 495.873391ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:21.352952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:20.479366Z","time spent":"873.562288ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:15:21.352967Z","caller":"traceutil/trace.go:171","msg":"trace[1118616062] linearizableReadLoop","detail":"{readStateIndex:464; appliedIndex:462; }","duration":"326.973094ms","start":"2026-04-16T09:15:21.025981Z","end":"2026-04-16T09:15:21.352954Z","steps":["trace[1118616062] 'read index received' (duration: 155.691566ms)","trace[1118616062] 'applied index is now lower than readState.Index' (duration: 171.280158ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:15:21.35304Z","caller":"traceutil/trace.go:171","msg":"trace[1551342609] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"870.877529ms","start":"2026-04-16T09:15:20.4821Z","end":"2026-04-16T09:15:21.352977Z","steps":["trace[1551342609] 'process raft request' (duration: 870.759327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:21.353287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:20.482062Z","time spent":"871.093774ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T09:15:21.35577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.765584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T09:15:21.355862Z","caller":"traceutil/trace.go:171","msg":"trace[1647280965] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:446; }","duration":"329.894346ms","start":"2026-04-16T09:15:21.025947Z","end":"2026-04-16T09:15:21.355841Z","steps":["trace[1647280965] 'agreement among raft nodes before linearized reading' (duration: 327.056245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:21.355909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:21.025933Z","time spent":"329.967527ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T09:15:26.964876Z","caller":"traceutil/trace.go:171","msg":"trace[962354468] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"471.872943ms","start":"2026-04-16T09:15:26.492963Z","end":"2026-04-16T09:15:26.964836Z","steps":["trace[962354468] 'process raft request' (duration: 471.67533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:26.965124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:26.492928Z","time spent":"472.068797ms","remote":"127.0.0.1:54824","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-04-16T09:15:31.778213Z","caller":"traceutil/trace.go:171","msg":"trace[622429880] linearizableReadLoop","detail":"{readStateIndex:525; appliedIndex:524; }","duration":"296.269018ms","start":"2026-04-16T09:15:31.481919Z","end":"2026-04-16T09:15:31.778188Z","steps":["trace[622429880] 'read index received' (duration: 296.021124ms)","trace[622429880] 'applied index is now lower than readState.Index' (duration: 246.724µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:31.778391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.443961ms","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-04-16T09:15:31.778351Z","caller":"traceutil/trace.go:171","msg":"trace[1852340843] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"305.423203ms","start":"2026-04-16T09:15:31.472879Z","end":"2026-04-16T09:15:31.778302Z","steps":["trace[1852340843] 'process raft request' (duration: 305.131887ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:31.778433Z","caller":"traceutil/trace.go:171","msg":"trace[1628165001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:504; }","duration":"296.552644ms","start":"2026-04-16T09:15:31.481867Z","end":"2026-04-16T09:15:31.77842Z","steps":["trace[1628165001] 'agreement among raft nodes before linearized reading' (duration: 296.457282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:31.778503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.835754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:15:31.778577Z","caller":"traceutil/trace.go:171","msg":"trace[197147739] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:504; }","duration":"188.969736ms","start":"2026-04-16T09:15:31.589589Z","end":"2026-04-16T09:15:31.778559Z","steps":["trace[197147739] 'agreement among raft nodes before linearized reading' (duration: 188.773332ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:31.778575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:31.472865Z","time spent":"305.599827ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T09:15:32.075656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.92396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:15:32.075758Z","caller":"traceutil/trace.go:171","msg":"trace[2124651085] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:505; }","duration":"124.093872ms","start":"2026-04-16T09:15:31.951638Z","end":"2026-04-16T09:15:32.075732Z","steps":["trace[2124651085] 'range keys from in-memory index tree' (duration: 123.848828ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:33.600362Z","caller":"traceutil/trace.go:171","msg":"trace[1296422645] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"146.278798ms","start":"2026-04-16T09:15:33.454054Z","end":"2026-04-16T09:15:33.600333Z","steps":["trace[1296422645] 'process raft request' (duration: 142.556481ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:37.223033Z","caller":"traceutil/trace.go:171","msg":"trace[2117393862] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"167.925994ms","start":"2026-04-16T09:15:37.055088Z","end":"2026-04-16T09:15:37.223014Z","steps":["trace[2117393862] 'process raft request' (duration: 167.790842ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:39.333771Z","caller":"traceutil/trace.go:171","msg":"trace[1624033946] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"289.322162ms","start":"2026-04-16T09:15:39.044423Z","end":"2026-04-16T09:15:39.333746Z","steps":["trace[1624033946] 'process raft request' (duration: 289.190988ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:39.334219Z","caller":"traceutil/trace.go:171","msg":"trace[1838500918] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:638; }","duration":"285.297739ms","start":"2026-04-16T09:15:39.04891Z","end":"2026-04-16T09:15:39.334208Z","steps":["trace[1838500918] 'read index received' (duration: 285.293039ms)","trace[1838500918] 'applied index is now lower than readState.Index' (duration: 3.86µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:39.334405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.761059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pmlxs\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-16T09:15:39.334435Z","caller":"traceutil/trace.go:171","msg":"trace[404935480] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pmlxs; range_end:; response_count:1; response_revision:613; }","duration":"244.8315ms","start":"2026-04-16T09:15:39.089594Z","end":"2026-04-16T09:15:39.334425Z","steps":["trace[404935480] 'agreement among raft nodes before linearized reading' (duration: 244.677857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:39.334635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.728687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T09:15:39.334662Z","caller":"traceutil/trace.go:171","msg":"trace[1639485275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:613; }","duration":"285.775098ms","start":"2026-04-16T09:15:39.048878Z","end":"2026-04-16T09:15:39.334653Z","steps":["trace[1639485275] 'agreement among raft nodes before linearized reading' (duration: 285.731968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:39.334829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.30115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-16T09:15:39.334855Z","caller":"traceutil/trace.go:171","msg":"trace[231620717] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"107.369592ms","start":"2026-04-16T09:15:39.227477Z","end":"2026-04-16T09:15:39.334847Z","steps":["trace[231620717] 'agreement among raft nodes before linearized reading' (duration: 107.294111ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:39.487237Z","caller":"traceutil/trace.go:171","msg":"trace[1159866074] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"131.329079ms","start":"2026-04-16T09:15:39.355873Z","end":"2026-04-16T09:15:39.487202Z","steps":["trace[1159866074] 'process raft request' (duration: 131.237668ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:39.487506Z","caller":"traceutil/trace.go:171","msg":"trace[327465880] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"138.656778ms","start":"2026-04-16T09:15:39.348811Z","end":"2026-04-16T09:15:39.487468Z","steps":["trace[327465880] 'read index received' (duration: 61.533895ms)","trace[327465880] 'applied index is now lower than readState.Index' (duration: 77.120443ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:39.487688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.861632ms","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-04-16T09:15:39.487722Z","caller":"traceutil/trace.go:171","msg":"trace[1652059652] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:615; }","duration":"138.934524ms","start":"2026-04-16T09:15:39.348776Z","end":"2026-04-16T09:15:39.487711Z","steps":["trace[1652059652] 'agreement among raft nodes before linearized reading' (duration: 138.828772ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:39.488301Z","caller":"traceutil/trace.go:171","msg":"trace[1800047225] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"144.614395ms","start":"2026-04-16T09:15:39.343662Z","end":"2026-04-16T09:15:39.488277Z","steps":["trace[1800047225] 'process raft request' (duration: 66.708818ms)","trace[1800047225] 'compare' (duration: 76.507092ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:40.502229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.754661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T09:15:40.502317Z","caller":"traceutil/trace.go:171","msg":"trace[2017827012] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.009370225s","start":"2026-04-16T09:15:39.49293Z","end":"2026-04-16T09:15:40.5023Z","steps":["trace[2017827012] 'process raft request' (duration: 609.470681ms)","trace[2017827012] 'compare' (duration: 399.491296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:40.50236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:39.492905Z","time spent":"1.009436097s","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:15:40.503132Z","caller":"traceutil/trace.go:171","msg":"trace[632163386] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"880.653873ms","start":"2026-04-16T09:15:39.622455Z","end":"2026-04-16T09:15:40.503108Z","steps":["trace[632163386] 'process raft request' (duration: 880.192975ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:40.503259Z","caller":"traceutil/trace.go:171","msg":"trace[317565588] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"720.134905ms","start":"2026-04-16T09:15:39.783105Z","end":"2026-04-16T09:15:40.503239Z","steps":["trace[317565588] 'process raft request' (duration: 719.584995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:40.503308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:39.78308Z","time spent":"720.206786ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T09:15:40.503378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:39.622429Z","time spent":"880.810876ms","remote":"127.0.0.1:54726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:15:40.503461Z","caller":"traceutil/trace.go:171","msg":"trace[2041480867] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:640; }","duration":"678.81569ms","start":"2026-04-16T09:15:39.824617Z","end":"2026-04-16T09:15:40.503432Z","steps":["trace[2041480867] 'read index received' (duration: 277.795485ms)","trace[2041480867] 'applied index is now lower than readState.Index' (duration: 401.018315ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:40.503713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.586834ms","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-04-16T09:15:40.503797Z","caller":"traceutil/trace.go:171","msg":"trace[1638237046] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"610.720248ms","start":"2026-04-16T09:15:39.893052Z","end":"2026-04-16T09:15:40.503772Z","steps":["trace[1638237046] 'agreement among raft nodes before linearized reading' (duration: 610.572915ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:40.503681Z","caller":"traceutil/trace.go:171","msg":"trace[1128304121] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"606.319519ms","start":"2026-04-16T09:15:39.897287Z","end":"2026-04-16T09:15:40.503606Z","steps":["trace[1128304121] 'process raft request' (duration: 605.616126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:40.503856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:39.893037Z","time spent":"610.805057ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T09:15:40.503729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"679.102964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T09:15:40.504967Z","caller":"traceutil/trace.go:171","msg":"trace[1224376026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"680.410788ms","start":"2026-04-16T09:15:39.824529Z","end":"2026-04-16T09:15:40.50494Z","steps":["trace[1224376026] 'agreement among raft nodes before linearized reading' (duration: 679.064394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:40.505064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:39.824507Z","time spent":"680.53765ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T09:15:40.504384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:39.897273Z","time spent":"606.638494ms","remote":"127.0.0.1:54650","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:15:42.405818Z","caller":"traceutil/trace.go:171","msg":"trace[2140504242] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"161.769825ms","start":"2026-04-16T09:15:42.24402Z","end":"2026-04-16T09:15:42.40579Z","steps":["trace[2140504242] 'process raft request' (duration: 161.599782ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:56.325976Z","caller":"traceutil/trace.go:171","msg":"trace[1122049206] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"109.663975ms","start":"2026-04-16T09:15:56.216276Z","end":"2026-04-16T09:15:56.32594Z","steps":["trace[1122049206] 'process raft request' (duration: 109.246444ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:56.75824Z","caller":"traceutil/trace.go:171","msg":"trace[812266543] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"170.824675ms","start":"2026-04-16T09:15:56.58738Z","end":"2026-04-16T09:15:56.758205Z","steps":["trace[812266543] 'process raft request' (duration: 170.565687ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:15:57.023766Z","caller":"traceutil/trace.go:171","msg":"trace[1315780447] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"436.187501ms","start":"2026-04-16T09:15:56.587541Z","end":"2026-04-16T09:15:57.023728Z","steps":["trace[1315780447] 'process raft request' (duration: 411.187258ms)","trace[1315780447] 'compare' (duration: 24.729966ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T09:15:57.024074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:56.587525Z","time spent":"436.350007ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:15:57.02419Z","caller":"traceutil/trace.go:171","msg":"trace[1650884185] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"436.479209ms","start":"2026-04-16T09:15:56.587583Z","end":"2026-04-16T09:15:57.024062Z","steps":["trace[1650884185] 'process raft request' (duration: 436.081149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:15:57.024482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:15:56.587529Z","time spent":"436.795069ms","remote":"127.0.0.1:54824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T09:15:57.198374Z","caller":"traceutil/trace.go:171","msg":"trace[1231289071] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"149.613818ms","start":"2026-04-16T09:15:57.048719Z","end":"2026-04-16T09:15:57.198333Z","steps":["trace[1231289071] 'process raft request' (duration: 143.254206ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:14.980354Z","caller":"traceutil/trace.go:171","msg":"trace[744310088] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"121.030555ms","start":"2026-04-16T09:16:14.859298Z","end":"2026-04-16T09:16:14.980329Z","steps":["trace[744310088] 'process raft request' (duration: 120.856911ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:15.224727Z","caller":"traceutil/trace.go:171","msg":"trace[557336319] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"102.278708ms","start":"2026-04-16T09:16:15.122417Z","end":"2026-04-16T09:16:15.224696Z","steps":["trace[557336319] 'process raft request' (duration: 102.049822ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:15.703483Z","caller":"traceutil/trace.go:171","msg":"trace[1649563898] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"580.95105ms","start":"2026-04-16T09:16:15.122496Z","end":"2026-04-16T09:16:15.703447Z","steps":["trace[1649563898] 'process raft request' (duration: 580.707533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:15.703877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T09:16:15.122479Z","time spent":"581.125465ms","remote":"127.0.0.1:54824","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-04-16T09:16:15.710447Z","caller":"traceutil/trace.go:171","msg":"trace[782434244] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"262.184291ms","start":"2026-04-16T09:16:15.448232Z","end":"2026-04-16T09:16:15.710416Z","steps":["trace[782434244] 'process raft request' (duration: 261.916614ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:15.710704Z","caller":"traceutil/trace.go:171","msg":"trace[1800678076] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"244.07623ms","start":"2026-04-16T09:16:15.46659Z","end":"2026-04-16T09:16:15.710666Z","steps":["trace[1800678076] 'process raft request' (duration: 243.756742ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:41.445604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.264916ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T09:16:41.445895Z","caller":"traceutil/trace.go:171","msg":"trace[138201580] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1115; }","duration":"127.965725ms","start":"2026-04-16T09:16:41.317894Z","end":"2026-04-16T09:16:41.44586Z","steps":["trace[138201580] 'read index received' (duration: 13.447543ms)","trace[138201580] 'applied index is now lower than readState.Index' (duration: 114.515862ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:16:41.446003Z","caller":"traceutil/trace.go:171","msg":"trace[385085284] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"122.527006ms","start":"2026-04-16T09:16:41.323453Z","end":"2026-04-16T09:16:41.44598Z","steps":["trace[385085284] 'process raft request' (duration: 122.360702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:41.446245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.329954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-567912be-6bbe-47b6-af50-0320121d792f\" ","response":"range_response_count:1 size:3885"} {"level":"info","ts":"2026-04-16T09:16:41.446349Z","caller":"traceutil/trace.go:171","msg":"trace[1388556033] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-567912be-6bbe-47b6-af50-0320121d792f; range_end:; response_count:1; response_revision:1075; }","duration":"128.442657ms","start":"2026-04-16T09:16:41.317841Z","end":"2026-04-16T09:16:41.446284Z","steps":["trace[1388556033] 'agreement among raft nodes before linearized reading' (duration: 128.147749ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:42.567803Z","caller":"traceutil/trace.go:171","msg":"trace[1801941421] linearizableReadLoop","detail":"{readStateIndex:1123; appliedIndex:1122; }","duration":"115.529011ms","start":"2026-04-16T09:16:42.452245Z","end":"2026-04-16T09:16:42.567774Z","steps":["trace[1801941421] 'read index received' (duration: 115.167312ms)","trace[1801941421] 'applied index is now lower than readState.Index' (duration: 360.539µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:16:42.567884Z","caller":"traceutil/trace.go:171","msg":"trace[1831625786] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"156.573097ms","start":"2026-04-16T09:16:42.411267Z","end":"2026-04-16T09:16:42.56784Z","steps":["trace[1831625786] 'process raft request' (duration: 156.238148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:42.568196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.922112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-567912be-6bbe-47b6-af50-0320121d792f\" ","response":"range_response_count:1 size:3887"} {"level":"info","ts":"2026-04-16T09:16:42.568273Z","caller":"traceutil/trace.go:171","msg":"trace[222226621] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-567912be-6bbe-47b6-af50-0320121d792f; range_end:; response_count:1; response_revision:1081; }","duration":"116.084976ms","start":"2026-04-16T09:16:42.452168Z","end":"2026-04-16T09:16:42.568253Z","steps":["trace[222226621] 'agreement among raft nodes before linearized reading' (duration: 115.768568ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T09:16:54.109225Z","caller":"traceutil/trace.go:171","msg":"trace[1406486950] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1181; }","duration":"142.107429ms","start":"2026-04-16T09:16:53.967102Z","end":"2026-04-16T09:16:54.109209Z","steps":["trace[1406486950] 'read index received' (duration: 141.921084ms)","trace[1406486950] 'applied index is now lower than readState.Index' (duration: 185.615µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T09:16:54.1097Z","caller":"traceutil/trace.go:171","msg":"trace[1262643740] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"212.973051ms","start":"2026-04-16T09:16:53.896676Z","end":"2026-04-16T09:16:54.109649Z","steps":["trace[1262643740] 'process raft request' (duration: 212.433117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:54.109781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.084573ms","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-04-16T09:16:54.109992Z","caller":"traceutil/trace.go:171","msg":"trace[1281000822] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1138; }","duration":"106.230207ms","start":"2026-04-16T09:16:54.003594Z","end":"2026-04-16T09:16:54.109824Z","steps":["trace[1281000822] 'agreement among raft nodes before linearized reading' (duration: 106.000722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T09:16:54.110299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.192665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T09:16:54.110392Z","caller":"traceutil/trace.go:171","msg":"trace[313757493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1138; }","duration":"143.345379ms","start":"2026-04-16T09:16:53.967033Z","end":"2026-04-16T09:16:54.110379Z","steps":["trace[313757493] 'agreement among raft nodes before linearized reading' (duration: 142.55926ms)"],"step_count":1}