{"level":"warn","ts":"2026-05-19T01:15:40.3664Z","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-19T01:15:40.366599Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109: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.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-19T01:15:40.366749Z","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-19T01:15:40.366804Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-05-19T01:15:40.366866Z","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-19T01:15:40.368032Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-05-19T01:15:40.368203Z","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.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-19T01:15:40.372509Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.923746ms"} {"level":"info","ts":"2026-05-19T01:15:40.38521Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-05-19T01:15:40.385383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T01:15:40.38548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-05-19T01:15:40.385507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T01:15:40.386316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-05-19T01:15:40.386373Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-05-19T01:15:40.395993Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T01:15:40.397498Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T01:15:40.398685Z","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-19T01:15:40.40089Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T01:15:40.404811Z","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-19T01:15:40.404882Z","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-19T01:15:40.404925Z","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-19T01:15:40.404994Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T01:15:40.405527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-05-19T01:15:40.406299Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-05-19T01:15:40.407368Z","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-19T01:15:40.407576Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T01:15:40.407602Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T01:15:40.407956Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-05-19T01:15:40.407997Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-05-19T01:15:40.687284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T01:15:40.687345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T01:15:40.687363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-05-19T01:15:40.687377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-05-19T01:15:40.687385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-05-19T01:15:40.687396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-05-19T01:15:40.687489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-05-19T01:15:40.688169Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T01:15:40.688247Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T01:15:40.688521Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T01:15:40.688616Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T01:15:40.688675Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T01:15:40.688986Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T01:15:40.692397Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T01:15:40.692815Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-05-19T01:15:40.695247Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T01:15:40.695385Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T01:15:40.695427Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-19T01:15:45.123316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.773678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T01:15:45.123591Z","caller":"traceutil/trace.go:171","msg":"trace[1435864140] linearizableReadLoop","detail":"{readStateIndex:254; appliedIndex:253; }","duration":"168.302653ms","start":"2026-05-19T01:15:44.95527Z","end":"2026-05-19T01:15:45.123572Z","steps":["trace[1435864140] 'read index received' (duration: 46.3µs)","trace[1435864140] 'applied index is now lower than readState.Index' (duration: 168.254823ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T01:15:45.123765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.475615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T01:15:45.123838Z","caller":"traceutil/trace.go:171","msg":"trace[748647079] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:248; }","duration":"168.580177ms","start":"2026-05-19T01:15:44.955237Z","end":"2026-05-19T01:15:45.123817Z","steps":["trace[748647079] 'agreement among raft nodes before linearized reading' (duration: 168.381365ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:15:45.124113Z","caller":"traceutil/trace.go:171","msg":"trace[742324341] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"485.937408ms","start":"2026-05-19T01:15:44.638153Z","end":"2026-05-19T01:15:45.12409Z","steps":["trace[742324341] 'process raft request' (duration: 166.65236ms)","trace[742324341] 'compare' (duration: 317.572125ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T01:15:45.124261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T01:15:44.638121Z","time spent":"486.099509ms","remote":"127.0.0.1:41466","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T01:15:45.32865Z","caller":"traceutil/trace.go:171","msg":"trace[1557604475] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"201.286508ms","start":"2026-05-19T01:15:45.127316Z","end":"2026-05-19T01:15:45.328603Z","steps":["trace[1557604475] 'process raft request' (duration: 119.855817ms)","trace[1557604475] 'compare' (duration: 81.298689ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T01:15:45.328947Z","caller":"traceutil/trace.go:171","msg":"trace[1093731588] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"198.917877ms","start":"2026-05-19T01:15:45.130019Z","end":"2026-05-19T01:15:45.328936Z","steps":["trace[1093731588] 'process raft request' (duration: 198.864046ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:16:11.000461Z","caller":"traceutil/trace.go:171","msg":"trace[1538272454] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"209.979328ms","start":"2026-05-19T01:16:10.790448Z","end":"2026-05-19T01:16:11.000427Z","steps":["trace[1538272454] 'process raft request' (duration: 209.491054ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:16:16.210721Z","caller":"traceutil/trace.go:171","msg":"trace[1643133371] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"165.468918ms","start":"2026-05-19T01:16:16.045226Z","end":"2026-05-19T01:16:16.210695Z","steps":["trace[1643133371] 'process raft request' (duration: 164.778532ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:16:16.60011Z","caller":"traceutil/trace.go:171","msg":"trace[629690809] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"252.24874ms","start":"2026-05-19T01:16:16.347813Z","end":"2026-05-19T01:16:16.600062Z","steps":["trace[629690809] 'read index received' (duration: 205.522261ms)","trace[629690809] 'applied index is now lower than readState.Index' (duration: 46.724839ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T01:16:16.600186Z","caller":"traceutil/trace.go:171","msg":"trace[2000731239] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"329.953348ms","start":"2026-05-19T01:16:16.270197Z","end":"2026-05-19T01:16:16.600151Z","steps":["trace[2000731239] 'process raft request' (duration: 283.211379ms)","trace[2000731239] 'compare' (duration: 46.443587ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T01:16:16.60039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.551363ms","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-05-19T01:16:16.600454Z","caller":"traceutil/trace.go:171","msg":"trace[795037999] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:614; }","duration":"252.663144ms","start":"2026-05-19T01:16:16.347773Z","end":"2026-05-19T01:16:16.600436Z","steps":["trace[795037999] 'agreement among raft nodes before linearized reading' (duration: 252.498683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:16:16.600731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.979483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-46zpn\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-05-19T01:16:16.600819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T01:16:16.270176Z","time spent":"330.476202ms","remote":"127.0.0.1:41868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T01:16:16.600904Z","caller":"traceutil/trace.go:171","msg":"trace[825876518] range","detail":"{range_begin:/registry/pods/kube-system/cilium-46zpn; range_end:; response_count:1; response_revision:614; }","duration":"249.203775ms","start":"2026-05-19T01:16:16.351574Z","end":"2026-05-19T01:16:16.600777Z","steps":["trace[825876518] 'agreement among raft nodes before linearized reading' (duration: 248.827692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:16:16.60133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.63914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-19T01:16:16.601388Z","caller":"traceutil/trace.go:171","msg":"trace[308321144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"122.753962ms","start":"2026-05-19T01:16:16.478618Z","end":"2026-05-19T01:16:16.601372Z","steps":["trace[308321144] 'agreement among raft nodes before linearized reading' (duration: 122.617581ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:16:16.789887Z","caller":"traceutil/trace.go:171","msg":"trace[963297832] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"183.170416ms","start":"2026-05-19T01:16:16.606696Z","end":"2026-05-19T01:16:16.789866Z","steps":["trace[963297832] 'process raft request' (duration: 181.29666ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:16:16.790017Z","caller":"traceutil/trace.go:171","msg":"trace[456924476] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:633; }","duration":"177.969833ms","start":"2026-05-19T01:16:16.612029Z","end":"2026-05-19T01:16:16.789999Z","steps":["trace[456924476] 'read index received' (duration: 55.823055ms)","trace[456924476] 'applied index is now lower than readState.Index' (duration: 122.145178ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T01:16:16.790011Z","caller":"traceutil/trace.go:171","msg":"trace[2077786198] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"182.690562ms","start":"2026-05-19T01:16:16.607281Z","end":"2026-05-19T01:16:16.789972Z","steps":["trace[2077786198] 'process raft request' (duration: 182.46657ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:16:16.790068Z","caller":"traceutil/trace.go:171","msg":"trace[341084709] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"175.949115ms","start":"2026-05-19T01:16:16.614108Z","end":"2026-05-19T01:16:16.790057Z","steps":["trace[341084709] 'process raft request' (duration: 175.697783ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:16:16.790136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.094384ms","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-05-19T01:16:16.790191Z","caller":"traceutil/trace.go:171","msg":"trace[343297505] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:618; }","duration":"178.195654ms","start":"2026-05-19T01:16:16.611981Z","end":"2026-05-19T01:16:16.790177Z","steps":["trace[343297505] 'agreement among raft nodes before linearized reading' (duration: 178.076703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:16:31.891733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.549524ms","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-19T01:16:31.891835Z","caller":"traceutil/trace.go:171","msg":"trace[573114560] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:778; }","duration":"233.738245ms","start":"2026-05-19T01:16:31.658074Z","end":"2026-05-19T01:16:31.891812Z","steps":["trace[573114560] 'range keys from in-memory index tree' (duration: 233.343192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:16:59.209909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.050048ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-19T01:16:59.210055Z","caller":"traceutil/trace.go:171","msg":"trace[401429194] linearizableReadLoop","detail":"{readStateIndex:1209; appliedIndex:1208; }","duration":"216.504432ms","start":"2026-05-19T01:16:58.993534Z","end":"2026-05-19T01:16:59.210038Z","steps":["trace[401429194] 'read index received' (duration: 96.191473ms)","trace[401429194] 'applied index is now lower than readState.Index' (duration: 120.311489ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T01:16:59.21025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.70929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-19T01:16:59.210253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.67956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-19T01:16:59.21029Z","caller":"traceutil/trace.go:171","msg":"trace[1481992197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1177; }","duration":"216.783903ms","start":"2026-05-19T01:16:58.993494Z","end":"2026-05-19T01:16:59.210278Z","steps":["trace[1481992197] 'agreement among raft nodes before linearized reading' (duration: 216.634667ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:16:59.210303Z","caller":"traceutil/trace.go:171","msg":"trace[1343426544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1177; }","duration":"216.769152ms","start":"2026-05-19T01:16:58.99352Z","end":"2026-05-19T01:16:59.210289Z","steps":["trace[1343426544] 'agreement among raft nodes before linearized reading' (duration: 216.631907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:17:46.531769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.019872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6241c1fd-2099-4aa7-a7c3-1f3551a242e0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-19T01:17:46.532006Z","caller":"traceutil/trace.go:171","msg":"trace[1442587455] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6241c1fd-2099-4aa7-a7c3-1f3551a242e0; range_end:; response_count:1; response_revision:1858; }","duration":"267.310978ms","start":"2026-05-19T01:17:46.264674Z","end":"2026-05-19T01:17:46.531985Z","steps":["trace[1442587455] 'range keys from in-memory index tree' (duration: 266.794397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:17:46.532089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.024429ms","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-19T01:17:46.5322Z","caller":"traceutil/trace.go:171","msg":"trace[643251135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1858; }","duration":"233.173363ms","start":"2026-05-19T01:17:46.299007Z","end":"2026-05-19T01:17:46.532181Z","steps":["trace[643251135] 'range keys from in-memory index tree' (duration: 232.894787ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:17:47.006252Z","caller":"traceutil/trace.go:171","msg":"trace[1085689924] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"204.479708ms","start":"2026-05-19T01:17:46.801745Z","end":"2026-05-19T01:17:47.006225Z","steps":["trace[1085689924] 'process raft request' (duration: 204.248153ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:18:19.61453Z","caller":"traceutil/trace.go:171","msg":"trace[893446170] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"151.463425ms","start":"2026-05-19T01:18:19.46304Z","end":"2026-05-19T01:18:19.614503Z","steps":["trace[893446170] 'process raft request' (duration: 151.17355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:18:19.947976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.561153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T01:18:19.948203Z","caller":"traceutil/trace.go:171","msg":"trace[1373533622] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"259.617051ms","start":"2026-05-19T01:18:19.688523Z","end":"2026-05-19T01:18:19.94814Z","steps":["trace[1373533622] 'process raft request' (duration: 95.533009ms)","trace[1373533622] 'compare' (duration: 163.309369ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T01:18:20.886534Z","caller":"traceutil/trace.go:171","msg":"trace[1781195672] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"154.436077ms","start":"2026-05-19T01:18:20.732076Z","end":"2026-05-19T01:18:20.886512Z","steps":["trace[1781195672] 'process raft request' (duration: 154.01047ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:19:49.628387Z","caller":"traceutil/trace.go:171","msg":"trace[1750137408] transaction","detail":"{read_only:false; response_revision:2684; number_of_response:1; }","duration":"209.15773ms","start":"2026-05-19T01:19:49.419202Z","end":"2026-05-19T01:19:49.62836Z","steps":["trace[1750137408] 'process raft request' (duration: 208.986797ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:23:39.114684Z","caller":"traceutil/trace.go:171","msg":"trace[1222254484] linearizableReadLoop","detail":"{readStateIndex:4791; appliedIndex:4790; }","duration":"217.706243ms","start":"2026-05-19T01:23:38.896952Z","end":"2026-05-19T01:23:39.114658Z","steps":["trace[1222254484] 'read index received' (duration: 217.631472ms)","trace[1222254484] 'applied index is now lower than readState.Index' (duration: 73.611µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T01:23:39.114879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.911917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T01:23:39.114932Z","caller":"traceutil/trace.go:171","msg":"trace[2068699124] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4625; }","duration":"217.989659ms","start":"2026-05-19T01:23:38.896919Z","end":"2026-05-19T01:23:39.114909Z","steps":["trace[2068699124] 'agreement among raft nodes before linearized reading' (duration: 217.891677ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:23:39.11473Z","caller":"traceutil/trace.go:171","msg":"trace[1036904295] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"226.324444ms","start":"2026-05-19T01:23:38.888373Z","end":"2026-05-19T01:23:39.114697Z","steps":["trace[1036904295] 'process raft request' (duration: 226.137121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:23:39.15441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.90833ms","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-19T01:23:39.154473Z","caller":"traceutil/trace.go:171","msg":"trace[466514800] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4627; }","duration":"204.005322ms","start":"2026-05-19T01:23:38.950454Z","end":"2026-05-19T01:23:39.15446Z","steps":["trace[466514800] 'agreement among raft nodes before linearized reading' (duration: 203.805879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:23:51.824167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.017598ms","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-05-19T01:23:51.824222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.390087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-05-19T01:23:51.824247Z","caller":"traceutil/trace.go:171","msg":"trace[2032560179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4838; }","duration":"283.14111ms","start":"2026-05-19T01:23:51.541088Z","end":"2026-05-19T01:23:51.82423Z","steps":["trace[2032560179] 'range keys from in-memory index tree' (duration: 282.838075ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:23:51.824302Z","caller":"traceutil/trace.go:171","msg":"trace[1957168681] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4838; }","duration":"174.518199ms","start":"2026-05-19T01:23:51.649764Z","end":"2026-05-19T01:23:51.824282Z","steps":["trace[1957168681] 'range keys from in-memory index tree' (duration: 173.971351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:23:51.8248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.277814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-19T01:23:51.824843Z","caller":"traceutil/trace.go:171","msg":"trace[1276413826] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4838; }","duration":"113.355556ms","start":"2026-05-19T01:23:51.711476Z","end":"2026-05-19T01:23:51.824832Z","steps":["trace[1276413826] 'range keys from in-memory index tree' (duration: 113.109923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:23:52.142585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.904976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T01:23:52.14287Z","caller":"traceutil/trace.go:171","msg":"trace[2107691068] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"238.368546ms","start":"2026-05-19T01:23:51.904469Z","end":"2026-05-19T01:23:52.142838Z","steps":["trace[2107691068] 'process raft request' (duration: 37.091756ms)","trace[2107691068] 'compare' (duration: 200.692672ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T01:23:52.142971Z","caller":"traceutil/trace.go:171","msg":"trace[1645002305] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"237.87273ms","start":"2026-05-19T01:23:51.905078Z","end":"2026-05-19T01:23:52.142951Z","steps":["trace[1645002305] 'process raft request' (duration: 237.641507ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:23:52.143004Z","caller":"traceutil/trace.go:171","msg":"trace[1178463519] linearizableReadLoop","detail":"{readStateIndex:5017; appliedIndex:5014; }","duration":"231.115767ms","start":"2026-05-19T01:23:51.911862Z","end":"2026-05-19T01:23:52.142977Z","steps":["trace[1178463519] 'read index received' (duration: 29.627484ms)","trace[1178463519] 'applied index is now lower than readState.Index' (duration: 201.485803ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T01:23:52.143017Z","caller":"traceutil/trace.go:171","msg":"trace[1174808736] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"237.594796ms","start":"2026-05-19T01:23:51.90538Z","end":"2026-05-19T01:23:52.142975Z","steps":["trace[1174808736] 'process raft request' (duration: 237.436164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T01:23:52.143382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.958144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16402"} {"level":"warn","ts":"2026-05-19T01:23:52.143419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.621587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-19T01:23:52.143438Z","caller":"traceutil/trace.go:171","msg":"trace[1366484805] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4845; }","duration":"239.042385ms","start":"2026-05-19T01:23:51.904382Z","end":"2026-05-19T01:23:52.143424Z","steps":["trace[1366484805] 'agreement among raft nodes before linearized reading' (duration: 238.741711ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:23:52.143461Z","caller":"traceutil/trace.go:171","msg":"trace[130114412] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4845; }","duration":"141.676237ms","start":"2026-05-19T01:23:52.001773Z","end":"2026-05-19T01:23:52.14345Z","steps":["trace[130114412] 'agreement among raft nodes before linearized reading' (duration: 141.511665ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:25:40.916663Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2958} {"level":"info","ts":"2026-05-19T01:25:41.003719Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2958,"took":"85.62515ms","hash":791137817,"current-db-size-bytes":53297152,"current-db-size":"53 MB","current-db-size-in-use-bytes":29499392,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-19T01:25:41.003788Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":791137817,"revision":2958,"compact-revision":-1} {"level":"info","ts":"2026-05-19T01:27:57.286232Z","caller":"traceutil/trace.go:171","msg":"trace[1141467099] transaction","detail":"{read_only:false; response_revision:6624; number_of_response:1; }","duration":"102.92745ms","start":"2026-05-19T01:27:57.183274Z","end":"2026-05-19T01:27:57.286201Z","steps":["trace[1141467099] 'process raft request' (duration: 102.344854ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:30:40.926319Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5674} {"level":"warn","ts":"2026-05-19T01:30:41.095821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.596006ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T01:30:41.095954Z","caller":"traceutil/trace.go:171","msg":"trace[679936203] transaction","detail":"{read_only:false; response_revision:7477; number_of_response:1; }","duration":"121.377827ms","start":"2026-05-19T01:30:40.974554Z","end":"2026-05-19T01:30:41.095932Z","steps":["trace[679936203] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/cilium-operator-resource-lock; req_size:473; } (duration: 116.329224ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T01:30:41.171349Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5674,"took":"242.978058ms","hash":1902254259,"current-db-size-bytes":53297152,"current-db-size":"53 MB","current-db-size-in-use-bytes":18141184,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-19T01:30:41.171468Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1902254259,"revision":5674,"compact-revision":2958}