{"level":"warn","ts":"2026-04-07T00:00:27.049952Z","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-07T00:00:27.050075Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.233: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.233:2380","--initial-cluster=instance=https://199.204.45.233:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.233:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.233: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-07T00:00:27.050166Z","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-07T00:00:27.050184Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-07T00:00:27.050214Z","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-07T00:00:27.051063Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"]} {"level":"info","ts":"2026-04-07T00:00:27.051165Z","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.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.233: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-07T00:00:27.359687Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"248.01835ms"} {"level":"info","ts":"2026-04-07T00:00:27.606214Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"90a0cb2044183f95","cluster-id":"782fef34d5ea94f9"} {"level":"info","ts":"2026-04-07T00:00:27.606319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T00:00:27.606356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 0"} {"level":"info","ts":"2026-04-07T00:00:27.606376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 90a0cb2044183f95 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T00:00:27.606385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became follower at term 1"} {"level":"info","ts":"2026-04-07T00:00:27.60643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"warn","ts":"2026-04-07T00:00:27.609802Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T00:00:27.61102Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T00:00:27.612003Z","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-07T00:00:27.614366Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"90a0cb2044183f95","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T00:00:27.614566Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"90a0cb2044183f95","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T00:00:27.614797Z","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-07T00:00:27.614873Z","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-07T00:00:27.614891Z","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-07T00:00:27.61656Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 switched to configuration voters=(10421552877177159573)"} {"level":"info","ts":"2026-04-07T00:00:27.61743Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","added-peer-id":"90a0cb2044183f95","added-peer-peer-urls":["https://199.204.45.233:2380"]} {"level":"info","ts":"2026-04-07T00:00:27.620308Z","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-07T00:00:27.620419Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-07T00:00:27.620504Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.233:2380"} {"level":"info","ts":"2026-04-07T00:00:27.620728Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"90a0cb2044183f95","initial-advertise-peer-urls":["https://199.204.45.233:2380"],"listen-peer-urls":["https://199.204.45.233:2380"],"advertise-client-urls":["https://199.204.45.233:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.233:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T00:00:27.620784Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T00:00:28.107208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T00:00:28.107278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T00:00:28.107328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgPreVoteResp from 90a0cb2044183f95 at term 1"} {"level":"info","ts":"2026-04-07T00:00:28.107343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became candidate at term 2"} {"level":"info","ts":"2026-04-07T00:00:28.107349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 received MsgVoteResp from 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-07T00:00:28.107358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"90a0cb2044183f95 became leader at term 2"} {"level":"info","ts":"2026-04-07T00:00:28.107366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 90a0cb2044183f95 elected leader 90a0cb2044183f95 at term 2"} {"level":"info","ts":"2026-04-07T00:00:28.108572Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"90a0cb2044183f95","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.233:2379]}","request-path":"/0/members/90a0cb2044183f95/attributes","cluster-id":"782fef34d5ea94f9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T00:00:28.108581Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:00:28.108644Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:00:28.108644Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:00:28.108936Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T00:00:28.108961Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T00:00:28.109929Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"782fef34d5ea94f9","local-member-id":"90a0cb2044183f95","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:00:28.11009Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:00:28.110146Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:00:28.112074Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.233:2379"} {"level":"info","ts":"2026-04-07T00:00:28.112391Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T00:00:59.059676Z","caller":"traceutil/trace.go:171","msg":"trace[253925919] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"141.106569ms","start":"2026-04-07T00:00:58.918532Z","end":"2026-04-07T00:00:59.059638Z","steps":["trace[253925919] 'process raft request' (duration: 60.379218ms)","trace[253925919] 'compare' (duration: 79.76962ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:00:59.061773Z","caller":"traceutil/trace.go:171","msg":"trace[1355563460] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"120.391566ms","start":"2026-04-07T00:00:58.941366Z","end":"2026-04-07T00:00:59.061757Z","steps":["trace[1355563460] 'process raft request' (duration: 118.287103ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:04.268964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.032132ms","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-07T00:01:04.269184Z","caller":"traceutil/trace.go:171","msg":"trace[1998659575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:562; }","duration":"184.325964ms","start":"2026-04-07T00:01:04.084831Z","end":"2026-04-07T00:01:04.269157Z","steps":["trace[1998659575] 'range keys from in-memory index tree' (duration: 183.759039ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:04.493023Z","caller":"traceutil/trace.go:171","msg":"trace[1267005777] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"104.738797ms","start":"2026-04-07T00:01:04.388237Z","end":"2026-04-07T00:01:04.492976Z","steps":["trace[1267005777] 'process raft request' (duration: 104.415244ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:04.930862Z","caller":"traceutil/trace.go:171","msg":"trace[1346450019] linearizableReadLoop","detail":"{readStateIndex:587; appliedIndex:585; }","duration":"424.859345ms","start":"2026-04-07T00:01:04.50597Z","end":"2026-04-07T00:01:04.930829Z","steps":["trace[1346450019] 'read index received' (duration: 2.567038ms)","trace[1346450019] 'applied index is now lower than readState.Index' (duration: 422.291097ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:01:04.931205Z","caller":"traceutil/trace.go:171","msg":"trace[1886138777] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"433.192354ms","start":"2026-04-07T00:01:04.497991Z","end":"2026-04-07T00:01:04.931184Z","steps":["trace[1886138777] 'process raft request' (duration: 354.135603ms)","trace[1886138777] 'compare' (duration: 78.553735ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:01:04.931434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.413341ms","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-07T00:01:04.93152Z","caller":"traceutil/trace.go:171","msg":"trace[925704536] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:567; }","duration":"425.570072ms","start":"2026-04-07T00:01:04.505929Z","end":"2026-04-07T00:01:04.931499Z","steps":["trace[925704536] 'agreement among raft nodes before linearized reading' (duration: 425.37687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:04.931554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:04.505913Z","time spent":"425.634613ms","remote":"127.0.0.1:35368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-07T00:01:04.931872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:04.497967Z","time spent":"433.294106ms","remote":"127.0.0.1:35396","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-07T00:01:05.285991Z","caller":"traceutil/trace.go:171","msg":"trace[1800547349] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"264.231888ms","start":"2026-04-07T00:01:05.021715Z","end":"2026-04-07T00:01:05.285947Z","steps":["trace[1800547349] 'read index received' (duration: 226.389893ms)","trace[1800547349] 'applied index is now lower than readState.Index' (duration: 37.841035ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:01:05.286212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.48123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:01:05.286251Z","caller":"traceutil/trace.go:171","msg":"trace[1459736299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:568; }","duration":"264.590371ms","start":"2026-04-07T00:01:05.021653Z","end":"2026-04-07T00:01:05.286243Z","steps":["trace[1459736299] 'agreement among raft nodes before linearized reading' (duration: 264.4627ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:05.28646Z","caller":"traceutil/trace.go:171","msg":"trace[294842979] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"340.346415ms","start":"2026-04-07T00:01:04.946103Z","end":"2026-04-07T00:01:05.286449Z","steps":["trace[294842979] 'process raft request' (duration: 302.083096ms)","trace[294842979] 'compare' (duration: 37.620132ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:01:05.286551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:04.946056Z","time spent":"340.429837ms","remote":"127.0.0.1:35330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:01:05.454336Z","caller":"traceutil/trace.go:171","msg":"trace[1083998048] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"133.354667ms","start":"2026-04-07T00:01:05.320961Z","end":"2026-04-07T00:01:05.454316Z","steps":["trace[1083998048] 'process raft request' (duration: 132.857792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:21.033615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.885606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T00:01:21.033734Z","caller":"traceutil/trace.go:171","msg":"trace[1328361132] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:730; }","duration":"116.053148ms","start":"2026-04-07T00:01:20.917665Z","end":"2026-04-07T00:01:21.033718Z","steps":["trace[1328361132] 'range keys from in-memory index tree' (duration: 115.729255ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:02:17.482143Z","caller":"traceutil/trace.go:171","msg":"trace[720332059] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"111.657406ms","start":"2026-04-07T00:02:17.370462Z","end":"2026-04-07T00:02:17.482119Z","steps":["trace[720332059] 'process raft request' (duration: 111.511142ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:02:17.48357Z","caller":"traceutil/trace.go:171","msg":"trace[1552326544] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"111.648447ms","start":"2026-04-07T00:02:17.371901Z","end":"2026-04-07T00:02:17.48355Z","steps":["trace[1552326544] 'process raft request' (duration: 111.539673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:02:43.041029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.450211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6663de45-ea53-46ea-b1a6-c60b9908ad11\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T00:02:43.0411Z","caller":"traceutil/trace.go:171","msg":"trace[861195696] linearizableReadLoop","detail":"{readStateIndex:1884; appliedIndex:1883; }","duration":"117.019109ms","start":"2026-04-07T00:02:42.924053Z","end":"2026-04-07T00:02:43.041072Z","steps":["trace[861195696] 'read index received' (duration: 40.676891ms)","trace[861195696] 'applied index is now lower than readState.Index' (duration: 76.341038ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:02:43.041153Z","caller":"traceutil/trace.go:171","msg":"trace[1416265226] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6663de45-ea53-46ea-b1a6-c60b9908ad11; range_end:; response_count:1; response_revision:1814; }","duration":"242.642576ms","start":"2026-04-07T00:02:42.798482Z","end":"2026-04-07T00:02:43.041124Z","steps":["trace[1416265226] 'range keys from in-memory index tree' (duration: 242.206045ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:02:43.041354Z","caller":"traceutil/trace.go:171","msg":"trace[272497526] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"154.346548ms","start":"2026-04-07T00:02:42.886959Z","end":"2026-04-07T00:02:43.041305Z","steps":["trace[272497526] 'process raft request' (duration: 77.761063ms)","trace[272497526] 'compare' (duration: 75.818084ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:02:43.041811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.739608ms","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-04-07T00:02:43.041921Z","caller":"traceutil/trace.go:171","msg":"trace[1065536689] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1815; }","duration":"117.921403ms","start":"2026-04-07T00:02:42.923971Z","end":"2026-04-07T00:02:43.041893Z","steps":["trace[1065536689] 'agreement among raft nodes before linearized reading' (duration: 117.502461ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:02:43.378442Z","caller":"traceutil/trace.go:171","msg":"trace[1230925815] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"151.552099ms","start":"2026-04-07T00:02:43.226857Z","end":"2026-04-07T00:02:43.378409Z","steps":["trace[1230925815] 'process raft request' (duration: 150.822419ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:03:16.734525Z","caller":"traceutil/trace.go:171","msg":"trace[1234555138] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"106.133322ms","start":"2026-04-07T00:03:16.628348Z","end":"2026-04-07T00:03:16.734482Z","steps":["trace[1234555138] 'process raft request' (duration: 98.757862ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:03:17.26993Z","caller":"traceutil/trace.go:171","msg":"trace[403430079] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"156.299552ms","start":"2026-04-07T00:03:17.113602Z","end":"2026-04-07T00:03:17.269901Z","steps":["trace[403430079] 'process raft request' (duration: 156.060777ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:03:17.500389Z","caller":"traceutil/trace.go:171","msg":"trace[2134879932] linearizableReadLoop","detail":"{readStateIndex:2136; appliedIndex:2135; }","duration":"196.005948ms","start":"2026-04-07T00:03:17.304351Z","end":"2026-04-07T00:03:17.500357Z","steps":["trace[2134879932] 'read index received' (duration: 117.449373ms)","trace[2134879932] 'applied index is now lower than readState.Index' (duration: 78.553845ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:03:17.5005Z","caller":"traceutil/trace.go:171","msg":"trace[961631308] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"221.693432ms","start":"2026-04-07T00:03:17.278759Z","end":"2026-04-07T00:03:17.500452Z","steps":["trace[961631308] 'process raft request' (duration: 143.011345ms)","trace[961631308] 'compare' (duration: 77.941671ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:03:17.500619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.251614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T00:03:17.500723Z","caller":"traceutil/trace.go:171","msg":"trace[743249670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2061; }","duration":"196.386497ms","start":"2026-04-07T00:03:17.304315Z","end":"2026-04-07T00:03:17.500701Z","steps":["trace[743249670] 'agreement among raft nodes before linearized reading' (duration: 196.137311ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:04:53.951506Z","caller":"traceutil/trace.go:171","msg":"trace[1593942994] linearizableReadLoop","detail":"{readStateIndex:2783; appliedIndex:2782; }","duration":"103.542283ms","start":"2026-04-07T00:04:53.847932Z","end":"2026-04-07T00:04:53.951474Z","steps":["trace[1593942994] 'read index received' (duration: 103.311439ms)","trace[1593942994] 'applied index is now lower than readState.Index' (duration: 229.714µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:04:53.951727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.780096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:04:53.951778Z","caller":"traceutil/trace.go:171","msg":"trace[907579447] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:2685; }","duration":"103.852057ms","start":"2026-04-07T00:04:53.84791Z","end":"2026-04-07T00:04:53.951762Z","steps":["trace[907579447] 'agreement among raft nodes before linearized reading' (duration: 103.717595ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:04:53.952181Z","caller":"traceutil/trace.go:171","msg":"trace[1862766474] transaction","detail":"{read_only:false; response_revision:2685; number_of_response:1; }","duration":"125.266035ms","start":"2026-04-07T00:04:53.826898Z","end":"2026-04-07T00:04:53.952165Z","steps":["trace[1862766474] 'process raft request' (duration: 124.420951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:49.200544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.734476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-04-07T00:08:49.200635Z","caller":"traceutil/trace.go:171","msg":"trace[598547059] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4688; }","duration":"243.869889ms","start":"2026-04-07T00:08:48.956748Z","end":"2026-04-07T00:08:49.200618Z","steps":["trace[598547059] 'range keys from in-memory index tree' (duration: 243.543463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:49.200668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.105395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:08:49.200751Z","caller":"traceutil/trace.go:171","msg":"trace[635347384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4688; }","duration":"179.230887ms","start":"2026-04-07T00:08:49.0215Z","end":"2026-04-07T00:08:49.200731Z","steps":["trace[635347384] 'range keys from in-memory index tree' (duration: 179.013653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:49.200689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.438537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-07T00:08:49.200888Z","caller":"traceutil/trace.go:171","msg":"trace[829939866] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4688; }","duration":"206.718553ms","start":"2026-04-07T00:08:48.994138Z","end":"2026-04-07T00:08:49.200857Z","steps":["trace[829939866] 'range keys from in-memory index tree' (duration: 206.114331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:49.645349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.552979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-04-07T00:08:49.645428Z","caller":"traceutil/trace.go:171","msg":"trace[1962033529] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4698; }","duration":"229.651732ms","start":"2026-04-07T00:08:49.415754Z","end":"2026-04-07T00:08:49.645405Z","steps":["trace[1962033529] 'range keys from in-memory index tree' (duration: 229.422257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:49.645881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.168106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-54506744-481e-4278-9763-d703da0871ea\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-07T00:08:49.647086Z","caller":"traceutil/trace.go:171","msg":"trace[1633216459] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-54506744-481e-4278-9763-d703da0871ea; range_end:; response_count:1; response_revision:4698; }","duration":"227.396609ms","start":"2026-04-07T00:08:49.419666Z","end":"2026-04-07T00:08:49.647063Z","steps":["trace[1633216459] 'range keys from in-memory index tree' (duration: 226.042343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:08:49.646368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.769055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T00:08:49.647246Z","caller":"traceutil/trace.go:171","msg":"trace[1122260870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4698; }","duration":"182.660982ms","start":"2026-04-07T00:08:49.464572Z","end":"2026-04-07T00:08:49.647233Z","steps":["trace[1122260870] 'range keys from in-memory index tree' (duration: 181.684203ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:08:49.879815Z","caller":"traceutil/trace.go:171","msg":"trace[2066725646] linearizableReadLoop","detail":"{readStateIndex:4874; appliedIndex:4871; }","duration":"191.352013ms","start":"2026-04-07T00:08:49.688439Z","end":"2026-04-07T00:08:49.879791Z","steps":["trace[2066725646] 'read index received' (duration: 20.097496ms)","trace[2066725646] 'applied index is now lower than readState.Index' (duration: 171.252897ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:08:49.879978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.522637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:08:49.880017Z","caller":"traceutil/trace.go:171","msg":"trace[795300880] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:4702; }","duration":"191.608708ms","start":"2026-04-07T00:08:49.688395Z","end":"2026-04-07T00:08:49.880004Z","steps":["trace[795300880] 'agreement among raft nodes before linearized reading' (duration: 191.497546ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:08:49.880106Z","caller":"traceutil/trace.go:171","msg":"trace[1861099264] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"216.878652ms","start":"2026-04-07T00:08:49.663203Z","end":"2026-04-07T00:08:49.880082Z","steps":["trace[1861099264] 'process raft request' (duration: 120.66382ms)","trace[1861099264] 'compare' (duration: 95.745003ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:08:49.907105Z","caller":"traceutil/trace.go:171","msg":"trace[1727491902] transaction","detail":"{read_only:false; response_revision:4704; number_of_response:1; }","duration":"127.336265ms","start":"2026-04-07T00:08:49.779751Z","end":"2026-04-07T00:08:49.907088Z","steps":["trace[1727491902] 'process raft request' (duration: 127.296004ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:08:49.907301Z","caller":"traceutil/trace.go:171","msg":"trace[1507881095] transaction","detail":"{read_only:false; response_revision:4703; number_of_response:1; }","duration":"159.65644ms","start":"2026-04-07T00:08:49.747569Z","end":"2026-04-07T00:08:49.907226Z","steps":["trace[1507881095] 'process raft request' (duration: 159.380075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:01.245191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.14855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:09:01.245276Z","caller":"traceutil/trace.go:171","msg":"trace[1259970357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4855; }","duration":"223.241082ms","start":"2026-04-07T00:09:01.022016Z","end":"2026-04-07T00:09:01.245257Z","steps":["trace[1259970357] 'range keys from in-memory index tree' (duration: 223.070729ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:01.539295Z","caller":"traceutil/trace.go:171","msg":"trace[1295408917] linearizableReadLoop","detail":"{readStateIndex:5037; appliedIndex:5036; }","duration":"141.346539ms","start":"2026-04-07T00:09:01.397907Z","end":"2026-04-07T00:09:01.539253Z","steps":["trace[1295408917] 'read index received' (duration: 117.57875ms)","trace[1295408917] 'applied index is now lower than readState.Index' (duration: 23.765989ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:09:01.539651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.712005ms","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-04-07T00:09:01.539719Z","caller":"traceutil/trace.go:171","msg":"trace[1750980143] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4860; }","duration":"141.808107ms","start":"2026-04-07T00:09:01.397889Z","end":"2026-04-07T00:09:01.539697Z","steps":["trace[1750980143] 'agreement among raft nodes before linearized reading' (duration: 141.500781ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:01.539807Z","caller":"traceutil/trace.go:171","msg":"trace[1055593059] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"143.541989ms","start":"2026-04-07T00:09:01.396106Z","end":"2026-04-07T00:09:01.539648Z","steps":["trace[1055593059] 'process raft request' (duration: 119.443624ms)","trace[1055593059] 'compare' (duration: 23.532414ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:09:01.913655Z","caller":"traceutil/trace.go:171","msg":"trace[59960180] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"107.374983ms","start":"2026-04-07T00:09:01.806244Z","end":"2026-04-07T00:09:01.913619Z","steps":["trace[59960180] 'process raft request' (duration: 66.427966ms)","trace[59960180] 'compare' (duration: 40.819324ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:10:28.135824Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2865} {"level":"info","ts":"2026-04-07T00:10:28.215703Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2865,"took":"78.429423ms","hash":2635671441,"current-db-size-bytes":54341632,"current-db-size":"54 MB","current-db-size-in-use-bytes":29401088,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-07T00:10:28.215767Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2635671441,"revision":2865,"compact-revision":-1} {"level":"info","ts":"2026-04-07T00:11:22.158915Z","caller":"traceutil/trace.go:171","msg":"trace[1776321684] transaction","detail":"{read_only:false; response_revision:5860; number_of_response:1; }","duration":"115.760687ms","start":"2026-04-07T00:11:22.043119Z","end":"2026-04-07T00:11:22.15888Z","steps":["trace[1776321684] 'process raft request' (duration: 115.563214ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:15:28.147015Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5587} {"level":"info","ts":"2026-04-07T00:15:28.224957Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5587,"took":"76.78408ms","hash":747851585,"current-db-size-bytes":54341632,"current-db-size":"54 MB","current-db-size-in-use-bytes":18325504,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-07T00:15:28.225014Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":747851585,"revision":5587,"compact-revision":2865}