{"level":"warn","ts":"2026-06-23T04:30:57.792111Z","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-23T04:30:57.792264Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.115: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.115:2380","--initial-cluster=instance=https://199.204.45.115:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.115:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.115: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-23T04:30:57.79239Z","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-23T04:30:57.792408Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-06-23T04:30:57.792429Z","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-23T04:30:57.793364Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"]} {"level":"info","ts":"2026-06-23T04:30:57.793479Z","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.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.115: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-23T04:30:57.798795Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.83862ms"} {"level":"info","ts":"2026-06-23T04:30:57.806843Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e3aaa5c123e150e0","cluster-id":"61ec519698823541"} {"level":"info","ts":"2026-06-23T04:30:57.806917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=()"} {"level":"info","ts":"2026-06-23T04:30:57.806935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 0"} {"level":"info","ts":"2026-06-23T04:30:57.806948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e3aaa5c123e150e0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-23T04:30:57.806959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became follower at term 1"} {"level":"info","ts":"2026-06-23T04:30:57.806989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"warn","ts":"2026-06-23T04:30:57.813664Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-23T04:30:57.815423Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-23T04:30:57.824918Z","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-23T04:30:57.836391Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e3aaa5c123e150e0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-23T04:30:57.836762Z","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-23T04:30:57.836845Z","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-23T04:30:57.836857Z","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-23T04:30:57.837271Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e3aaa5c123e150e0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-23T04:30:57.83786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 switched to configuration voters=(16405106841599693024)"} {"level":"info","ts":"2026-06-23T04:30:57.838605Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","added-peer-id":"e3aaa5c123e150e0","added-peer-peer-urls":["https://199.204.45.115:2380"]} {"level":"info","ts":"2026-06-23T04:30:57.843302Z","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-23T04:30:57.843413Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-06-23T04:30:57.843452Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.115:2380"} {"level":"info","ts":"2026-06-23T04:30:57.844635Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e3aaa5c123e150e0","initial-advertise-peer-urls":["https://199.204.45.115:2380"],"listen-peer-urls":["https://199.204.45.115:2380"],"advertise-client-urls":["https://199.204.45.115:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.115:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-23T04:30:57.844673Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-23T04:30:57.907241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 is starting a new election at term 1"} {"level":"info","ts":"2026-06-23T04:30:57.907311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-23T04:30:57.907338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgPreVoteResp from e3aaa5c123e150e0 at term 1"} {"level":"info","ts":"2026-06-23T04:30:57.90736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became candidate at term 2"} {"level":"info","ts":"2026-06-23T04:30:57.907374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 received MsgVoteResp from e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-06-23T04:30:57.907393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e3aaa5c123e150e0 became leader at term 2"} {"level":"info","ts":"2026-06-23T04:30:57.907431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e3aaa5c123e150e0 elected leader e3aaa5c123e150e0 at term 2"} {"level":"info","ts":"2026-06-23T04:30:57.908525Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e3aaa5c123e150e0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.115:2379]}","request-path":"/0/members/e3aaa5c123e150e0/attributes","cluster-id":"61ec519698823541","publish-timeout":"7s"} {"level":"info","ts":"2026-06-23T04:30:57.908575Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T04:30:57.908758Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T04:30:57.90882Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T04:30:57.908982Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-23T04:30:57.908997Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-23T04:30:57.910331Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"61ec519698823541","local-member-id":"e3aaa5c123e150e0","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T04:30:57.910649Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T04:30:57.910699Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T04:30:57.91221Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-23T04:30:57.914212Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.115:2379"} {"level":"info","ts":"2026-06-23T04:31:32.957195Z","caller":"traceutil/trace.go:171","msg":"trace[1085087671] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"106.786004ms","start":"2026-06-23T04:31:32.850391Z","end":"2026-06-23T04:31:32.957177Z","steps":["trace[1085087671] 'process raft request' (duration: 106.002962ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:32.957466Z","caller":"traceutil/trace.go:171","msg":"trace[1927948944] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"106.273677ms","start":"2026-06-23T04:31:32.851175Z","end":"2026-06-23T04:31:32.957449Z","steps":["trace[1927948944] 'process raft request' (duration: 105.311825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:33.259585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.710992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:31:33.260101Z","caller":"traceutil/trace.go:171","msg":"trace[446659055] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"330.386453ms","start":"2026-06-23T04:31:32.929674Z","end":"2026-06-23T04:31:33.26006Z","steps":["trace[446659055] 'process raft request' (duration: 227.629605ms)","trace[446659055] 'compare' (duration: 101.522982ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:31:33.260431Z","caller":"traceutil/trace.go:171","msg":"trace[597782801] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"283.687927ms","start":"2026-06-23T04:31:32.976525Z","end":"2026-06-23T04:31:33.260213Z","steps":["trace[597782801] 'process raft request' (duration: 283.339758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:33.260963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:31:32.929465Z","time spent":"330.766493ms","remote":"127.0.0.1:40558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:31:33.261486Z","caller":"traceutil/trace.go:171","msg":"trace[1045133990] linearizableReadLoop","detail":"{readStateIndex:557; appliedIndex:554; }","duration":"301.661628ms","start":"2026-06-23T04:31:32.95979Z","end":"2026-06-23T04:31:33.261452Z","steps":["trace[1045133990] 'read index received' (duration: 197.607011ms)","trace[1045133990] 'applied index is now lower than readState.Index' (duration: 104.053537ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:31:33.262544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.718325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:31:33.262596Z","caller":"traceutil/trace.go:171","msg":"trace[1124994048] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:541; }","duration":"302.81038ms","start":"2026-06-23T04:31:32.959766Z","end":"2026-06-23T04:31:33.262576Z","steps":["trace[1124994048] 'agreement among raft nodes before linearized reading' (duration: 301.760524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:33.262642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:31:32.959756Z","time spent":"302.879353ms","remote":"127.0.0.1:40496","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-06-23T04:31:33.261322Z","caller":"traceutil/trace.go:171","msg":"trace[2009714196] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"330.90948ms","start":"2026-06-23T04:31:32.930305Z","end":"2026-06-23T04:31:33.261214Z","steps":["trace[2009714196] 'process raft request' (duration: 329.446912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:33.263181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:31:32.930295Z","time spent":"332.800911ms","remote":"127.0.0.1:35784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T04:31:33.263682Z","caller":"traceutil/trace.go:171","msg":"trace[1822821675] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"263.217418ms","start":"2026-06-23T04:31:33.000441Z","end":"2026-06-23T04:31:33.263658Z","steps":["trace[1822821675] 'process raft request' (duration: 259.640957ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:33.263858Z","caller":"traceutil/trace.go:171","msg":"trace[2120274880] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"280.532594ms","start":"2026-06-23T04:31:32.983305Z","end":"2026-06-23T04:31:33.263838Z","steps":["trace[2120274880] 'process raft request' (duration: 276.629156ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:33.264075Z","caller":"traceutil/trace.go:171","msg":"trace[1016791711] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"287.234387ms","start":"2026-06-23T04:31:32.97669Z","end":"2026-06-23T04:31:33.263924Z","steps":["trace[1016791711] 'process raft request' (duration: 283.211622ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:33.264641Z","caller":"traceutil/trace.go:171","msg":"trace[1059406243] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"276.94141ms","start":"2026-06-23T04:31:32.987655Z","end":"2026-06-23T04:31:33.264596Z","steps":["trace[1059406243] 'process raft request' (duration: 272.324563ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:33.265213Z","caller":"traceutil/trace.go:171","msg":"trace[421749324] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"272.125658ms","start":"2026-06-23T04:31:32.993043Z","end":"2026-06-23T04:31:33.265168Z","steps":["trace[421749324] 'process raft request' (duration: 266.962473ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:33.261428Z","caller":"traceutil/trace.go:171","msg":"trace[665453512] transaction","detail":"{read_only:false; number_of_response:1; response_revision:535; }","duration":"329.443081ms","start":"2026-06-23T04:31:32.931975Z","end":"2026-06-23T04:31:33.261418Z","steps":["trace[665453512] 'process raft request' (duration: 327.837445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:33.266155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:31:32.931966Z","time spent":"334.097149ms","remote":"127.0.0.1:40558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:31:33.272502Z","caller":"traceutil/trace.go:171","msg":"trace[949932210] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"259.985385ms","start":"2026-06-23T04:31:33.012484Z","end":"2026-06-23T04:31:33.27247Z","steps":["trace[949932210] 'process raft request' (duration: 259.103628ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:33.275271Z","caller":"traceutil/trace.go:171","msg":"trace[269154866] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"261.520667ms","start":"2026-06-23T04:31:33.011016Z","end":"2026-06-23T04:31:33.272536Z","steps":["trace[269154866] 'process raft request' (duration: 252.03478ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:33.275749Z","caller":"traceutil/trace.go:171","msg":"trace[862746716] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"174.154001ms","start":"2026-06-23T04:31:33.10158Z","end":"2026-06-23T04:31:33.275734Z","steps":["trace[862746716] 'process raft request' (duration: 174.017713ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:39.669344Z","caller":"traceutil/trace.go:171","msg":"trace[495146721] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"100.055614ms","start":"2026-06-23T04:31:39.569257Z","end":"2026-06-23T04:31:39.669312Z","steps":["trace[495146721] 'process raft request' (duration: 98.242235ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:39.835139Z","caller":"traceutil/trace.go:171","msg":"trace[1876547868] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"105.715676ms","start":"2026-06-23T04:31:39.729349Z","end":"2026-06-23T04:31:39.835065Z","steps":["trace[1876547868] 'process raft request' (duration: 105.39468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:40.596267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.586079ms","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-06-23T04:31:40.596362Z","caller":"traceutil/trace.go:171","msg":"trace[614174872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:631; }","duration":"510.744547ms","start":"2026-06-23T04:31:40.085595Z","end":"2026-06-23T04:31:40.59634Z","steps":["trace[614174872] 'range keys from in-memory index tree' (duration: 510.39373ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:40.596404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:31:40.085577Z","time spent":"510.81826ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T04:31:40.596485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.854175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8tf4f\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-23T04:31:40.596579Z","caller":"traceutil/trace.go:171","msg":"trace[1730817952] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8tf4f; range_end:; response_count:1; response_revision:631; }","duration":"405.991792ms","start":"2026-06-23T04:31:40.190564Z","end":"2026-06-23T04:31:40.596556Z","steps":["trace[1730817952] 'range keys from in-memory index tree' (duration: 405.604273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:40.596655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:31:40.190542Z","time spent":"406.101417ms","remote":"127.0.0.1:40664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-8tf4f\" "} {"level":"info","ts":"2026-06-23T04:31:40.620576Z","caller":"traceutil/trace.go:171","msg":"trace[1968868698] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"201.091677ms","start":"2026-06-23T04:31:40.419468Z","end":"2026-06-23T04:31:40.62056Z","steps":["trace[1968868698] 'read index received' (duration: 200.422255ms)","trace[1968868698] 'applied index is now lower than readState.Index' (duration: 668.292µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:31:40.62069Z","caller":"traceutil/trace.go:171","msg":"trace[542037086] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"315.000001ms","start":"2026-06-23T04:31:40.30566Z","end":"2026-06-23T04:31:40.62066Z","steps":["trace[542037086] 'process raft request' (duration: 314.395842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:40.620763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.291637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T04:31:40.620805Z","caller":"traceutil/trace.go:171","msg":"trace[1136616234] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:632; }","duration":"201.385632ms","start":"2026-06-23T04:31:40.419407Z","end":"2026-06-23T04:31:40.620793Z","steps":["trace[1136616234] 'agreement among raft nodes before linearized reading' (duration: 201.260036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:40.620848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:31:40.305638Z","time spent":"315.124737ms","remote":"127.0.0.1:40594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:31:57.048285Z","caller":"traceutil/trace.go:171","msg":"trace[949151603] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"226.67757ms","start":"2026-06-23T04:31:56.821567Z","end":"2026-06-23T04:31:57.048244Z","steps":["trace[949151603] 'process raft request' (duration: 226.367717ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:31:57.048852Z","caller":"traceutil/trace.go:171","msg":"trace[1845842951] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:832; }","duration":"140.493698ms","start":"2026-06-23T04:31:56.908317Z","end":"2026-06-23T04:31:57.04881Z","steps":["trace[1845842951] 'read index received' (duration: 139.647134ms)","trace[1845842951] 'applied index is now lower than readState.Index' (duration: 845.004µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:31:57.049189Z","caller":"traceutil/trace.go:171","msg":"trace[669901969] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"225.45189ms","start":"2026-06-23T04:31:56.823706Z","end":"2026-06-23T04:31:57.049157Z","steps":["trace[669901969] 'process raft request' (duration: 224.889547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:31:57.049335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.008538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:31:57.050178Z","caller":"traceutil/trace.go:171","msg":"trace[1026990803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"141.886873ms","start":"2026-06-23T04:31:56.908256Z","end":"2026-06-23T04:31:57.050143Z","steps":["trace[1026990803] 'agreement among raft nodes before linearized reading' (duration: 141.022628ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:32:26.957523Z","caller":"traceutil/trace.go:171","msg":"trace[354174156] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"106.679309ms","start":"2026-06-23T04:32:26.850818Z","end":"2026-06-23T04:32:26.957498Z","steps":["trace[354174156] 'process raft request' (duration: 106.245446ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:32:51.477006Z","caller":"traceutil/trace.go:171","msg":"trace[556529859] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"131.101785ms","start":"2026-06-23T04:32:51.345885Z","end":"2026-06-23T04:32:51.476987Z","steps":["trace[556529859] 'process raft request' (duration: 130.750946ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:33:16.807972Z","caller":"traceutil/trace.go:171","msg":"trace[1429670775] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"132.037967ms","start":"2026-06-23T04:33:16.675903Z","end":"2026-06-23T04:33:16.807941Z","steps":["trace[1429670775] 'process raft request' (duration: 105.894843ms)","trace[1429670775] 'compare' (duration: 26.023592ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:33:24.218013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.849055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:33:24.218106Z","caller":"traceutil/trace.go:171","msg":"trace[337075392] linearizableReadLoop","detail":"{readStateIndex:1991; appliedIndex:1990; }","duration":"383.496117ms","start":"2026-06-23T04:33:23.834596Z","end":"2026-06-23T04:33:24.218092Z","steps":["trace[337075392] 'read index received' (duration: 151.492459ms)","trace[337075392] 'applied index is now lower than readState.Index' (duration: 232.002928ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:33:24.218131Z","caller":"traceutil/trace.go:171","msg":"trace[1610529569] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"414.602312ms","start":"2026-06-23T04:33:23.803513Z","end":"2026-06-23T04:33:24.218115Z","steps":["trace[1610529569] 'process raft request' (duration: 182.574383ms)","trace[1610529569] 'compare' (duration: 231.186443ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:33:24.218204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:33:23.803489Z","time spent":"414.683994ms","remote":"127.0.0.1:40664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:33:24.218726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.135269ms","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-23T04:33:24.218761Z","caller":"traceutil/trace.go:171","msg":"trace[402602212] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1914; }","duration":"384.219501ms","start":"2026-06-23T04:33:23.834533Z","end":"2026-06-23T04:33:24.218753Z","steps":["trace[402602212] 'agreement among raft nodes before linearized reading' (duration: 383.611719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:33:24.218784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:33:23.834508Z","time spent":"384.270951ms","remote":"127.0.0.1:35092","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-23T04:33:24.219019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.85387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:33:24.219104Z","caller":"traceutil/trace.go:171","msg":"trace[536791067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1915; }","duration":"310.982283ms","start":"2026-06-23T04:33:23.908105Z","end":"2026-06-23T04:33:24.219087Z","steps":["trace[536791067] 'agreement among raft nodes before linearized reading' (duration: 310.84747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:33:24.219135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.693255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4df0bae4-79aa-42fe-b2a3-6151929b8a36\" ","response":"range_response_count:1 size:3744"} {"level":"warn","ts":"2026-06-23T04:33:24.21915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:33:23.908087Z","time spent":"311.054734ms","remote":"127.0.0.1:40494","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-06-23T04:33:24.219187Z","caller":"traceutil/trace.go:171","msg":"trace[1614878233] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4df0bae4-79aa-42fe-b2a3-6151929b8a36; range_end:; response_count:1; response_revision:1915; }","duration":"229.786997ms","start":"2026-06-23T04:33:23.989389Z","end":"2026-06-23T04:33:24.219176Z","steps":["trace[1614878233] 'agreement among raft nodes before linearized reading' (duration: 229.698685ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:33:24.380941Z","caller":"traceutil/trace.go:171","msg":"trace[238061040] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"149.040975ms","start":"2026-06-23T04:33:24.231811Z","end":"2026-06-23T04:33:24.380852Z","steps":["trace[238061040] 'process raft request' (duration: 144.095183ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:33:24.511016Z","caller":"traceutil/trace.go:171","msg":"trace[2067915387] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"123.037129ms","start":"2026-06-23T04:33:24.387948Z","end":"2026-06-23T04:33:24.510985Z","steps":["trace[2067915387] 'process raft request' (duration: 117.504056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:33:24.788962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.579569ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:33:24.789336Z","caller":"traceutil/trace.go:171","msg":"trace[1997325188] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"401.007644ms","start":"2026-06-23T04:33:24.388307Z","end":"2026-06-23T04:33:24.789314Z","steps":["trace[1997325188] 'process raft request' (duration: 400.78278ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:33:24.789379Z","caller":"traceutil/trace.go:171","msg":"trace[1624882845] linearizableReadLoop","detail":"{readStateIndex:1998; appliedIndex:1993; }","duration":"352.896745ms","start":"2026-06-23T04:33:24.436461Z","end":"2026-06-23T04:33:24.789357Z","steps":["trace[1624882845] 'read index received' (duration: 69.288155ms)","trace[1624882845] 'applied index is now lower than readState.Index' (duration: 283.60711ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:33:24.789387Z","caller":"traceutil/trace.go:171","msg":"trace[1402316439] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"399.825752ms","start":"2026-06-23T04:33:24.389542Z","end":"2026-06-23T04:33:24.789368Z","steps":["trace[1402316439] 'process raft request' (duration: 399.71367ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:33:24.789366Z","caller":"traceutil/trace.go:171","msg":"trace[1183634401] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"401.177888ms","start":"2026-06-23T04:33:24.388073Z","end":"2026-06-23T04:33:24.789251Z","steps":["trace[1183634401] 'process raft request' (duration: 261.197132ms)","trace[1183634401] 'compare' (duration: 139.406285ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:33:24.789471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:33:24.388297Z","time spent":"401.093967ms","remote":"127.0.0.1:40658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:33:24.7895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:33:24.38953Z","time spent":"399.922225ms","remote":"127.0.0.1:40748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:33:24.789576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.11283ms","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-23T04:33:24.789636Z","caller":"traceutil/trace.go:171","msg":"trace[547277456] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1921; }","duration":"353.194751ms","start":"2026-06-23T04:33:24.436415Z","end":"2026-06-23T04:33:24.789609Z","steps":["trace[547277456] 'agreement among raft nodes before linearized reading' (duration: 353.057728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:33:24.789673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:33:24.436398Z","time spent":"353.269093ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T04:33:24.789655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:33:24.38805Z","time spent":"401.456083ms","remote":"127.0.0.1:40748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:33:24.789777Z","caller":"traceutil/trace.go:171","msg":"trace[57664123] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"398.966197ms","start":"2026-06-23T04:33:24.3908Z","end":"2026-06-23T04:33:24.789766Z","steps":["trace[57664123] 'process raft request' (duration: 398.500248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:33:24.789838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:33:24.390791Z","time spent":"399.017468ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:33:39.952163Z","caller":"traceutil/trace.go:171","msg":"trace[304163928] transaction","detail":"{read_only:false; response_revision:2047; number_of_response:1; }","duration":"159.22575ms","start":"2026-06-23T04:33:39.792917Z","end":"2026-06-23T04:33:39.952143Z","steps":["trace[304163928] 'process raft request' (duration: 158.949716ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:33:39.969163Z","caller":"traceutil/trace.go:171","msg":"trace[1587209154] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"173.857001ms","start":"2026-06-23T04:33:39.795256Z","end":"2026-06-23T04:33:39.969113Z","steps":["trace[1587209154] 'process raft request' (duration: 173.245461ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:33:55.524973Z","caller":"traceutil/trace.go:171","msg":"trace[346125244] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"154.386729ms","start":"2026-06-23T04:33:55.370567Z","end":"2026-06-23T04:33:55.524954Z","steps":["trace[346125244] 'process raft request' (duration: 154.251907ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:33:55.54527Z","caller":"traceutil/trace.go:171","msg":"trace[627874909] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"150.542958ms","start":"2026-06-23T04:33:55.394685Z","end":"2026-06-23T04:33:55.545228Z","steps":["trace[627874909] 'process raft request' (duration: 150.179982ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:34:01.339856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.257708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-23T04:34:01.339924Z","caller":"traceutil/trace.go:171","msg":"trace[1593985423] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:2168; }","duration":"131.387981ms","start":"2026-06-23T04:34:01.208519Z","end":"2026-06-23T04:34:01.339907Z","steps":["trace[1593985423] 'range keys from in-memory index tree' (duration: 131.034476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:34:01.340398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.293697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"} {"level":"info","ts":"2026-06-23T04:34:01.340425Z","caller":"traceutil/trace.go:171","msg":"trace[345366374] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2168; }","duration":"151.369779ms","start":"2026-06-23T04:34:01.189049Z","end":"2026-06-23T04:34:01.340419Z","steps":["trace[345366374] 'range keys from in-memory index tree' (duration: 151.161586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:34:01.586599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.942552ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-23T04:34:02.376859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.194308ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:34:02.377002Z","caller":"traceutil/trace.go:171","msg":"trace[784155517] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2259; }","duration":"193.379387ms","start":"2026-06-23T04:34:02.1836Z","end":"2026-06-23T04:34:02.376979Z","steps":["trace[784155517] 'read index received' (duration: 63.928305ms)","trace[784155517] 'applied index is now lower than readState.Index' (duration: 129.449272ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:34:02.377091Z","caller":"traceutil/trace.go:171","msg":"trace[1326810146] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"281.723777ms","start":"2026-06-23T04:34:02.095317Z","end":"2026-06-23T04:34:02.377041Z","steps":["trace[1326810146] 'process raft request' (duration: 152.213794ms)","trace[1326810146] 'compare' (duration: 129.013116ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:34:02.377176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.58241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18bb9baa0a4cee68\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-23T04:34:02.377214Z","caller":"traceutil/trace.go:171","msg":"trace[1236120746] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18bb9baa0a4cee68; range_end:; response_count:1; response_revision:2174; }","duration":"193.665381ms","start":"2026-06-23T04:34:02.183538Z","end":"2026-06-23T04:34:02.377203Z","steps":["trace[1236120746] 'agreement among raft nodes before linearized reading' (duration: 193.502078ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:34:03.219148Z","caller":"traceutil/trace.go:171","msg":"trace[1960014378] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"122.188484ms","start":"2026-06-23T04:34:03.095943Z","end":"2026-06-23T04:34:03.218132Z","steps":["trace[1960014378] 'process raft request' (duration: 118.824442ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:34:03.439056Z","caller":"traceutil/trace.go:171","msg":"trace[1562791649] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"342.211036ms","start":"2026-06-23T04:34:03.096805Z","end":"2026-06-23T04:34:03.439016Z","steps":["trace[1562791649] 'process raft request' (duration: 317.0579ms)","trace[1562791649] 'compare' (duration: 24.291103ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:34:03.439259Z","caller":"traceutil/trace.go:171","msg":"trace[867153406] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"342.313238ms","start":"2026-06-23T04:34:03.096878Z","end":"2026-06-23T04:34:03.439191Z","steps":["trace[867153406] 'process raft request' (duration: 341.918892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:34:03.439785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:34:03.096853Z","time spent":"342.495801ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:34:03.440404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:34:03.096784Z","time spent":"342.369659ms","remote":"127.0.0.1:40742","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-23T04:36:10.203943Z","caller":"traceutil/trace.go:171","msg":"trace[23880928] transaction","detail":"{read_only:false; response_revision:2961; number_of_response:1; }","duration":"128.94187ms","start":"2026-06-23T04:36:10.074962Z","end":"2026-06-23T04:36:10.203904Z","steps":["trace[23880928] 'process raft request' (duration: 128.686859ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:36:10.248872Z","caller":"traceutil/trace.go:171","msg":"trace[752639651] linearizableReadLoop","detail":"{readStateIndex:3076; appliedIndex:3074; }","duration":"155.924484ms","start":"2026-06-23T04:36:10.092926Z","end":"2026-06-23T04:36:10.248851Z","steps":["trace[752639651] 'read index received' (duration: 110.765246ms)","trace[752639651] 'applied index is now lower than readState.Index' (duration: 45.158448ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:36:10.250011Z","caller":"traceutil/trace.go:171","msg":"trace[973432093] transaction","detail":"{read_only:false; response_revision:2962; number_of_response:1; }","duration":"173.19112ms","start":"2026-06-23T04:36:10.076792Z","end":"2026-06-23T04:36:10.249983Z","steps":["trace[973432093] 'process raft request' (duration: 171.941117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:36:10.250451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.347995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T04:36:10.25049Z","caller":"traceutil/trace.go:171","msg":"trace[1189570146] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2962; }","duration":"148.432549ms","start":"2026-06-23T04:36:10.102049Z","end":"2026-06-23T04:36:10.250481Z","steps":["trace[1189570146] 'agreement among raft nodes before linearized reading' (duration: 148.343795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:36:10.251247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.044412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-23T04:36:10.25128Z","caller":"traceutil/trace.go:171","msg":"trace[750429047] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2962; }","duration":"148.097875ms","start":"2026-06-23T04:36:10.103173Z","end":"2026-06-23T04:36:10.251271Z","steps":["trace[750429047] 'agreement among raft nodes before linearized reading' (duration: 147.966379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:36:10.251459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.505102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-23T04:36:10.251518Z","caller":"traceutil/trace.go:171","msg":"trace[208541156] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2962; }","duration":"158.589976ms","start":"2026-06-23T04:36:10.092919Z","end":"2026-06-23T04:36:10.251509Z","steps":["trace[208541156] 'agreement among raft nodes before linearized reading' (duration: 158.388747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:39:04.324322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.290894ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T04:39:04.325458Z","caller":"traceutil/trace.go:171","msg":"trace[664675306] transaction","detail":"{read_only:false; response_revision:3966; number_of_response:1; }","duration":"176.467807ms","start":"2026-06-23T04:39:04.148959Z","end":"2026-06-23T04:39:04.325427Z","steps":["trace[664675306] 'process raft request' (duration: 39.953587ms)","trace[664675306] 'compare' (duration: 134.792032ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:39:43.628534Z","caller":"traceutil/trace.go:171","msg":"trace[264915834] transaction","detail":"{read_only:false; number_of_response:0; response_revision:4250; }","duration":"113.824542ms","start":"2026-06-23T04:39:43.514673Z","end":"2026-06-23T04:39:43.628498Z","steps":["trace[264915834] 'process raft request' (duration: 113.583067ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:09.179199Z","caller":"traceutil/trace.go:171","msg":"trace[1323731254] linearizableReadLoop","detail":"{readStateIndex:4948; appliedIndex:4947; }","duration":"270.991762ms","start":"2026-06-23T04:40:08.908188Z","end":"2026-06-23T04:40:09.17918Z","steps":["trace[1323731254] 'read index received' (duration: 270.500932ms)","trace[1323731254] 'applied index is now lower than readState.Index' (duration: 490.22µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:09.179417Z","caller":"traceutil/trace.go:171","msg":"trace[1319852615] transaction","detail":"{read_only:false; response_revision:4759; number_of_response:1; }","duration":"271.297428ms","start":"2026-06-23T04:40:08.90809Z","end":"2026-06-23T04:40:09.179387Z","steps":["trace[1319852615] 'process raft request' (duration: 270.457601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:09.179494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.292768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:09.179516Z","caller":"traceutil/trace.go:171","msg":"trace[1827539082] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4759; }","duration":"271.41561ms","start":"2026-06-23T04:40:08.908094Z","end":"2026-06-23T04:40:09.17951Z","steps":["trace[1827539082] 'agreement among raft nodes before linearized reading' (duration: 271.360439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:09.182342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.227885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-06-23T04:40:09.182411Z","caller":"traceutil/trace.go:171","msg":"trace[1297690200] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4760; }","duration":"273.291577ms","start":"2026-06-23T04:40:08.909106Z","end":"2026-06-23T04:40:09.182397Z","steps":["trace[1297690200] 'agreement among raft nodes before linearized reading' (duration: 273.152914ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:09.182608Z","caller":"traceutil/trace.go:171","msg":"trace[382138015] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"272.679105ms","start":"2026-06-23T04:40:08.909923Z","end":"2026-06-23T04:40:09.182602Z","steps":["trace[382138015] 'process raft request' (duration: 272.267356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:09.183224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.605826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:09.183282Z","caller":"traceutil/trace.go:171","msg":"trace[596407747] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:0; response_revision:4760; }","duration":"265.716778ms","start":"2026-06-23T04:40:08.91755Z","end":"2026-06-23T04:40:09.183267Z","steps":["trace[596407747] 'agreement among raft nodes before linearized reading' (duration: 265.623207ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:15.614413Z","caller":"traceutil/trace.go:171","msg":"trace[1855715399] linearizableReadLoop","detail":"{readStateIndex:5135; appliedIndex:5133; }","duration":"356.376005ms","start":"2026-06-23T04:40:15.258007Z","end":"2026-06-23T04:40:15.614383Z","steps":["trace[1855715399] 'read index received' (duration: 22.895842ms)","trace[1855715399] 'applied index is now lower than readState.Index' (duration: 333.478723ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:15.614559Z","caller":"traceutil/trace.go:171","msg":"trace[1089499105] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"358.286972ms","start":"2026-06-23T04:40:15.256237Z","end":"2026-06-23T04:40:15.614524Z","steps":["trace[1089499105] 'process raft request' (duration: 259.293512ms)","trace[1089499105] 'compare' (duration: 98.053461ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:15.614742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.709571ms","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-23T04:40:15.6148Z","caller":"traceutil/trace.go:171","msg":"trace[1965372069] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4941; }","duration":"356.800484ms","start":"2026-06-23T04:40:15.257983Z","end":"2026-06-23T04:40:15.614784Z","steps":["trace[1965372069] 'agreement among raft nodes before linearized reading' (duration: 356.586149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:15.614792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:15.25622Z","time spent":"358.458475ms","remote":"127.0.0.1:40742","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-23T04:40:15.614844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:15.257975Z","time spent":"356.858564ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T04:40:15.615204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.988277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-06-23T04:40:15.61531Z","caller":"traceutil/trace.go:171","msg":"trace[1403600698] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4941; }","duration":"357.14615ms","start":"2026-06-23T04:40:15.258138Z","end":"2026-06-23T04:40:15.615284Z","steps":["trace[1403600698] 'agreement among raft nodes before linearized reading' (duration: 356.649891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:15.61557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:15.258119Z","time spent":"357.407915ms","remote":"127.0.0.1:40594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":719,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" "} {"level":"warn","ts":"2026-06-23T04:40:15.6156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.369805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:15.615676Z","caller":"traceutil/trace.go:171","msg":"trace[1239607393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4941; }","duration":"229.486847ms","start":"2026-06-23T04:40:15.386177Z","end":"2026-06-23T04:40:15.615663Z","steps":["trace[1239607393] 'agreement among raft nodes before linearized reading' (duration: 229.369504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:15.615821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.73127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T04:40:15.615885Z","caller":"traceutil/trace.go:171","msg":"trace[416060633] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:4941; }","duration":"288.844002ms","start":"2026-06-23T04:40:15.327025Z","end":"2026-06-23T04:40:15.615869Z","steps":["trace[416060633] 'agreement among raft nodes before linearized reading' (duration: 288.70783ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:16.137403Z","caller":"traceutil/trace.go:171","msg":"trace[2017269746] linearizableReadLoop","detail":"{readStateIndex:5138; appliedIndex:5136; }","duration":"475.861376ms","start":"2026-06-23T04:40:15.661518Z","end":"2026-06-23T04:40:16.137379Z","steps":["trace[2017269746] 'read index received' (duration: 452.959035ms)","trace[2017269746] 'applied index is now lower than readState.Index' (duration: 22.901351ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:16.137934Z","caller":"traceutil/trace.go:171","msg":"trace[1807612652] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"515.447109ms","start":"2026-06-23T04:40:15.622459Z","end":"2026-06-23T04:40:16.137906Z","steps":["trace[1807612652] 'process raft request' (duration: 492.004547ms)","trace[1807612652] 'compare' (duration: 21.961593ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:16.138179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:15.622426Z","time spent":"515.581722ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:16.138197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.672251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-06-23T04:40:16.13825Z","caller":"traceutil/trace.go:171","msg":"trace[1233487781] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4944; }","duration":"476.726662ms","start":"2026-06-23T04:40:15.66151Z","end":"2026-06-23T04:40:16.138236Z","steps":["trace[1233487781] 'agreement among raft nodes before linearized reading' (duration: 476.557569ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.138288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:15.661496Z","time spent":"476.782383ms","remote":"127.0.0.1:40672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":1016,"request content":"key:\"/registry/services/specs/monitoring/prometheus-operated\" "} {"level":"info","ts":"2026-06-23T04:40:16.137985Z","caller":"traceutil/trace.go:171","msg":"trace[706553865] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"514.765216ms","start":"2026-06-23T04:40:15.623205Z","end":"2026-06-23T04:40:16.13797Z","steps":["trace[706553865] 'process raft request' (duration: 514.069763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.138954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:15.623194Z","time spent":"515.233945ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:40:16.170915Z","caller":"traceutil/trace.go:171","msg":"trace[1650963302] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"233.810355ms","start":"2026-06-23T04:40:15.937091Z","end":"2026-06-23T04:40:16.170901Z","steps":["trace[1650963302] 'process raft request' (duration: 233.620292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.171234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.843786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:16.171326Z","caller":"traceutil/trace.go:171","msg":"trace[253950877] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4946; }","duration":"261.969748ms","start":"2026-06-23T04:40:15.909337Z","end":"2026-06-23T04:40:16.171306Z","steps":["trace[253950877] 'agreement among raft nodes before linearized reading' (duration: 261.835096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.172063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.485077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-2k2rd\" ","response":"range_response_count:1 size:9674"} {"level":"info","ts":"2026-06-23T04:40:16.172174Z","caller":"traceutil/trace.go:171","msg":"trace[1734797988] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-2k2rd; range_end:; response_count:1; response_revision:4946; }","duration":"236.642039ms","start":"2026-06-23T04:40:15.935506Z","end":"2026-06-23T04:40:16.172148Z","steps":["trace[1734797988] 'agreement among raft nodes before linearized reading' (duration: 236.291003ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:16.483331Z","caller":"traceutil/trace.go:171","msg":"trace[981002396] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"300.387295ms","start":"2026-06-23T04:40:16.182906Z","end":"2026-06-23T04:40:16.483293Z","steps":["trace[981002396] 'process raft request' (duration: 260.989656ms)","trace[981002396] 'compare' (duration: 39.077723ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:16.483506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:16.182893Z","time spent":"300.520808ms","remote":"127.0.0.1:40664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9671,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:40:16.684044Z","caller":"traceutil/trace.go:171","msg":"trace[1530673923] linearizableReadLoop","detail":"{readStateIndex:5142; appliedIndex:5140; }","duration":"491.279672ms","start":"2026-06-23T04:40:16.192737Z","end":"2026-06-23T04:40:16.684016Z","steps":["trace[1530673923] 'read index received' (duration: 251.172278ms)","trace[1530673923] 'applied index is now lower than readState.Index' (duration: 240.106164ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:16.684171Z","caller":"traceutil/trace.go:171","msg":"trace[400277951] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"493.180739ms","start":"2026-06-23T04:40:16.190942Z","end":"2026-06-23T04:40:16.684122Z","steps":["trace[400277951] 'process raft request' (duration: 441.399572ms)","trace[400277951] 'compare' (duration: 51.244747ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:16.684417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:16.190915Z","time spent":"493.359812ms","remote":"127.0.0.1:51126","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7495,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:16.885927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.913729ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-06-23T04:40:16.88596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.167961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T04:40:16.886075Z","caller":"traceutil/trace.go:171","msg":"trace[1055853419] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4948; }","duration":"693.327824ms","start":"2026-06-23T04:40:16.192711Z","end":"2026-06-23T04:40:16.886039Z","steps":["trace[1055853419] 'agreement among raft nodes before linearized reading' (duration: 491.455126ms)","trace[1055853419] 'count revisions from in-memory index tree' (duration: 201.703715ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:16.886137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:16.192699Z","time spent":"693.422796ms","remote":"127.0.0.1:35012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-06-23T04:40:16.886253Z","caller":"traceutil/trace.go:171","msg":"trace[1993345272] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"180.741941ms","start":"2026-06-23T04:40:16.705495Z","end":"2026-06-23T04:40:16.886237Z","steps":["trace[1993345272] 'process raft request' (duration: 180.567988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.886305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.049763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:16.88636Z","caller":"traceutil/trace.go:171","msg":"trace[103059] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:4949; }","duration":"538.157965ms","start":"2026-06-23T04:40:16.348192Z","end":"2026-06-23T04:40:16.886349Z","steps":["trace[103059] 'agreement among raft nodes before linearized reading' (duration: 538.027133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.886399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:16.348155Z","time spent":"538.234057ms","remote":"127.0.0.1:38166","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true "} {"level":"info","ts":"2026-06-23T04:40:16.886175Z","caller":"traceutil/trace.go:171","msg":"trace[1170844419] linearizableReadLoop","detail":"{readStateIndex:5143; appliedIndex:5142; }","duration":"202.012941ms","start":"2026-06-23T04:40:16.684128Z","end":"2026-06-23T04:40:16.886141Z","steps":["trace[1170844419] 'read index received' (duration: 56.781µs)","trace[1170844419] 'applied index is now lower than readState.Index' (duration: 201.95253ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:16.886723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.383027ms","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-23T04:40:16.886836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.576479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-23T04:40:16.88689Z","caller":"traceutil/trace.go:171","msg":"trace[2025922738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4949; }","duration":"314.681572ms","start":"2026-06-23T04:40:16.572194Z","end":"2026-06-23T04:40:16.886875Z","steps":["trace[2025922738] 'agreement among raft nodes before linearized reading' (duration: 314.468977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.886928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:16.572165Z","time spent":"314.755202ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-23T04:40:16.887063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.542488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-23T04:40:16.887117Z","caller":"traceutil/trace.go:171","msg":"trace[835222763] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4948; }","duration":"463.594799ms","start":"2026-06-23T04:40:16.423506Z","end":"2026-06-23T04:40:16.887101Z","steps":["trace[835222763] 'agreement among raft nodes before linearized reading' (duration: 462.677811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.887154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:16.423478Z","time spent":"463.666521ms","remote":"127.0.0.1:40602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206996,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-06-23T04:40:16.887721Z","caller":"traceutil/trace.go:171","msg":"trace[918664163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4949; }","duration":"474.427608ms","start":"2026-06-23T04:40:16.413277Z","end":"2026-06-23T04:40:16.887705Z","steps":["trace[918664163] 'agreement among raft nodes before linearized reading' (duration: 473.320586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:16.887802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:16.413246Z","time spent":"474.53826ms","remote":"127.0.0.1:40742","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-23T04:40:23.998482Z","caller":"traceutil/trace.go:171","msg":"trace[552508253] linearizableReadLoop","detail":"{readStateIndex:5200; appliedIndex:5199; }","duration":"308.139161ms","start":"2026-06-23T04:40:23.690271Z","end":"2026-06-23T04:40:23.998411Z","steps":["trace[552508253] 'read index received' (duration: 307.936497ms)","trace[552508253] 'applied index is now lower than readState.Index' (duration: 199.954µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:23.998842Z","caller":"traceutil/trace.go:171","msg":"trace[1493796297] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"350.940967ms","start":"2026-06-23T04:40:23.647881Z","end":"2026-06-23T04:40:23.998822Z","steps":["trace[1493796297] 'process raft request' (duration: 350.342045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:23.999028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:23.647853Z","time spent":"351.043298ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:23.999844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.540337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-23T04:40:23.999919Z","caller":"traceutil/trace.go:171","msg":"trace[304995682] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5004; }","duration":"309.68578ms","start":"2026-06-23T04:40:23.690219Z","end":"2026-06-23T04:40:23.999904Z","steps":["trace[304995682] 'agreement among raft nodes before linearized reading' (duration: 308.359585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:23.999957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:23.690195Z","time spent":"309.754592ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T04:40:24.053989Z","caller":"traceutil/trace.go:171","msg":"trace[1289447280] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"193.138399ms","start":"2026-06-23T04:40:23.860825Z","end":"2026-06-23T04:40:24.053964Z","steps":["trace[1289447280] 'process raft request' (duration: 141.646849ms)","trace[1289447280] 'compare' (duration: 51.177884ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:24.839656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.165335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-2k2rd.18bb9c03a0841c39\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-06-23T04:40:24.839724Z","caller":"traceutil/trace.go:171","msg":"trace[1145982300] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-2k2rd.18bb9c03a0841c39; range_end:; response_count:1; response_revision:5022; }","duration":"101.315778ms","start":"2026-06-23T04:40:24.73839Z","end":"2026-06-23T04:40:24.839706Z","steps":["trace[1145982300] 'range keys from in-memory index tree' (duration: 100.993182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:24.840166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.324663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-06-23T04:40:24.840314Z","caller":"traceutil/trace.go:171","msg":"trace[1362890360] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5022; }","duration":"341.484347ms","start":"2026-06-23T04:40:24.49882Z","end":"2026-06-23T04:40:24.840304Z","steps":["trace[1362890360] 'range keys from in-memory index tree' (duration: 341.029188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:24.840337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:24.498813Z","time spent":"341.517377ms","remote":"127.0.0.1:35092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5674,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-23T04:40:25.162824Z","caller":"traceutil/trace.go:171","msg":"trace[1374638005] linearizableReadLoop","detail":"{readStateIndex:5222; appliedIndex:5221; }","duration":"144.250491ms","start":"2026-06-23T04:40:25.018545Z","end":"2026-06-23T04:40:25.162796Z","steps":["trace[1374638005] 'read index received' (duration: 129.509451ms)","trace[1374638005] 'applied index is now lower than readState.Index' (duration: 14.73986ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:25.163091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.516836ms","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-06-23T04:40:25.163168Z","caller":"traceutil/trace.go:171","msg":"trace[539876514] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5026; }","duration":"144.71855ms","start":"2026-06-23T04:40:25.018435Z","end":"2026-06-23T04:40:25.163154Z","steps":["trace[539876514] 'agreement among raft nodes before linearized reading' (duration: 144.472305ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:25.163112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.597313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-fd9b54f8d-5z27j.18bb9c0509dfd747\" ","response":"range_response_count:1 size:895"} {"level":"info","ts":"2026-06-23T04:40:25.163258Z","caller":"traceutil/trace.go:171","msg":"trace[1130956341] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-fd9b54f8d-5z27j.18bb9c0509dfd747; range_end:; response_count:1; response_revision:5026; }","duration":"138.771926ms","start":"2026-06-23T04:40:25.024467Z","end":"2026-06-23T04:40:25.163239Z","steps":["trace[1130956341] 'agreement among raft nodes before linearized reading' (duration: 138.498711ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:25.163543Z","caller":"traceutil/trace.go:171","msg":"trace[2042289000] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"152.202811ms","start":"2026-06-23T04:40:25.010656Z","end":"2026-06-23T04:40:25.162858Z","steps":["trace[2042289000] 'process raft request' (duration: 137.332719ms)","trace[2042289000] 'compare' (duration: 14.586667ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:30.760814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.512861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-23T04:40:30.761313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.155668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af7129ff-419e-4370-bd8f-fcdd1fa49430\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-23T04:40:30.762068Z","caller":"traceutil/trace.go:171","msg":"trace[1314580642] transaction","detail":"{read_only:false; response_revision:5118; number_of_response:1; }","duration":"454.209805ms","start":"2026-06-23T04:40:30.306824Z","end":"2026-06-23T04:40:30.761034Z","steps":["trace[1314580642] 'process raft request' (duration: 400.284288ms)","trace[1314580642] 'compare' (duration: 53.153312ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:30.762037Z","caller":"traceutil/trace.go:171","msg":"trace[243919946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5117; }","duration":"464.474218ms","start":"2026-06-23T04:40:30.297214Z","end":"2026-06-23T04:40:30.76168Z","steps":["trace[243919946] 'range keys from in-memory index tree' (duration: 463.313807ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:30.761036Z","caller":"traceutil/trace.go:171","msg":"trace[771808171] linearizableReadLoop","detail":"{readStateIndex:5316; appliedIndex:5315; }","duration":"450.853192ms","start":"2026-06-23T04:40:30.310145Z","end":"2026-06-23T04:40:30.760998Z","steps":["trace[771808171] 'read index received' (duration: 396.875354ms)","trace[771808171] 'applied index is now lower than readState.Index' (duration: 53.975998ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:40:30.76218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:30.297189Z","time spent":"464.938008ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-23T04:40:30.76235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:30.306781Z","time spent":"455.343297ms","remote":"127.0.0.1:40742","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-23T04:40:30.762116Z","caller":"traceutil/trace.go:171","msg":"trace[519018832] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-af7129ff-419e-4370-bd8f-fcdd1fa49430; range_end:; response_count:1; response_revision:5118; }","duration":"451.988453ms","start":"2026-06-23T04:40:30.310078Z","end":"2026-06-23T04:40:30.762066Z","steps":["trace[519018832] 'agreement among raft nodes before linearized reading' (duration: 451.044036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:30.762494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:30.310041Z","time spent":"452.389061ms","remote":"127.0.0.1:40664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af7129ff-419e-4370-bd8f-fcdd1fa49430\" "} {"level":"warn","ts":"2026-06-23T04:40:30.762688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.713271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-23T04:40:30.762798Z","caller":"traceutil/trace.go:171","msg":"trace[1284255191] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5118; }","duration":"449.897544ms","start":"2026-06-23T04:40:30.312872Z","end":"2026-06-23T04:40:30.762769Z","steps":["trace[1284255191] 'agreement among raft nodes before linearized reading' (duration: 449.530497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:30.762864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:30.312861Z","time spent":"449.988795ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-23T04:40:31.36289Z","caller":"traceutil/trace.go:171","msg":"trace[685471151] linearizableReadLoop","detail":"{readStateIndex:5318; appliedIndex:5317; }","duration":"454.284926ms","start":"2026-06-23T04:40:30.908576Z","end":"2026-06-23T04:40:31.362861Z","steps":["trace[685471151] 'read index received' (duration: 453.654884ms)","trace[685471151] 'applied index is now lower than readState.Index' (duration: 628.662µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T04:40:31.363045Z","caller":"traceutil/trace.go:171","msg":"trace[1527969114] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"594.53776ms","start":"2026-06-23T04:40:30.768492Z","end":"2026-06-23T04:40:31.36303Z","steps":["trace[1527969114] 'process raft request' (duration: 594.172393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:31.363181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:30.768475Z","time spent":"594.605522ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T04:40:31.36341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.816036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T04:40:31.363512Z","caller":"traceutil/trace.go:171","msg":"trace[1675993717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5120; }","duration":"454.987079ms","start":"2026-06-23T04:40:30.908499Z","end":"2026-06-23T04:40:31.363486Z","steps":["trace[1675993717] 'agreement among raft nodes before linearized reading' (duration: 454.821646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:31.36356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:30.908468Z","time spent":"455.083481ms","remote":"127.0.0.1:40494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T04:40:31.408636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.512802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.115\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-23T04:40:31.40868Z","caller":"traceutil/trace.go:171","msg":"trace[2095347329] range","detail":"{range_begin:/registry/masterleases/199.204.45.115; range_end:; response_count:1; response_revision:5123; }","duration":"177.600434ms","start":"2026-06-23T04:40:31.231069Z","end":"2026-06-23T04:40:31.40867Z","steps":["trace[2095347329] 'agreement among raft nodes before linearized reading' (duration: 177.39914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:31.408792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.313326ms","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-06-23T04:40:31.410312Z","caller":"traceutil/trace.go:171","msg":"trace[1241647960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5123; }","duration":"214.875135ms","start":"2026-06-23T04:40:31.195405Z","end":"2026-06-23T04:40:31.41028Z","steps":["trace[1241647960] 'agreement among raft nodes before linearized reading' (duration: 213.055461ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:31.408967Z","caller":"traceutil/trace.go:171","msg":"trace[1945214215] transaction","detail":"{read_only:false; response_revision:5121; number_of_response:1; }","duration":"414.952203ms","start":"2026-06-23T04:40:30.993964Z","end":"2026-06-23T04:40:31.408916Z","steps":["trace[1945214215] 'process raft request' (duration: 412.307594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:31.410645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:30.993922Z","time spent":"416.528962ms","remote":"127.0.0.1:40742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T04:40:31.408999Z","caller":"traceutil/trace.go:171","msg":"trace[1567139484] transaction","detail":"{read_only:false; response_revision:5122; number_of_response:1; }","duration":"193.435232ms","start":"2026-06-23T04:40:31.215557Z","end":"2026-06-23T04:40:31.408992Z","steps":["trace[1567139484] 'process raft request' (duration: 192.718378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:31.409054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.514193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af7129ff-419e-4370-bd8f-fcdd1fa49430\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-23T04:40:31.411286Z","caller":"traceutil/trace.go:171","msg":"trace[1662499720] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-af7129ff-419e-4370-bd8f-fcdd1fa49430; range_end:; response_count:1; response_revision:5123; }","duration":"332.797736ms","start":"2026-06-23T04:40:31.078477Z","end":"2026-06-23T04:40:31.411274Z","steps":["trace[1662499720] 'agreement among raft nodes before linearized reading' (duration: 330.478112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:31.411332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T04:40:31.078452Z","time spent":"332.855746ms","remote":"127.0.0.1:40664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-af7129ff-419e-4370-bd8f-fcdd1fa49430\" "} {"level":"warn","ts":"2026-06-23T04:40:31.409151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.186029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-23T04:40:31.411465Z","caller":"traceutil/trace.go:171","msg":"trace[368516336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5123; }","duration":"219.519563ms","start":"2026-06-23T04:40:31.191916Z","end":"2026-06-23T04:40:31.411435Z","steps":["trace[368516336] 'agreement among raft nodes before linearized reading' (duration: 217.168529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T04:40:44.379993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.160655ms","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-23T04:40:44.380101Z","caller":"traceutil/trace.go:171","msg":"trace[1261250375] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5283; }","duration":"112.316728ms","start":"2026-06-23T04:40:44.267755Z","end":"2026-06-23T04:40:44.380072Z","steps":["trace[1261250375] 'range keys from in-memory index tree' (duration: 111.983712ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:40:58.241019Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2899} {"level":"info","ts":"2026-06-23T04:40:58.326843Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2899,"took":"84.820342ms","hash":218233952,"current-db-size-bytes":53112832,"current-db-size":"53 MB","current-db-size-in-use-bytes":27803648,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-23T04:40:58.326932Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":218233952,"revision":2899,"compact-revision":-1} {"level":"info","ts":"2026-06-23T04:41:03.725146Z","caller":"traceutil/trace.go:171","msg":"trace[332784805] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"122.908261ms","start":"2026-06-23T04:41:03.602219Z","end":"2026-06-23T04:41:03.725127Z","steps":["trace[332784805] 'process raft request' (duration: 122.516244ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:03.725428Z","caller":"traceutil/trace.go:171","msg":"trace[574539728] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"121.72888ms","start":"2026-06-23T04:41:03.603677Z","end":"2026-06-23T04:41:03.725406Z","steps":["trace[574539728] 'process raft request' (duration: 121.16372ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:41:36.790759Z","caller":"traceutil/trace.go:171","msg":"trace[1162425056] transaction","detail":"{read_only:false; response_revision:5716; number_of_response:1; }","duration":"180.317048ms","start":"2026-06-23T04:41:36.610408Z","end":"2026-06-23T04:41:36.790725Z","steps":["trace[1162425056] 'process raft request' (duration: 180.057193ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T04:42:11.116064Z","caller":"traceutil/trace.go:171","msg":"trace[1802916263] transaction","detail":"{read_only:false; response_revision:5953; number_of_response:1; }","duration":"118.181454ms","start":"2026-06-23T04:42:10.99784Z","end":"2026-06-23T04:42:11.116021Z","steps":["trace[1802916263] 'process raft request' (duration: 101.39495ms)","trace[1802916263] 'compare' (duration: 16.598581ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T04:45:16.51571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.672479ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-23T04:45:58.249979Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5381} {"level":"info","ts":"2026-06-23T04:45:58.512633Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5381,"took":"260.649482ms","hash":1696504081,"current-db-size-bytes":53112832,"current-db-size":"53 MB","current-db-size-in-use-bytes":18923520,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-06-23T04:45:58.512709Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1696504081,"revision":5381,"compact-revision":2899} {"level":"info","ts":"2026-06-23T04:48:10.383971Z","caller":"traceutil/trace.go:171","msg":"trace[1249109538] transaction","detail":"{read_only:false; response_revision:8098; number_of_response:1; }","duration":"102.004075ms","start":"2026-06-23T04:48:10.281948Z","end":"2026-06-23T04:48:10.383952Z","steps":["trace[1249109538] 'process raft request' (duration: 101.839681ms)"],"step_count":1}