{"level":"warn","ts":"2026-04-08T10:47:34.76341Z","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-08T10:47:34.763501Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.202:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.202:2380","--initial-cluster=instance=https://199.19.213.202:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.202:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.202: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-08T10:47:34.763569Z","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-08T10:47:34.763585Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.202:2380"]} {"level":"info","ts":"2026-04-08T10:47:34.763613Z","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-08T10:47:34.764245Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"]} {"level":"info","ts":"2026-04-08T10:47:34.764326Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.202:2380"],"listen-peer-urls":["https://199.19.213.202:2380"],"advertise-client-urls":["https://199.19.213.202:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.202: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-08T10:47:34.767858Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.32323ms"} {"level":"info","ts":"2026-04-08T10:47:34.774928Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c9b4049ccf4190cf","cluster-id":"2bc66bd50b26302c"} {"level":"info","ts":"2026-04-08T10:47:34.775069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T10:47:34.775121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became follower at term 0"} {"level":"info","ts":"2026-04-08T10:47:34.775156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c9b4049ccf4190cf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T10:47:34.775186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became follower at term 1"} {"level":"info","ts":"2026-04-08T10:47:34.775265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=(14534246968970023119)"} {"level":"warn","ts":"2026-04-08T10:47:34.782285Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T10:47:34.783605Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T10:47:34.784818Z","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-08T10:47:34.787134Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c9b4049ccf4190cf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T10:47:34.787368Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c9b4049ccf4190cf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T10:47:34.787471Z","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-08T10:47:34.78958Z","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-08T10:47:34.789681Z","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-08T10:47:34.789917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=(14534246968970023119)"} {"level":"info","ts":"2026-04-08T10:47:34.790776Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bc66bd50b26302c","local-member-id":"c9b4049ccf4190cf","added-peer-id":"c9b4049ccf4190cf","added-peer-peer-urls":["https://199.19.213.202:2380"]} {"level":"info","ts":"2026-04-08T10:47:34.793219Z","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-08T10:47:34.793449Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.202:2380"} {"level":"info","ts":"2026-04-08T10:47:34.793503Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.202:2380"} {"level":"info","ts":"2026-04-08T10:47:34.793881Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c9b4049ccf4190cf","initial-advertise-peer-urls":["https://199.19.213.202:2380"],"listen-peer-urls":["https://199.19.213.202:2380"],"advertise-client-urls":["https://199.19.213.202:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T10:47:34.793974Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T10:47:35.776178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T10:47:35.776251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T10:47:35.776269Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf received MsgPreVoteResp from c9b4049ccf4190cf at term 1"} {"level":"info","ts":"2026-04-08T10:47:35.776283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became candidate at term 2"} {"level":"info","ts":"2026-04-08T10:47:35.776291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf received MsgVoteResp from c9b4049ccf4190cf at term 2"} {"level":"info","ts":"2026-04-08T10:47:35.776302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became leader at term 2"} {"level":"info","ts":"2026-04-08T10:47:35.77631Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9b4049ccf4190cf elected leader c9b4049ccf4190cf at term 2"} {"level":"info","ts":"2026-04-08T10:47:35.777295Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:35.778413Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c9b4049ccf4190cf","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.202:2379]}","request-path":"/0/members/c9b4049ccf4190cf/attributes","cluster-id":"2bc66bd50b26302c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T10:47:35.778424Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T10:47:35.778547Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T10:47:35.778717Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T10:47:35.778789Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T10:47:35.779377Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bc66bd50b26302c","local-member-id":"c9b4049ccf4190cf","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:35.77952Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:35.779562Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:35.78159Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.202:2379"} {"level":"info","ts":"2026-04-08T10:47:35.782006Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T10:47:56.370988Z","caller":"traceutil/trace.go:171","msg":"trace[1972747831] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"218.982514ms","start":"2026-04-08T10:47:56.15198Z","end":"2026-04-08T10:47:56.370963Z","steps":["trace[1972747831] 'process raft request' (duration: 218.858871ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:01.606815Z","caller":"traceutil/trace.go:171","msg":"trace[5932763] linearizableReadLoop","detail":"{readStateIndex:490; appliedIndex:489; }","duration":"130.360913ms","start":"2026-04-08T10:48:01.476427Z","end":"2026-04-08T10:48:01.606788Z","steps":["trace[5932763] 'read index received' (duration: 130.168557ms)","trace[5932763] 'applied index is now lower than readState.Index' (duration: 191.476µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:48:01.606927Z","caller":"traceutil/trace.go:171","msg":"trace[422301613] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"179.897299ms","start":"2026-04-08T10:48:01.426996Z","end":"2026-04-08T10:48:01.606893Z","steps":["trace[422301613] 'process raft request' (duration: 179.650912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:48:01.606998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.554508ms","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-08T10:48:01.607091Z","caller":"traceutil/trace.go:171","msg":"trace[864984289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:470; }","duration":"130.701801ms","start":"2026-04-08T10:48:01.476367Z","end":"2026-04-08T10:48:01.607069Z","steps":["trace[864984289] 'agreement among raft nodes before linearized reading' (duration: 130.528597ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:05.12458Z","caller":"traceutil/trace.go:171","msg":"trace[2052734946] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"105.540282ms","start":"2026-04-08T10:48:05.018986Z","end":"2026-04-08T10:48:05.124526Z","steps":["trace[2052734946] 'process raft request' (duration: 102.838047ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:05.125012Z","caller":"traceutil/trace.go:171","msg":"trace[417394293] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"101.061928ms","start":"2026-04-08T10:48:05.023914Z","end":"2026-04-08T10:48:05.124976Z","steps":["trace[417394293] 'process raft request' (duration: 100.876213ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:05.124941Z","caller":"traceutil/trace.go:171","msg":"trace[891581048] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"103.796484ms","start":"2026-04-08T10:48:05.021083Z","end":"2026-04-08T10:48:05.124879Z","steps":["trace[891581048] 'process raft request' (duration: 103.548087ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:11.359235Z","caller":"traceutil/trace.go:171","msg":"trace[1751525180] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"163.632445ms","start":"2026-04-08T10:48:11.195572Z","end":"2026-04-08T10:48:11.359204Z","steps":["trace[1751525180] 'process raft request' (duration: 163.43509ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:11.390956Z","caller":"traceutil/trace.go:171","msg":"trace[2097638706] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"141.5088ms","start":"2026-04-08T10:48:11.249416Z","end":"2026-04-08T10:48:11.390925Z","steps":["trace[2097638706] 'process raft request' (duration: 141.096099ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:11.940988Z","caller":"traceutil/trace.go:171","msg":"trace[1568239911] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"284.010151ms","start":"2026-04-08T10:48:11.656953Z","end":"2026-04-08T10:48:11.940963Z","steps":["trace[1568239911] 'process raft request' (duration: 283.856447ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:12.113312Z","caller":"traceutil/trace.go:171","msg":"trace[58124072] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"452.052781ms","start":"2026-04-08T10:48:11.661234Z","end":"2026-04-08T10:48:12.113287Z","steps":["trace[58124072] 'process raft request' (duration: 451.495655ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:12.113462Z","caller":"traceutil/trace.go:171","msg":"trace[665145304] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"387.646711ms","start":"2026-04-08T10:48:11.725781Z","end":"2026-04-08T10:48:12.113427Z","steps":["trace[665145304] 'read index received' (duration: 215.112017ms)","trace[665145304] 'applied index is now lower than readState.Index' (duration: 172.531503ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:48:12.11356Z","caller":"traceutil/trace.go:171","msg":"trace[902681852] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"308.355298ms","start":"2026-04-08T10:48:11.805183Z","end":"2026-04-08T10:48:12.113538Z","steps":["trace[902681852] 'process raft request' (duration: 307.904465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:48:12.113754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.947569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-08T10:48:12.113809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:48:11.805153Z","time spent":"308.456371ms","remote":"127.0.0.1:37962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:48:12.113833Z","caller":"traceutil/trace.go:171","msg":"trace[1974751177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"388.073512ms","start":"2026-04-08T10:48:11.725742Z","end":"2026-04-08T10:48:12.113816Z","steps":["trace[1974751177] 'agreement among raft nodes before linearized reading' (duration: 387.826576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:48:12.113887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:48:11.725723Z","time spent":"388.151375ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-08T10:48:12.114008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.226726ms","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-08T10:48:12.114134Z","caller":"traceutil/trace.go:171","msg":"trace[1419752722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"271.37085ms","start":"2026-04-08T10:48:11.842709Z","end":"2026-04-08T10:48:12.11408Z","steps":["trace[1419752722] 'agreement among raft nodes before linearized reading' (duration: 270.963068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:48:12.113723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:48:11.661212Z","time spent":"452.166253ms","remote":"127.0.0.1:38050","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-08T10:48:28.922672Z","caller":"traceutil/trace.go:171","msg":"trace[736510078] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"103.152306ms","start":"2026-04-08T10:48:28.819496Z","end":"2026-04-08T10:48:28.922648Z","steps":["trace[736510078] 'process raft request' (duration: 102.981032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:49:42.893611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.187873ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:49:42.893791Z","caller":"traceutil/trace.go:171","msg":"trace[1313436843] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"304.750506ms","start":"2026-04-08T10:49:42.588997Z","end":"2026-04-08T10:49:42.893748Z","steps":["trace[1313436843] 'process raft request' (duration: 20.043758ms)","trace[1313436843] 'compare' (duration: 284.090091ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:49:42.893727Z","caller":"traceutil/trace.go:171","msg":"trace[1323707610] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1910; }","duration":"221.970673ms","start":"2026-04-08T10:49:42.671741Z","end":"2026-04-08T10:49:42.893711Z","steps":["trace[1323707610] 'read index received' (duration: 45.391µs)","trace[1323707610] 'applied index is now lower than readState.Index' (duration: 221.923622ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:49:42.893937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:49:42.58898Z","time spent":"304.880249ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:49:42.89398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.917156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:49:42.894031Z","caller":"traceutil/trace.go:171","msg":"trace[221401232] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1842; }","duration":"178.986928ms","start":"2026-04-08T10:49:42.71502Z","end":"2026-04-08T10:49:42.894007Z","steps":["trace[221401232] 'agreement among raft nodes before linearized reading' (duration: 178.922137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:49:42.894027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.273072ms","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-08T10:49:42.894119Z","caller":"traceutil/trace.go:171","msg":"trace[730278738] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1842; }","duration":"222.402376ms","start":"2026-04-08T10:49:42.671691Z","end":"2026-04-08T10:49:42.894093Z","steps":["trace[730278738] 'agreement among raft nodes before linearized reading' (duration: 222.135108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:49:43.333555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.684372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:49:43.333648Z","caller":"traceutil/trace.go:171","msg":"trace[597736013] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"214.165707ms","start":"2026-04-08T10:49:43.119465Z","end":"2026-04-08T10:49:43.333631Z","steps":["trace[597736013] 'process raft request' (duration: 59.32733ms)","trace[597736013] 'compare' (duration: 154.58803ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:49:43.363755Z","caller":"traceutil/trace.go:171","msg":"trace[1939110583] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"241.925049ms","start":"2026-04-08T10:49:43.121804Z","end":"2026-04-08T10:49:43.363729Z","steps":["trace[1939110583] 'process raft request' (duration: 241.764144ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:49:55.310453Z","caller":"traceutil/trace.go:171","msg":"trace[301556457] transaction","detail":"{read_only:false; response_revision:1948; number_of_response:1; }","duration":"151.910305ms","start":"2026-04-08T10:49:55.158515Z","end":"2026-04-08T10:49:55.310425Z","steps":["trace[301556457] 'process raft request' (duration: 151.7315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:50:27.827146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.130717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-08T10:50:27.82722Z","caller":"traceutil/trace.go:171","msg":"trace[1059586478] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2136; }","duration":"229.24354ms","start":"2026-04-08T10:50:27.59796Z","end":"2026-04-08T10:50:27.827203Z","steps":["trace[1059586478] 'range keys from in-memory index tree' (duration: 228.959322ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:51:23.596967Z","caller":"traceutil/trace.go:171","msg":"trace[414700658] linearizableReadLoop","detail":"{readStateIndex:2709; appliedIndex:2708; }","duration":"164.490389ms","start":"2026-04-08T10:51:23.432444Z","end":"2026-04-08T10:51:23.596934Z","steps":["trace[414700658] 'read index received' (duration: 164.310324ms)","trace[414700658] 'applied index is now lower than readState.Index' (duration: 178.575µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:51:23.597037Z","caller":"traceutil/trace.go:171","msg":"trace[1066908315] transaction","detail":"{read_only:false; response_revision:2611; number_of_response:1; }","duration":"183.806027ms","start":"2026-04-08T10:51:23.413192Z","end":"2026-04-08T10:51:23.596998Z","steps":["trace[1066908315] 'process raft request' (duration: 183.542549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:51:23.597238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.524525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-08T10:51:23.597236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.771366ms","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-08T10:51:23.597286Z","caller":"traceutil/trace.go:171","msg":"trace[857290417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2611; }","duration":"158.616128ms","start":"2026-04-08T10:51:23.438657Z","end":"2026-04-08T10:51:23.597273Z","steps":["trace[857290417] 'agreement among raft nodes before linearized reading' (duration: 158.437613ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:51:23.597314Z","caller":"traceutil/trace.go:171","msg":"trace[1258467657] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2611; }","duration":"164.90576ms","start":"2026-04-08T10:51:23.432393Z","end":"2026-04-08T10:51:23.597298Z","steps":["trace[1258467657] 'agreement among raft nodes before linearized reading' (duration: 164.655723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:51:56.510614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.028018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-08T10:51:56.510818Z","caller":"traceutil/trace.go:171","msg":"trace[1702628940] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2810; }","duration":"220.299865ms","start":"2026-04-08T10:51:56.290496Z","end":"2026-04-08T10:51:56.510796Z","steps":["trace[1702628940] 'range keys from in-memory index tree' (duration: 219.907284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:51:56.511179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.398827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-08T10:51:56.511297Z","caller":"traceutil/trace.go:171","msg":"trace[604247818] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2810; }","duration":"160.589842ms","start":"2026-04-08T10:51:56.35068Z","end":"2026-04-08T10:51:56.511269Z","steps":["trace[604247818] 'range keys from in-memory index tree' (duration: 159.504713ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:51:56.575311Z","caller":"traceutil/trace.go:171","msg":"trace[1111796828] transaction","detail":"{read_only:false; response_revision:2811; number_of_response:1; }","duration":"178.779949ms","start":"2026-04-08T10:51:56.396504Z","end":"2026-04-08T10:51:56.575284Z","steps":["trace[1111796828] 'process raft request' (duration: 178.556103ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:52:01.912178Z","caller":"traceutil/trace.go:171","msg":"trace[764479828] linearizableReadLoop","detail":"{readStateIndex:2946; appliedIndex:2945; }","duration":"125.162341ms","start":"2026-04-08T10:52:01.786991Z","end":"2026-04-08T10:52:01.912153Z","steps":["trace[764479828] 'read index received' (duration: 124.877923ms)","trace[764479828] 'applied index is now lower than readState.Index' (duration: 283.418µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:52:01.912258Z","caller":"traceutil/trace.go:171","msg":"trace[830034809] transaction","detail":"{read_only:false; response_revision:2839; number_of_response:1; }","duration":"138.608144ms","start":"2026-04-08T10:52:01.773606Z","end":"2026-04-08T10:52:01.912214Z","steps":["trace[830034809] 'process raft request' (duration: 138.389038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:52:01.912507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.43065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-08T10:52:01.912563Z","caller":"traceutil/trace.go:171","msg":"trace[1713406353] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2839; }","duration":"120.511103ms","start":"2026-04-08T10:52:01.792037Z","end":"2026-04-08T10:52:01.912548Z","steps":["trace[1713406353] 'agreement among raft nodes before linearized reading' (duration: 120.303417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:52:01.912575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.562693ms","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-08T10:52:01.912641Z","caller":"traceutil/trace.go:171","msg":"trace[876274055] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2839; }","duration":"125.681786ms","start":"2026-04-08T10:52:01.786943Z","end":"2026-04-08T10:52:01.912625Z","steps":["trace[876274055] 'agreement among raft nodes before linearized reading' (duration: 125.353737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:52:01.91274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.637416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T10:52:01.912867Z","caller":"traceutil/trace.go:171","msg":"trace[622706386] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2839; }","duration":"120.766929ms","start":"2026-04-08T10:52:01.792054Z","end":"2026-04-08T10:52:01.912821Z","steps":["trace[622706386] 'agreement among raft nodes before linearized reading' (duration: 120.351928ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:55:50.993376Z","caller":"traceutil/trace.go:171","msg":"trace[1814835409] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"106.964818ms","start":"2026-04-08T10:55:50.88639Z","end":"2026-04-08T10:55:50.993355Z","steps":["trace[1814835409] 'process raft request' (duration: 106.848615ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:00.804603Z","caller":"traceutil/trace.go:171","msg":"trace[833538115] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"202.844874ms","start":"2026-04-08T10:56:00.60173Z","end":"2026-04-08T10:56:00.804575Z","steps":["trace[833538115] 'process raft request' (duration: 202.687509ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:00.805142Z","caller":"traceutil/trace.go:171","msg":"trace[1923931228] linearizableReadLoop","detail":"{readStateIndex:5245; appliedIndex:5245; }","duration":"138.379739ms","start":"2026-04-08T10:56:00.666747Z","end":"2026-04-08T10:56:00.805127Z","steps":["trace[1923931228] 'read index received' (duration: 138.372588ms)","trace[1923931228] 'applied index is now lower than readState.Index' (duration: 5.401µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:56:00.805314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.562853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-18eaf27f-2cc2-490f-8930-d156686fc1a3\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-08T10:56:00.805354Z","caller":"traceutil/trace.go:171","msg":"trace[25932617] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-18eaf27f-2cc2-490f-8930-d156686fc1a3; range_end:; response_count:1; response_revision:5053; }","duration":"138.660747ms","start":"2026-04-08T10:56:00.666683Z","end":"2026-04-08T10:56:00.805344Z","steps":["trace[25932617] 'agreement among raft nodes before linearized reading' (duration: 138.497912ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:01.086629Z","caller":"traceutil/trace.go:171","msg":"trace[718217707] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"134.392799ms","start":"2026-04-08T10:56:00.952205Z","end":"2026-04-08T10:56:01.086598Z","steps":["trace[718217707] 'process raft request' (duration: 134.239755ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:10.707017Z","caller":"traceutil/trace.go:171","msg":"trace[2029682853] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"140.581399ms","start":"2026-04-08T10:56:10.566416Z","end":"2026-04-08T10:56:10.706998Z","steps":["trace[2029682853] 'process raft request' (duration: 140.532318ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:10.707041Z","caller":"traceutil/trace.go:171","msg":"trace[598987656] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"140.62377ms","start":"2026-04-08T10:56:10.566377Z","end":"2026-04-08T10:56:10.707001Z","steps":["trace[598987656] 'process raft request' (duration: 43.955204ms)","trace[598987656] 'compare' (duration: 96.496722ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:56:21.507244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.307604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:56:21.507386Z","caller":"traceutil/trace.go:171","msg":"trace[806174132] linearizableReadLoop","detail":"{readStateIndex:5650; appliedIndex:5649; }","duration":"160.675709ms","start":"2026-04-08T10:56:21.346687Z","end":"2026-04-08T10:56:21.507362Z","steps":["trace[806174132] 'read index received' (duration: 40.073087ms)","trace[806174132] 'applied index is now lower than readState.Index' (duration: 120.600522ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:56:21.507503Z","caller":"traceutil/trace.go:171","msg":"trace[706132741] transaction","detail":"{read_only:false; response_revision:5447; number_of_response:1; }","duration":"201.295821ms","start":"2026-04-08T10:56:21.30619Z","end":"2026-04-08T10:56:21.507486Z","steps":["trace[706132741] 'process raft request' (duration: 80.648918ms)","trace[706132741] 'compare' (duration: 120.032576ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:56:21.507693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.361016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T10:56:21.507763Z","caller":"traceutil/trace.go:171","msg":"trace[1540610053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5447; }","duration":"158.558921ms","start":"2026-04-08T10:56:21.349189Z","end":"2026-04-08T10:56:21.507748Z","steps":["trace[1540610053] 'agreement among raft nodes before linearized reading' (duration: 158.372396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:21.507761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.07022ms","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-08T10:56:21.507826Z","caller":"traceutil/trace.go:171","msg":"trace[301436010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5447; }","duration":"161.175523ms","start":"2026-04-08T10:56:21.346635Z","end":"2026-04-08T10:56:21.507811Z","steps":["trace[301436010] 'agreement among raft nodes before linearized reading' (duration: 160.981628ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:21.711144Z","caller":"traceutil/trace.go:171","msg":"trace[497548904] transaction","detail":"{read_only:false; response_revision:5451; number_of_response:1; }","duration":"118.920096ms","start":"2026-04-08T10:56:21.5922Z","end":"2026-04-08T10:56:21.71112Z","steps":["trace[497548904] 'process raft request' (duration: 118.480974ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:21.711169Z","caller":"traceutil/trace.go:171","msg":"trace[230646423] transaction","detail":"{read_only:false; response_revision:5450; number_of_response:1; }","duration":"141.072442ms","start":"2026-04-08T10:56:21.570057Z","end":"2026-04-08T10:56:21.711129Z","steps":["trace[230646423] 'process raft request' (duration: 140.443915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:22.13526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.513373ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:56:22.135737Z","caller":"traceutil/trace.go:171","msg":"trace[689939728] transaction","detail":"{read_only:false; response_revision:5453; number_of_response:1; }","duration":"417.51534ms","start":"2026-04-08T10:56:21.718136Z","end":"2026-04-08T10:56:22.135651Z","steps":["trace[689939728] 'process raft request' (duration: 225.514843ms)","trace[689939728] 'compare' (duration: 191.289257ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:56:22.135855Z","caller":"traceutil/trace.go:171","msg":"trace[112121282] transaction","detail":"{read_only:false; response_revision:5454; number_of_response:1; }","duration":"417.429368ms","start":"2026-04-08T10:56:21.718389Z","end":"2026-04-08T10:56:22.135818Z","steps":["trace[112121282] 'process raft request' (duration: 417.155081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:22.135981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:56:21.718377Z","time spent":"417.544971ms","remote":"127.0.0.1:38164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1621,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T10:56:22.136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:56:21.718117Z","time spent":"417.738426ms","remote":"127.0.0.1:38164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1413,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:56:22.136286Z","caller":"traceutil/trace.go:171","msg":"trace[820033447] linearizableReadLoop","detail":"{readStateIndex:5657; appliedIndex:5655; }","duration":"393.40843ms","start":"2026-04-08T10:56:21.742845Z","end":"2026-04-08T10:56:22.136254Z","steps":["trace[820033447] 'read index received' (duration: 200.819118ms)","trace[820033447] 'applied index is now lower than readState.Index' (duration: 192.586662ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:56:22.136593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.802991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T10:56:22.136646Z","caller":"traceutil/trace.go:171","msg":"trace[1667919253] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5455; }","duration":"168.887383ms","start":"2026-04-08T10:56:21.967745Z","end":"2026-04-08T10:56:22.136632Z","steps":["trace[1667919253] 'agreement among raft nodes before linearized reading' (duration: 168.74565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:22.136708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.828761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus.18a45c66304fe350\" ","response":"range_response_count:1 size:745"} {"level":"warn","ts":"2026-04-08T10:56:22.136717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.62671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-08T10:56:22.136804Z","caller":"traceutil/trace.go:171","msg":"trace[2069982922] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus.18a45c66304fe350; range_end:; response_count:1; response_revision:5455; }","duration":"393.975445ms","start":"2026-04-08T10:56:21.742804Z","end":"2026-04-08T10:56:22.136779Z","steps":["trace[2069982922] 'agreement among raft nodes before linearized reading' (duration: 393.663327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:22.136844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:56:21.742787Z","time spent":"394.049088ms","remote":"127.0.0.1:37948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":1,"response size":768,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus.18a45c66304fe350\" "} {"level":"info","ts":"2026-04-08T10:56:22.136872Z","caller":"traceutil/trace.go:171","msg":"trace[1681487604] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5455; }","duration":"140.789255ms","start":"2026-04-08T10:56:21.99601Z","end":"2026-04-08T10:56:22.136799Z","steps":["trace[1681487604] 'agreement among raft nodes before linearized reading' (duration: 140.493817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:22.136946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.277697ms","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-08T10:56:22.136978Z","caller":"traceutil/trace.go:171","msg":"trace[694245615] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5455; }","duration":"153.308788ms","start":"2026-04-08T10:56:21.98366Z","end":"2026-04-08T10:56:22.136969Z","steps":["trace[694245615] 'agreement among raft nodes before linearized reading' (duration: 153.153933ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:32.427204Z","caller":"traceutil/trace.go:171","msg":"trace[986757817] transaction","detail":"{read_only:false; response_revision:5606; number_of_response:1; }","duration":"106.441943ms","start":"2026-04-08T10:56:32.320723Z","end":"2026-04-08T10:56:32.427165Z","steps":["trace[986757817] 'process raft request' (duration: 57.996977ms)","trace[986757817] 'compare' (duration: 48.269381ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:56:32.429636Z","caller":"traceutil/trace.go:171","msg":"trace[1467372699] transaction","detail":"{read_only:false; response_revision:5607; number_of_response:1; }","duration":"108.540941ms","start":"2026-04-08T10:56:32.321076Z","end":"2026-04-08T10:56:32.429617Z","steps":["trace[1467372699] 'process raft request' (duration: 108.388987ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:32.430027Z","caller":"traceutil/trace.go:171","msg":"trace[127525812] transaction","detail":"{read_only:false; response_revision:5609; number_of_response:1; }","duration":"107.630046ms","start":"2026-04-08T10:56:32.322373Z","end":"2026-04-08T10:56:32.430003Z","steps":["trace[127525812] 'process raft request' (duration: 107.44221ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:32.430034Z","caller":"traceutil/trace.go:171","msg":"trace[1884682535] transaction","detail":"{read_only:false; response_revision:5608; number_of_response:1; }","duration":"108.820948ms","start":"2026-04-08T10:56:32.321195Z","end":"2026-04-08T10:56:32.430016Z","steps":["trace[1884682535] 'process raft request' (duration: 108.374526ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:56:43.720668Z","caller":"traceutil/trace.go:171","msg":"trace[86625084] transaction","detail":"{read_only:false; response_revision:5678; number_of_response:1; }","duration":"320.823703ms","start":"2026-04-08T10:56:43.399813Z","end":"2026-04-08T10:56:43.720637Z","steps":["trace[86625084] 'process raft request' (duration: 320.609427ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:56:43.720825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:56:43.399773Z","time spent":"320.973967ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:57:12.895772Z","caller":"traceutil/trace.go:171","msg":"trace[315561401] transaction","detail":"{read_only:false; response_revision:5945; number_of_response:1; }","duration":"116.764337ms","start":"2026-04-08T10:57:12.778971Z","end":"2026-04-08T10:57:12.895735Z","steps":["trace[315561401] 'process raft request' (duration: 116.532741ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:57:13.083624Z","caller":"traceutil/trace.go:171","msg":"trace[224770342] linearizableReadLoop","detail":"{readStateIndex:6163; appliedIndex:6162; }","duration":"101.818517ms","start":"2026-04-08T10:57:12.981774Z","end":"2026-04-08T10:57:13.083593Z","steps":["trace[224770342] 'read index received' (duration: 39.067799ms)","trace[224770342] 'applied index is now lower than readState.Index' (duration: 62.747288ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:57:13.083755Z","caller":"traceutil/trace.go:171","msg":"trace[756602619] transaction","detail":"{read_only:false; response_revision:5947; number_of_response:1; }","duration":"124.309493ms","start":"2026-04-08T10:57:12.95943Z","end":"2026-04-08T10:57:13.08374Z","steps":["trace[756602619] 'process raft request' (duration: 61.413221ms)","trace[756602619] 'compare' (duration: 62.622474ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:57:13.084083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.28372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T10:57:13.08419Z","caller":"traceutil/trace.go:171","msg":"trace[529083907] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:5947; }","duration":"102.441065ms","start":"2026-04-08T10:57:12.981725Z","end":"2026-04-08T10:57:13.084166Z","steps":["trace[529083907] 'agreement among raft nodes before linearized reading' (duration: 102.165947ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:57:35.8096Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3025} {"level":"info","ts":"2026-04-08T10:57:35.898041Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3025,"took":"86.810757ms","hash":4281783520,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":31424512,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-08T10:57:35.89811Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4281783520,"revision":3025,"compact-revision":-1} {"level":"info","ts":"2026-04-08T11:02:26.014436Z","caller":"traceutil/trace.go:171","msg":"trace[1045350485] transaction","detail":"{read_only:false; response_revision:8266; number_of_response:1; }","duration":"269.486565ms","start":"2026-04-08T11:02:25.744919Z","end":"2026-04-08T11:02:26.014405Z","steps":["trace[1045350485] 'process raft request' (duration: 269.268499ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:02:26.131932Z","caller":"traceutil/trace.go:171","msg":"trace[1913155906] transaction","detail":"{read_only:false; response_revision:8267; number_of_response:1; }","duration":"386.683649ms","start":"2026-04-08T11:02:25.745221Z","end":"2026-04-08T11:02:26.131905Z","steps":["trace[1913155906] 'process raft request' (duration: 385.514997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:02:26.132059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:02:25.745212Z","time spent":"386.777571ms","remote":"127.0.0.1:38144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T11:02:35.815898Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6123} {"level":"info","ts":"2026-04-08T11:02:35.908218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6123,"took":"90.764944ms","hash":3336966639,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":23625728,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-08T11:02:35.908298Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3336966639,"revision":6123,"compact-revision":3025} {"level":"info","ts":"2026-04-08T11:02:37.742654Z","caller":"traceutil/trace.go:171","msg":"trace[1855181906] transaction","detail":"{read_only:false; response_revision:8328; number_of_response:1; }","duration":"207.148276ms","start":"2026-04-08T11:02:37.535457Z","end":"2026-04-08T11:02:37.742605Z","steps":["trace[1855181906] 'process raft request' (duration: 206.972031ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:02:38.64455Z","caller":"traceutil/trace.go:171","msg":"trace[155437028] transaction","detail":"{read_only:false; response_revision:8333; number_of_response:1; }","duration":"209.346255ms","start":"2026-04-08T11:02:38.435175Z","end":"2026-04-08T11:02:38.644521Z","steps":["trace[155437028] 'process raft request' (duration: 209.15868ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:02:38.670189Z","caller":"traceutil/trace.go:171","msg":"trace[898580526] transaction","detail":"{read_only:false; response_revision:8334; number_of_response:1; }","duration":"160.739391ms","start":"2026-04-08T11:02:38.509426Z","end":"2026-04-08T11:02:38.670166Z","steps":["trace[898580526] 'process raft request' (duration: 160.594827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:03:08.383628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.394703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T11:03:08.383894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.121814ms","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-04-08T11:03:08.384256Z","caller":"traceutil/trace.go:171","msg":"trace[1788179087] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8546; }","duration":"311.787322ms","start":"2026-04-08T11:03:08.072165Z","end":"2026-04-08T11:03:08.383952Z","steps":["trace[1788179087] 'range keys from in-memory index tree' (duration: 311.315841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:03:08.38457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:03:08.072146Z","time spent":"312.359766ms","remote":"127.0.0.1:37844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-08T11:03:08.384343Z","caller":"traceutil/trace.go:171","msg":"trace[723409735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8546; }","duration":"141.73574ms","start":"2026-04-08T11:03:08.242586Z","end":"2026-04-08T11:03:08.384321Z","steps":["trace[723409735] 'range keys from in-memory index tree' (duration: 140.907269ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:20.478307Z","caller":"traceutil/trace.go:171","msg":"trace[98922460] linearizableReadLoop","detail":"{readStateIndex:8957; appliedIndex:8956; }","duration":"140.624082ms","start":"2026-04-08T11:03:20.337654Z","end":"2026-04-08T11:03:20.478278Z","steps":["trace[98922460] 'read index received' (duration: 140.378386ms)","trace[98922460] 'applied index is now lower than readState.Index' (duration: 244.756µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:03:20.478446Z","caller":"traceutil/trace.go:171","msg":"trace[799225173] transaction","detail":"{read_only:false; response_revision:8648; number_of_response:1; }","duration":"204.978854ms","start":"2026-04-08T11:03:20.273418Z","end":"2026-04-08T11:03:20.478396Z","steps":["trace[799225173] 'process raft request' (duration: 204.694678ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:03:20.47867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.003891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-08T11:03:20.478719Z","caller":"traceutil/trace.go:171","msg":"trace[1485820320] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8648; }","duration":"141.102124ms","start":"2026-04-08T11:03:20.337602Z","end":"2026-04-08T11:03:20.478704Z","steps":["trace[1485820320] 'agreement among raft nodes before linearized reading' (duration: 140.778096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:03:21.009038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.968941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T11:03:21.009289Z","caller":"traceutil/trace.go:171","msg":"trace[1660405245] transaction","detail":"{read_only:false; response_revision:8658; number_of_response:1; }","duration":"122.099096ms","start":"2026-04-08T11:03:20.887169Z","end":"2026-04-08T11:03:21.009268Z","steps":["trace[1660405245] 'process raft request' (duration: 19.787668ms)","trace[1660405245] 'compare' (duration: 101.181591ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:04:02.166598Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002495.wal"} {"level":"info","ts":"2026-04-08T11:05:09.749654Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c9b4049ccf4190cf","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T11:05:09.755559Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T11:05:09.75563Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T11:07:35.822844Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8317} {"level":"info","ts":"2026-04-08T11:07:35.9003Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8317,"took":"75.267407ms","hash":3193576329,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":25403392,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-08T11:07:35.900376Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3193576329,"revision":8317,"compact-revision":6123} {"level":"info","ts":"2026-04-08T11:12:35.828679Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10717} {"level":"info","ts":"2026-04-08T11:12:35.908864Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10717,"took":"78.274641ms","hash":1516530118,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":20455424,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-08T11:12:35.908936Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1516530118,"revision":10717,"compact-revision":8317}