{"level":"warn","ts":"2026-06-09T01:01:47.377293Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T01:01:47.377379Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-06-09T01:01:47.377443Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T01:01:47.377463Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-06-09T01:01:47.37748Z","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-06-09T01:01:47.378278Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-06-09T01:01:47.378381Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-06-09T01:01:47.382251Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.593536ms"} {"level":"info","ts":"2026-06-09T01:01:47.387956Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-06-09T01:01:47.388027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T01:01:47.38805Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-06-09T01:01:47.388065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T01:01:47.388074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-06-09T01:01:47.388121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-06-09T01:01:47.395085Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T01:01:47.396946Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T01:01:47.399981Z","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-06-09T01:01:47.405587Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T01:01:47.40624Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T01:01:47.406337Z","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-06-09T01:01:47.406381Z","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-06-09T01:01:47.406395Z","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-06-09T01:01:47.407517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-06-09T01:01:47.407782Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-06-09T01:01:47.413385Z","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-06-09T01:01:47.413669Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T01:01:47.413733Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T01:01:47.41353Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-06-09T01:01:47.414465Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-06-09T01:01:48.389187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T01:01:48.389282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T01:01:48.389321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-06-09T01:01:48.389347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-06-09T01:01:48.389371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-06-09T01:01:48.389393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-06-09T01:01:48.38941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-06-09T01:01:48.39068Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T01:01:48.390842Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T01:01:48.390755Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:01:48.391149Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T01:01:48.3941Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T01:01:48.394305Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:01:48.394527Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:01:48.394567Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T01:01:48.394962Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-06-09T01:01:48.399022Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T01:01:48.399108Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T01:02:31.655799Z","caller":"traceutil/trace.go:171","msg":"trace[1772884569] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"103.296107ms","start":"2026-06-09T01:02:31.552476Z","end":"2026-06-09T01:02:31.655772Z","steps":["trace[1772884569] 'process raft request' (duration: 102.794465ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:02:31.837481Z","caller":"traceutil/trace.go:171","msg":"trace[1441935554] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"130.209682ms","start":"2026-06-09T01:02:31.707248Z","end":"2026-06-09T01:02:31.837458Z","steps":["trace[1441935554] 'process raft request' (duration: 130.110619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:02:32.131629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.44448ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:02:32.132066Z","caller":"traceutil/trace.go:171","msg":"trace[1343253481] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"244.185718ms","start":"2026-06-09T01:02:31.887858Z","end":"2026-06-09T01:02:32.132044Z","steps":["trace[1343253481] 'process raft request' (duration: 16.530308ms)","trace[1343253481] 'compare' (duration: 226.183482ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:02:32.584438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.265889ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:02:32.584576Z","caller":"traceutil/trace.go:171","msg":"trace[76404535] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:594; }","duration":"288.428093ms","start":"2026-06-09T01:02:32.296128Z","end":"2026-06-09T01:02:32.584556Z","steps":["trace[76404535] 'range keys from in-memory index tree' (duration: 288.245119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:02:32.585217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.180352ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:02:32.585353Z","caller":"traceutil/trace.go:171","msg":"trace[477887735] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"448.760297ms","start":"2026-06-09T01:02:32.136573Z","end":"2026-06-09T01:02:32.585333Z","steps":["trace[477887735] 'process raft request' (duration: 236.352229ms)","trace[477887735] 'compare' (duration: 212.024318ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:02:32.585482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:02:32.136553Z","time spent":"448.89614ms","remote":"127.0.0.1:40110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:02:32.591502Z","caller":"traceutil/trace.go:171","msg":"trace[1869940144] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"347.849474ms","start":"2026-06-09T01:02:32.243609Z","end":"2026-06-09T01:02:32.591459Z","steps":["trace[1869940144] 'process raft request' (duration: 347.274979ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:02:32.592144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:02:32.243581Z","time spent":"348.007298ms","remote":"127.0.0.1:39938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:02:32.59216Z","caller":"traceutil/trace.go:171","msg":"trace[1140036649] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"341.353208ms","start":"2026-06-09T01:02:32.250008Z","end":"2026-06-09T01:02:32.591361Z","steps":["trace[1140036649] 'read index received' (duration: 123.011619ms)","trace[1140036649] 'applied index is now lower than readState.Index' (duration: 218.338749ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:02:32.592561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.677971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:02:32.592659Z","caller":"traceutil/trace.go:171","msg":"trace[1652127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"190.802214ms","start":"2026-06-09T01:02:32.401798Z","end":"2026-06-09T01:02:32.5926Z","steps":["trace[1652127] 'agreement among raft nodes before linearized reading' (duration: 190.6367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:02:32.592669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.641872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-srjls\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-09T01:02:32.592807Z","caller":"traceutil/trace.go:171","msg":"trace[1663003974] range","detail":"{range_begin:/registry/pods/kube-system/cilium-srjls; range_end:; response_count:1; response_revision:596; }","duration":"342.793116ms","start":"2026-06-09T01:02:32.249983Z","end":"2026-06-09T01:02:32.592776Z","steps":["trace[1663003974] 'agreement among raft nodes before linearized reading' (duration: 341.656626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:02:32.592931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:02:32.24997Z","time spent":"342.890848ms","remote":"127.0.0.1:40036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-srjls\" "} {"level":"info","ts":"2026-06-09T01:04:05.761521Z","caller":"traceutil/trace.go:171","msg":"trace[743125492] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1900; }","duration":"108.34243ms","start":"2026-06-09T01:04:05.653157Z","end":"2026-06-09T01:04:05.761499Z","steps":["trace[743125492] 'read index received' (duration: 108.230658ms)","trace[743125492] 'applied index is now lower than readState.Index' (duration: 110.862µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:05.761651Z","caller":"traceutil/trace.go:171","msg":"trace[160406080] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"112.52329ms","start":"2026-06-09T01:04:05.649118Z","end":"2026-06-09T01:04:05.761641Z","steps":["trace[160406080] 'process raft request' (duration: 112.192595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:05.762059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.576118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5b514f91-4cf2-4fb0-9ca2-13628d409ec8\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-09T01:04:05.762107Z","caller":"traceutil/trace.go:171","msg":"trace[938274083] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5b514f91-4cf2-4fb0-9ca2-13628d409ec8; range_end:; response_count:1; response_revision:1831; }","duration":"105.652929ms","start":"2026-06-09T01:04:05.656444Z","end":"2026-06-09T01:04:05.762097Z","steps":["trace[938274083] 'agreement among raft nodes before linearized reading' (duration: 105.523777ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:05.762312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.157441ms","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-06-09T01:04:05.762351Z","caller":"traceutil/trace.go:171","msg":"trace[284312488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1831; }","duration":"109.225413ms","start":"2026-06-09T01:04:05.653112Z","end":"2026-06-09T01:04:05.762338Z","steps":["trace[284312488] 'agreement among raft nodes before linearized reading' (duration: 108.758786ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:05.878001Z","caller":"traceutil/trace.go:171","msg":"trace[1728346451] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"111.419315ms","start":"2026-06-09T01:04:05.766552Z","end":"2026-06-09T01:04:05.877971Z","steps":["trace[1728346451] 'process raft request' (duration: 88.002235ms)","trace[1728346451] 'compare' (duration: 23.222127ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:04:05.951583Z","caller":"traceutil/trace.go:171","msg":"trace[1209960296] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1901; }","duration":"162.801309ms","start":"2026-06-09T01:04:05.788759Z","end":"2026-06-09T01:04:05.95156Z","steps":["trace[1209960296] 'read index received' (duration: 65.804113ms)","trace[1209960296] 'applied index is now lower than readState.Index' (duration: 96.996016ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:05.951729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.94983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:04:05.951764Z","caller":"traceutil/trace.go:171","msg":"trace[2109680000] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1834; }","duration":"163.043712ms","start":"2026-06-09T01:04:05.788709Z","end":"2026-06-09T01:04:05.951753Z","steps":["trace[2109680000] 'agreement among raft nodes before linearized reading' (duration: 162.962161ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:05.951853Z","caller":"traceutil/trace.go:171","msg":"trace[1136069075] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"182.129618ms","start":"2026-06-09T01:04:05.7697Z","end":"2026-06-09T01:04:05.95183Z","steps":["trace[1136069075] 'process raft request' (duration: 181.793294ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:05.951862Z","caller":"traceutil/trace.go:171","msg":"trace[607067713] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"182.23651ms","start":"2026-06-09T01:04:05.769596Z","end":"2026-06-09T01:04:05.951833Z","steps":["trace[607067713] 'process raft request' (duration: 181.764094ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:19.122918Z","caller":"traceutil/trace.go:171","msg":"trace[10364441] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"119.658715ms","start":"2026-06-09T01:04:19.003228Z","end":"2026-06-09T01:04:19.122887Z","steps":["trace[10364441] 'process raft request' (duration: 119.463662ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:35.362721Z","caller":"traceutil/trace.go:171","msg":"trace[176921514] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"187.159865ms","start":"2026-06-09T01:04:35.175508Z","end":"2026-06-09T01:04:35.362668Z","steps":["trace[176921514] 'process raft request' (duration: 186.892972ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:36.791229Z","caller":"traceutil/trace.go:171","msg":"trace[260201947] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"205.497241ms","start":"2026-06-09T01:04:36.585717Z","end":"2026-06-09T01:04:36.791214Z","steps":["trace[260201947] 'process raft request' (duration: 205.214617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:37.104371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.056227ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-09T01:04:37.104736Z","caller":"traceutil/trace.go:171","msg":"trace[35488275] linearizableReadLoop","detail":"{readStateIndex:2138; appliedIndex:2135; }","duration":"384.300017ms","start":"2026-06-09T01:04:36.720402Z","end":"2026-06-09T01:04:37.104702Z","steps":["trace[35488275] 'read index received' (duration: 70.753173ms)","trace[35488275] 'applied index is now lower than readState.Index' (duration: 313.546134ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:04:37.105004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.587901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-09T01:04:37.10507Z","caller":"traceutil/trace.go:171","msg":"trace[1279626581] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2061; }","duration":"384.685912ms","start":"2026-06-09T01:04:36.720366Z","end":"2026-06-09T01:04:37.105052Z","steps":["trace[1279626581] 'agreement among raft nodes before linearized reading' (duration: 384.52572ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:04:37.105075Z","caller":"traceutil/trace.go:171","msg":"trace[1948348747] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"342.514786ms","start":"2026-06-09T01:04:36.762551Z","end":"2026-06-09T01:04:37.105065Z","steps":["trace[1948348747] 'process raft request' (duration: 342.07344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:37.105099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:36.720347Z","time spent":"384.744903ms","remote":"127.0.0.1:59042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-09T01:04:37.105181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.017195ms","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-06-09T01:04:37.105234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:36.762521Z","time spent":"342.580187ms","remote":"127.0.0.1:40110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:04:37.105245Z","caller":"traceutil/trace.go:171","msg":"trace[967839230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2061; }","duration":"328.116106ms","start":"2026-06-09T01:04:36.777111Z","end":"2026-06-09T01:04:37.105227Z","steps":["trace[967839230] 'agreement among raft nodes before linearized reading' (duration: 327.944694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:37.105287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:36.777094Z","time spent":"328.184578ms","remote":"127.0.0.1:40110","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":"info","ts":"2026-06-09T01:04:37.105406Z","caller":"traceutil/trace.go:171","msg":"trace[1649734277] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"466.147819ms","start":"2026-06-09T01:04:36.638655Z","end":"2026-06-09T01:04:37.104803Z","steps":["trace[1649734277] 'process raft request' (duration: 465.786004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:04:37.105505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:04:36.638623Z","time spent":"466.808697ms","remote":"127.0.0.1:40110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T01:06:20.868187Z","caller":"traceutil/trace.go:171","msg":"trace[887993285] transaction","detail":"{read_only:false; response_revision:2727; number_of_response:1; }","duration":"252.725478ms","start":"2026-06-09T01:06:20.615432Z","end":"2026-06-09T01:06:20.868158Z","steps":["trace[887993285] 'process raft request' (duration: 252.555695ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:06:26.07325Z","caller":"traceutil/trace.go:171","msg":"trace[1593645940] transaction","detail":"{read_only:false; response_revision:2757; number_of_response:1; }","duration":"123.649888ms","start":"2026-06-09T01:06:25.949568Z","end":"2026-06-09T01:06:26.073218Z","steps":["trace[1593645940] 'process raft request' (duration: 123.436774ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:09:06.606386Z","caller":"traceutil/trace.go:171","msg":"trace[1705588654] linearizableReadLoop","detail":"{readStateIndex:3869; appliedIndex:3868; }","duration":"204.26588ms","start":"2026-06-09T01:09:06.402094Z","end":"2026-06-09T01:09:06.60636Z","steps":["trace[1705588654] 'read index received' (duration: 204.187369ms)","trace[1705588654] 'applied index is now lower than readState.Index' (duration: 77.581µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:09:06.606436Z","caller":"traceutil/trace.go:171","msg":"trace[461291716] transaction","detail":"{read_only:false; response_revision:3727; number_of_response:1; }","duration":"374.695311ms","start":"2026-06-09T01:09:06.231707Z","end":"2026-06-09T01:09:06.606403Z","steps":["trace[461291716] 'process raft request' (duration: 374.490818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:09:06.606591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.466572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T01:09:06.606672Z","caller":"traceutil/trace.go:171","msg":"trace[974350406] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3727; }","duration":"204.642545ms","start":"2026-06-09T01:09:06.402018Z","end":"2026-06-09T01:09:06.606661Z","steps":["trace[974350406] 'agreement among raft nodes before linearized reading' (duration: 204.480562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:09:06.606777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:09:06.231681Z","time spent":"374.928725ms","remote":"127.0.0.1:40110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:09:06.618346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.278935ms","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-06-09T01:09:06.61841Z","caller":"traceutil/trace.go:171","msg":"trace[152243152] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3727; }","duration":"203.380756ms","start":"2026-06-09T01:09:06.415012Z","end":"2026-06-09T01:09:06.618393Z","steps":["trace[152243152] 'agreement among raft nodes before linearized reading' (duration: 203.197694ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:09:51.838157Z","caller":"traceutil/trace.go:171","msg":"trace[1655991476] transaction","detail":"{read_only:false; response_revision:4336; number_of_response:1; }","duration":"122.291368ms","start":"2026-06-09T01:09:51.715842Z","end":"2026-06-09T01:09:51.838133Z","steps":["trace[1655991476] 'process raft request' (duration: 121.914183ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:09:51.893664Z","caller":"traceutil/trace.go:171","msg":"trace[2107128004] transaction","detail":"{read_only:false; response_revision:4337; number_of_response:1; }","duration":"142.177738ms","start":"2026-06-09T01:09:51.751462Z","end":"2026-06-09T01:09:51.89364Z","steps":["trace[2107128004] 'process raft request' (duration: 141.954995ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:09:53.100545Z","caller":"traceutil/trace.go:171","msg":"trace[643180210] transaction","detail":"{read_only:false; response_revision:4377; number_of_response:1; }","duration":"101.13652ms","start":"2026-06-09T01:09:52.999361Z","end":"2026-06-09T01:09:53.100498Z","steps":["trace[643180210] 'process raft request' (duration: 31.77658ms)","trace[643180210] 'compare' (duration: 68.993755ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:07.576018Z","caller":"traceutil/trace.go:171","msg":"trace[1665379279] transaction","detail":"{read_only:false; response_revision:4697; number_of_response:1; }","duration":"101.37591ms","start":"2026-06-09T01:10:07.47462Z","end":"2026-06-09T01:10:07.575995Z","steps":["trace[1665379279] 'process raft request' (duration: 100.870443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:20.634006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.919976ms","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-06-09T01:10:20.634085Z","caller":"traceutil/trace.go:171","msg":"trace[306210805] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4860; }","duration":"150.042158ms","start":"2026-06-09T01:10:20.484026Z","end":"2026-06-09T01:10:20.634068Z","steps":["trace[306210805] 'range keys from in-memory index tree' (duration: 149.757514ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:20.902014Z","caller":"traceutil/trace.go:171","msg":"trace[243253355] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"257.125292ms","start":"2026-06-09T01:10:20.644863Z","end":"2026-06-09T01:10:20.901988Z","steps":["trace[243253355] 'process raft request' (duration: 256.887909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:20.902244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.08701ms","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-06-09T01:10:20.902329Z","caller":"traceutil/trace.go:171","msg":"trace[2139261612] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4863; }","duration":"199.249561ms","start":"2026-06-09T01:10:20.70306Z","end":"2026-06-09T01:10:20.90231Z","steps":["trace[2139261612] 'agreement among raft nodes before linearized reading' (duration: 199.019209ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:20.901916Z","caller":"traceutil/trace.go:171","msg":"trace[1768065260] linearizableReadLoop","detail":"{readStateIndex:5045; appliedIndex:5044; }","duration":"198.750845ms","start":"2026-06-09T01:10:20.703141Z","end":"2026-06-09T01:10:20.901892Z","steps":["trace[1768065260] 'read index received' (duration: 198.523682ms)","trace[1768065260] 'applied index is now lower than readState.Index' (duration: 225.963µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:21.187579Z","caller":"traceutil/trace.go:171","msg":"trace[690020540] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"276.924235ms","start":"2026-06-09T01:10:20.910631Z","end":"2026-06-09T01:10:21.187555Z","steps":["trace[690020540] 'process raft request' (duration: 276.835414ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.187892Z","caller":"traceutil/trace.go:171","msg":"trace[291276631] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"276.115773ms","start":"2026-06-09T01:10:20.911759Z","end":"2026-06-09T01:10:21.187875Z","steps":["trace[291276631] 'process raft request' (duration: 275.760438ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.188052Z","caller":"traceutil/trace.go:171","msg":"trace[162347025] transaction","detail":"{read_only:false; response_revision:4865; number_of_response:1; }","duration":"277.484482ms","start":"2026-06-09T01:10:20.910544Z","end":"2026-06-09T01:10:21.188028Z","steps":["trace[162347025] 'process raft request' (duration: 276.750843ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.189296Z","caller":"traceutil/trace.go:171","msg":"trace[1107238987] linearizableReadLoop","detail":"{readStateIndex:5049; appliedIndex:5046; }","duration":"275.039989ms","start":"2026-06-09T01:10:20.914228Z","end":"2026-06-09T01:10:21.189268Z","steps":["trace[1107238987] 'read index received' (duration: 12.80431ms)","trace[1107238987] 'applied index is now lower than readState.Index' (duration: 262.234919ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:21.189469Z","caller":"traceutil/trace.go:171","msg":"trace[1064415222] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"270.051614ms","start":"2026-06-09T01:10:20.91941Z","end":"2026-06-09T01:10:21.189461Z","steps":["trace[1064415222] 'process raft request' (duration: 268.28844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:21.189651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.407004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-09T01:10:21.189684Z","caller":"traceutil/trace.go:171","msg":"trace[1720875711] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4868; }","duration":"275.465544ms","start":"2026-06-09T01:10:20.914209Z","end":"2026-06-09T01:10:21.189674Z","steps":["trace[1720875711] 'agreement among raft nodes before linearized reading' (duration: 275.351413ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:21.429569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.6913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T01:10:21.429989Z","caller":"traceutil/trace.go:171","msg":"trace[1405718320] linearizableReadLoop","detail":"{readStateIndex:5052; appliedIndex:5050; }","duration":"240.641421ms","start":"2026-06-09T01:10:21.189327Z","end":"2026-06-09T01:10:21.429968Z","steps":["trace[1405718320] 'read index received' (duration: 115.433545ms)","trace[1405718320] 'applied index is now lower than readState.Index' (duration: 125.206906ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:21.4301Z","caller":"traceutil/trace.go:171","msg":"trace[1351382745] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"500.436138ms","start":"2026-06-09T01:10:20.929631Z","end":"2026-06-09T01:10:21.430068Z","steps":["trace[1351382745] 'process raft request' (duration: 375.166451ms)","trace[1351382745] 'compare' (duration: 124.477066ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:21.43015Z","caller":"traceutil/trace.go:171","msg":"trace[2142057443] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"323.401832ms","start":"2026-06-09T01:10:21.106735Z","end":"2026-06-09T01:10:21.430137Z","steps":["trace[2142057443] 'process raft request' (duration: 323.156079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:21.430251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:20.929616Z","time spent":"500.55311ms","remote":"127.0.0.1:40110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:10:21.430419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:21.106703Z","time spent":"323.653986ms","remote":"127.0.0.1:40110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T01:10:21.430549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.419548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-06-09T01:10:21.430406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.171866ms","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-06-09T01:10:21.430629Z","caller":"traceutil/trace.go:171","msg":"trace[1400170305] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4870; }","duration":"343.50364ms","start":"2026-06-09T01:10:21.087095Z","end":"2026-06-09T01:10:21.430599Z","steps":["trace[1400170305] 'agreement among raft nodes before linearized reading' (duration: 343.369158ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:21.430638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.441953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-09T01:10:21.430643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.969736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-6b4567c9b9-b8f2l\" ","response":"range_response_count:1 size:11847"} {"level":"info","ts":"2026-06-09T01:10:21.430677Z","caller":"traceutil/trace.go:171","msg":"trace[549472482] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4870; }","duration":"178.517665ms","start":"2026-06-09T01:10:21.252148Z","end":"2026-06-09T01:10:21.430666Z","steps":["trace[549472482] 'agreement among raft nodes before linearized reading' (duration: 178.410894ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.430688Z","caller":"traceutil/trace.go:171","msg":"trace[1107640694] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-6b4567c9b9-b8f2l; range_end:; response_count:1; response_revision:4870; }","duration":"235.037267ms","start":"2026-06-09T01:10:21.195637Z","end":"2026-06-09T01:10:21.430675Z","steps":["trace[1107640694] 'agreement among raft nodes before linearized reading' (duration: 234.939986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:21.430546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.344583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-37504483-6804-4a29-8b56-06a570076169\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-06-09T01:10:21.43068Z","caller":"traceutil/trace.go:171","msg":"trace[1839318121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4870; }","duration":"392.45613ms","start":"2026-06-09T01:10:21.038203Z","end":"2026-06-09T01:10:21.430659Z","steps":["trace[1839318121] 'agreement among raft nodes before linearized reading' (duration: 392.023064ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.430733Z","caller":"traceutil/trace.go:171","msg":"trace[77963807] range","detail":"{range_begin:/registry/persistentvolumes/pvc-37504483-6804-4a29-8b56-06a570076169; range_end:; response_count:1; response_revision:4870; }","duration":"236.580497ms","start":"2026-06-09T01:10:21.194139Z","end":"2026-06-09T01:10:21.430719Z","steps":["trace[77963807] 'agreement among raft nodes before linearized reading' (duration: 236.248242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T01:10:21.430684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:21.087059Z","time spent":"343.611601ms","remote":"127.0.0.1:41126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-06-09T01:10:21.430797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T01:10:21.038123Z","time spent":"392.608262ms","remote":"127.0.0.1:40110","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-06-09T01:10:21.431077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.537217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-09T01:10:21.431131Z","caller":"traceutil/trace.go:171","msg":"trace[56979948] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:4870; }","duration":"118.636638ms","start":"2026-06-09T01:10:21.312482Z","end":"2026-06-09T01:10:21.431118Z","steps":["trace[56979948] 'agreement among raft nodes before linearized reading' (duration: 118.125131ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.911552Z","caller":"traceutil/trace.go:171","msg":"trace[1872895294] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"184.792767ms","start":"2026-06-09T01:10:21.726724Z","end":"2026-06-09T01:10:21.911517Z","steps":["trace[1872895294] 'process raft request' (duration: 114.754506ms)","trace[1872895294] 'compare' (duration: 69.734597ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T01:10:21.911799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.670455ms","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-06-09T01:10:21.911847Z","caller":"traceutil/trace.go:171","msg":"trace[116732166] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4887; }","duration":"141.733206ms","start":"2026-06-09T01:10:21.770104Z","end":"2026-06-09T01:10:21.911838Z","steps":["trace[116732166] 'agreement among raft nodes before linearized reading' (duration: 141.561153ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.911881Z","caller":"traceutil/trace.go:171","msg":"trace[1176903867] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"185.007051ms","start":"2026-06-09T01:10:21.726858Z","end":"2026-06-09T01:10:21.911865Z","steps":["trace[1176903867] 'process raft request' (duration: 184.541735ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.912035Z","caller":"traceutil/trace.go:171","msg":"trace[959056888] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"183.085146ms","start":"2026-06-09T01:10:21.72894Z","end":"2026-06-09T01:10:21.912026Z","steps":["trace[959056888] 'process raft request' (duration: 182.58462ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.912299Z","caller":"traceutil/trace.go:171","msg":"trace[1880902549] transaction","detail":"{read_only:false; response_revision:4887; number_of_response:1; }","duration":"179.148892ms","start":"2026-06-09T01:10:21.733134Z","end":"2026-06-09T01:10:21.912283Z","steps":["trace[1880902549] 'process raft request' (duration: 178.421663ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:10:21.91162Z","caller":"traceutil/trace.go:171","msg":"trace[1857355834] linearizableReadLoop","detail":"{readStateIndex:5070; appliedIndex:5065; }","duration":"141.479842ms","start":"2026-06-09T01:10:21.770119Z","end":"2026-06-09T01:10:21.911598Z","steps":["trace[1857355834] 'read index received' (duration: 71.281859ms)","trace[1857355834] 'applied index is now lower than readState.Index' (duration: 70.197073ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T01:10:21.911642Z","caller":"traceutil/trace.go:171","msg":"trace[775010306] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"182.937484ms","start":"2026-06-09T01:10:21.728682Z","end":"2026-06-09T01:10:21.911619Z","steps":["trace[775010306] 'process raft request' (duration: 182.804712ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:11:48.423148Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874} {"level":"info","ts":"2026-06-09T01:11:48.513882Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"89.01315ms","hash":2033240790,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":29679616,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-09T01:11:48.513933Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2033240790,"revision":2874,"compact-revision":-1} {"level":"info","ts":"2026-06-09T01:14:21.369582Z","caller":"traceutil/trace.go:171","msg":"trace[1068860857] transaction","detail":"{read_only:false; response_revision:6629; number_of_response:1; }","duration":"130.923806ms","start":"2026-06-09T01:14:21.238637Z","end":"2026-06-09T01:14:21.369561Z","steps":["trace[1068860857] 'process raft request' (duration: 130.778502ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T01:16:48.430897Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5600} {"level":"info","ts":"2026-06-09T01:16:48.547855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5600,"took":"115.755545ms","hash":1050708981,"current-db-size-bytes":54747136,"current-db-size":"55 MB","current-db-size-in-use-bytes":18305024,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-09T01:16:48.547905Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1050708981,"revision":5600,"compact-revision":2874}