{"level":"warn","ts":"2026-09-22T01:58:09.545887Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-22T01:58:09.545971Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.54: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://162.253.55.54:2380","--initial-cluster=instance=https://162.253.55.54:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.54:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.54: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-09-22T01:58:09.546034Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-22T01:58:09.546044Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.54:2380"]} {"level":"info","ts":"2026-09-22T01:58:09.54606Z","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-09-22T01:58:09.546676Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"]} {"level":"info","ts":"2026-09-22T01:58:09.54675Z","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://162.253.55.54:2380"],"listen-peer-urls":["https://162.253.55.54:2380"],"advertise-client-urls":["https://162.253.55.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.54: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-09-22T01:58:09.551512Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.531149ms"} {"level":"info","ts":"2026-09-22T01:58:09.562735Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"353030364a385dbf","cluster-id":"1e619908a4cffd8f"} {"level":"info","ts":"2026-09-22T01:58:09.562842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T01:58:09.562897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became follower at term 0"} {"level":"info","ts":"2026-09-22T01:58:09.562934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 353030364a385dbf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T01:58:09.562959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became follower at term 1"} {"level":"info","ts":"2026-09-22T01:58:09.563021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=(3832616292623867327)"} {"level":"warn","ts":"2026-09-22T01:58:09.576191Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T01:58:09.581675Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T01:58:09.587338Z","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-09-22T01:58:09.5892Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"353030364a385dbf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T01:58:09.590727Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"353030364a385dbf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T01:58:09.591095Z","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-09-22T01:58:09.591863Z","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-09-22T01:58:09.591987Z","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-09-22T01:58:09.596704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=(3832616292623867327)"} {"level":"info","ts":"2026-09-22T01:58:09.596951Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1e619908a4cffd8f","local-member-id":"353030364a385dbf","added-peer-id":"353030364a385dbf","added-peer-peer-urls":["https://162.253.55.54:2380"]} {"level":"info","ts":"2026-09-22T01:58:09.598918Z","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-09-22T01:58:09.599067Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.54:2380"} {"level":"info","ts":"2026-09-22T01:58:09.5991Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.54:2380"} {"level":"info","ts":"2026-09-22T01:58:09.599272Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"353030364a385dbf","initial-advertise-peer-urls":["https://162.253.55.54:2380"],"listen-peer-urls":["https://162.253.55.54:2380"],"advertise-client-urls":["https://162.253.55.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T01:58:09.599342Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T01:58:09.664377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T01:58:09.66445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T01:58:09.664501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf received MsgPreVoteResp from 353030364a385dbf at term 1"} {"level":"info","ts":"2026-09-22T01:58:09.664523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became candidate at term 2"} {"level":"info","ts":"2026-09-22T01:58:09.66454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf received MsgVoteResp from 353030364a385dbf at term 2"} {"level":"info","ts":"2026-09-22T01:58:09.664557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became leader at term 2"} {"level":"info","ts":"2026-09-22T01:58:09.664572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 353030364a385dbf elected leader 353030364a385dbf at term 2"} {"level":"info","ts":"2026-09-22T01:58:09.666016Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"353030364a385dbf","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.54:2379]}","request-path":"/0/members/353030364a385dbf/attributes","cluster-id":"1e619908a4cffd8f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T01:58:09.666063Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:58:09.666082Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:58:09.666221Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:58:09.666509Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T01:58:09.666569Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T01:58:09.667344Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1e619908a4cffd8f","local-member-id":"353030364a385dbf","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:58:09.667538Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:58:09.667602Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:58:09.671937Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T01:58:09.674446Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.54:2379"} {"level":"info","ts":"2026-09-22T01:58:27.92791Z","caller":"traceutil/trace.go:171","msg":"trace[1670655307] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:429; }","duration":"235.699831ms","start":"2026-09-22T01:58:27.692183Z","end":"2026-09-22T01:58:27.927883Z","steps":["trace[1670655307] 'read index received' (duration: 235.454361ms)","trace[1670655307] 'applied index is now lower than readState.Index' (duration: 244.25µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:58:27.927971Z","caller":"traceutil/trace.go:171","msg":"trace[841190492] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"275.403703ms","start":"2026-09-22T01:58:27.65253Z","end":"2026-09-22T01:58:27.927934Z","steps":["trace[841190492] 'process raft request' (duration: 275.198433ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:27.928126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.888371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-22T01:58:27.928216Z","caller":"traceutil/trace.go:171","msg":"trace[245706426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:417; }","duration":"236.075711ms","start":"2026-09-22T01:58:27.692128Z","end":"2026-09-22T01:58:27.928204Z","steps":["trace[245706426] 'agreement among raft nodes before linearized reading' (duration: 235.895251ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:27.928236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.965043ms","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-09-22T01:58:27.928305Z","caller":"traceutil/trace.go:171","msg":"trace[131837407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:417; }","duration":"229.073233ms","start":"2026-09-22T01:58:27.699213Z","end":"2026-09-22T01:58:27.928287Z","steps":["trace[131837407] 'agreement among raft nodes before linearized reading' (duration: 228.911463ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:27.928314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.526634ms","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-09-22T01:58:27.928377Z","caller":"traceutil/trace.go:171","msg":"trace[139355599] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:417; }","duration":"222.605604ms","start":"2026-09-22T01:58:27.705752Z","end":"2026-09-22T01:58:27.928357Z","steps":["trace[139355599] 'agreement among raft nodes before linearized reading' (duration: 222.467154ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:28.324119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.152949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:58:28.324629Z","caller":"traceutil/trace.go:171","msg":"trace[30654144] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"392.248919ms","start":"2026-09-22T01:58:27.932337Z","end":"2026-09-22T01:58:28.324586Z","steps":["trace[30654144] 'process raft request' (duration: 194.65212ms)","trace[30654144] 'compare' (duration: 195.976779ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:28.324777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:27.932312Z","time spent":"392.382529ms","remote":"127.0.0.1:37450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:58:28.324912Z","caller":"traceutil/trace.go:171","msg":"trace[1889038373] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"390.98492ms","start":"2026-09-22T01:58:27.933885Z","end":"2026-09-22T01:58:28.324869Z","steps":["trace[1889038373] 'process raft request' (duration: 390.60179ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:28.324955Z","caller":"traceutil/trace.go:171","msg":"trace[185841520] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"390.92341ms","start":"2026-09-22T01:58:27.934008Z","end":"2026-09-22T01:58:28.324931Z","steps":["trace[185841520] 'process raft request' (duration: 390.56059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:28.325013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:27.933871Z","time spent":"391.09095ms","remote":"127.0.0.1:37450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:58:28.325101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.756789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:58:28.325173Z","caller":"traceutil/trace.go:171","msg":"trace[35479999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:420; }","duration":"297.866259ms","start":"2026-09-22T01:58:28.027288Z","end":"2026-09-22T01:58:28.325154Z","steps":["trace[35479999] 'agreement among raft nodes before linearized reading' (duration: 297.733649ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:28.324669Z","caller":"traceutil/trace.go:171","msg":"trace[2000500810] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:430; }","duration":"297.307959ms","start":"2026-09-22T01:58:28.027335Z","end":"2026-09-22T01:58:28.324643Z","steps":["trace[2000500810] 'read index received' (duration: 99.64598ms)","trace[2000500810] 'applied index is now lower than readState.Index' (duration: 197.660779ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:28.325644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:27.933983Z","time spent":"391.03087ms","remote":"127.0.0.1:37450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:58:50.396442Z","caller":"traceutil/trace.go:171","msg":"trace[304275854] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"217.591737ms","start":"2026-09-22T01:58:50.178828Z","end":"2026-09-22T01:58:50.39642Z","steps":["trace[304275854] 'process raft request' (duration: 217.439437ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.403719Z","caller":"traceutil/trace.go:171","msg":"trace[317612826] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"218.996936ms","start":"2026-09-22T01:58:50.184697Z","end":"2026-09-22T01:58:50.403694Z","steps":["trace[317612826] 'process raft request' (duration: 218.826126ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.40388Z","caller":"traceutil/trace.go:171","msg":"trace[1507443792] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"203.210699ms","start":"2026-09-22T01:58:50.200662Z","end":"2026-09-22T01:58:50.403873Z","steps":["trace[1507443792] 'process raft request' (duration: 203.063369ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.403762Z","caller":"traceutil/trace.go:171","msg":"trace[905943853] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"216.683236ms","start":"2026-09-22T01:58:50.187062Z","end":"2026-09-22T01:58:50.403745Z","steps":["trace[905943853] 'process raft request' (duration: 216.573236ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.403802Z","caller":"traceutil/trace.go:171","msg":"trace[1172025009] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"203.179679ms","start":"2026-09-22T01:58:50.200603Z","end":"2026-09-22T01:58:50.403783Z","steps":["trace[1172025009] 'process raft request' (duration: 203.078579ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.404106Z","caller":"traceutil/trace.go:171","msg":"trace[716154536] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"198.63866ms","start":"2026-09-22T01:58:50.205457Z","end":"2026-09-22T01:58:50.404095Z","steps":["trace[716154536] 'process raft request' (duration: 198.30465ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.40419Z","caller":"traceutil/trace.go:171","msg":"trace[1561924435] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"189.926462ms","start":"2026-09-22T01:58:50.214255Z","end":"2026-09-22T01:58:50.404181Z","steps":["trace[1561924435] 'process raft request' (duration: 189.741872ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.404476Z","caller":"traceutil/trace.go:171","msg":"trace[516046280] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"188.531702ms","start":"2026-09-22T01:58:50.215935Z","end":"2026-09-22T01:58:50.404467Z","steps":["trace[516046280] 'process raft request' (duration: 188.220442ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.404551Z","caller":"traceutil/trace.go:171","msg":"trace[1784529860] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"169.876516ms","start":"2026-09-22T01:58:50.234666Z","end":"2026-09-22T01:58:50.404543Z","steps":["trace[1784529860] 'process raft request' (duration: 169.744676ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.404677Z","caller":"traceutil/trace.go:171","msg":"trace[1226709847] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"148.96564ms","start":"2026-09-22T01:58:50.255701Z","end":"2026-09-22T01:58:50.404667Z","steps":["trace[1226709847] 'process raft request' (duration: 148.76161ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:50.404866Z","caller":"traceutil/trace.go:171","msg":"trace[483942395] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"136.512263ms","start":"2026-09-22T01:58:50.268316Z","end":"2026-09-22T01:58:50.404829Z","steps":["trace[483942395] 'process raft request' (duration: 136.266133ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:56.483195Z","caller":"traceutil/trace.go:171","msg":"trace[539650450] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"124.942715ms","start":"2026-09-22T01:58:56.358228Z","end":"2026-09-22T01:58:56.483171Z","steps":["trace[539650450] 'process raft request' (duration: 124.415605ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:58:57.127348Z","caller":"traceutil/trace.go:171","msg":"trace[1150010276] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"164.577958ms","start":"2026-09-22T01:58:56.962746Z","end":"2026-09-22T01:58:57.127324Z","steps":["trace[1150010276] 'process raft request' (duration: 164.110338ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:57.740153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.554976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:58:57.740228Z","caller":"traceutil/trace.go:171","msg":"trace[261090851] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"367.040066ms","start":"2026-09-22T01:58:57.373175Z","end":"2026-09-22T01:58:57.740215Z","steps":["trace[261090851] 'read index received' (duration: 148.40079ms)","trace[261090851] 'applied index is now lower than readState.Index' (duration: 218.638076ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:57.740325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.145556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tpsx6\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-22T01:58:57.740354Z","caller":"traceutil/trace.go:171","msg":"trace[1852186066] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tpsx6; range_end:; response_count:1; response_revision:645; }","duration":"367.209256ms","start":"2026-09-22T01:58:57.373137Z","end":"2026-09-22T01:58:57.740346Z","steps":["trace[1852186066] 'agreement among raft nodes before linearized reading' (duration: 367.112046ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:58:57.740385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:57.373118Z","time spent":"367.259996ms","remote":"127.0.0.1:37352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-tpsx6\" "} {"level":"info","ts":"2026-09-22T01:58:57.740576Z","caller":"traceutil/trace.go:171","msg":"trace[1930023929] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"535.342423ms","start":"2026-09-22T01:58:57.20522Z","end":"2026-09-22T01:58:57.740562Z","steps":["trace[1930023929] 'process raft request' (duration: 316.292957ms)","trace[1930023929] 'compare' (duration: 218.290086ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:58:57.74063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:58:57.20519Z","time spent":"535.415163ms","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T01:59:15.432515Z","caller":"traceutil/trace.go:171","msg":"trace[484590910] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"154.03193ms","start":"2026-09-22T01:59:15.278462Z","end":"2026-09-22T01:59:15.432494Z","steps":["trace[484590910] 'process raft request' (duration: 153.88449ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:59:46.789139Z","caller":"traceutil/trace.go:171","msg":"trace[670100971] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"172.207516ms","start":"2026-09-22T01:59:46.616906Z","end":"2026-09-22T01:59:46.789113Z","steps":["trace[670100971] 'process raft request' (duration: 171.710966ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:00:37.409358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.347777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-22T02:00:37.409483Z","caller":"traceutil/trace.go:171","msg":"trace[1008281838] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1884; }","duration":"116.535387ms","start":"2026-09-22T02:00:37.292924Z","end":"2026-09-22T02:00:37.40946Z","steps":["trace[1008281838] 'range keys from in-memory index tree' (duration: 116.140027ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:00:37.851459Z","caller":"traceutil/trace.go:171","msg":"trace[1642996265] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1955; }","duration":"178.534855ms","start":"2026-09-22T02:00:37.672896Z","end":"2026-09-22T02:00:37.851431Z","steps":["trace[1642996265] 'read index received' (duration: 178.227845ms)","trace[1642996265] 'applied index is now lower than readState.Index' (duration: 305.89µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:00:37.851613Z","caller":"traceutil/trace.go:171","msg":"trace[701351135] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"243.341963ms","start":"2026-09-22T02:00:37.608256Z","end":"2026-09-22T02:00:37.851598Z","steps":["trace[701351135] 'process raft request' (duration: 242.984233ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:00:37.851921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.013364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-22T02:00:37.851997Z","caller":"traceutil/trace.go:171","msg":"trace[2075261737] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1885; }","duration":"179.143184ms","start":"2026-09-22T02:00:37.672834Z","end":"2026-09-22T02:00:37.851977Z","steps":["trace[2075261737] 'agreement among raft nodes before linearized reading' (duration: 178.986885ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:00:37.970832Z","caller":"traceutil/trace.go:171","msg":"trace[126617016] linearizableReadLoop","detail":"{readStateIndex:1957; appliedIndex:1956; }","duration":"110.128769ms","start":"2026-09-22T02:00:37.860684Z","end":"2026-09-22T02:00:37.970813Z","steps":["trace[126617016] 'read index received' (duration: 65.585947ms)","trace[126617016] 'applied index is now lower than readState.Index' (duration: 44.540772ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:00:37.970831Z","caller":"traceutil/trace.go:171","msg":"trace[1719981852] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"114.377458ms","start":"2026-09-22T02:00:37.856419Z","end":"2026-09-22T02:00:37.970796Z","steps":["trace[1719981852] 'process raft request' (duration: 69.773066ms)","trace[1719981852] 'compare' (duration: 44.384282ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:00:37.971087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.392079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-22T02:00:37.971132Z","caller":"traceutil/trace.go:171","msg":"trace[2111356460] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1887; }","duration":"110.452159ms","start":"2026-09-22T02:00:37.860667Z","end":"2026-09-22T02:00:37.971119Z","steps":["trace[2111356460] 'agreement among raft nodes before linearized reading' (duration: 110.249549ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:00:38.132349Z","caller":"traceutil/trace.go:171","msg":"trace[1173606900] linearizableReadLoop","detail":"{readStateIndex:1960; appliedIndex:1959; }","duration":"106.181469ms","start":"2026-09-22T02:00:38.026142Z","end":"2026-09-22T02:00:38.132323Z","steps":["trace[1173606900] 'read index received' (duration: 82.132064ms)","trace[1173606900] 'applied index is now lower than readState.Index' (duration: 24.048265ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:00:38.132395Z","caller":"traceutil/trace.go:171","msg":"trace[729001652] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"154.35411ms","start":"2026-09-22T02:00:37.978014Z","end":"2026-09-22T02:00:38.132369Z","steps":["trace[729001652] 'process raft request' (duration: 130.321895ms)","trace[729001652] 'compare' (duration: 23.861795ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:00:38.132467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.303059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:00:38.132507Z","caller":"traceutil/trace.go:171","msg":"trace[509157254] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1889; }","duration":"106.396399ms","start":"2026-09-22T02:00:38.026101Z","end":"2026-09-22T02:00:38.132497Z","steps":["trace[509157254] 'agreement among raft nodes before linearized reading' (duration: 106.309249ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:00:53.308839Z","caller":"traceutil/trace.go:171","msg":"trace[1917653183] linearizableReadLoop","detail":"{readStateIndex:2094; appliedIndex:2093; }","duration":"105.570489ms","start":"2026-09-22T02:00:53.20323Z","end":"2026-09-22T02:00:53.3088Z","steps":["trace[1917653183] 'read index received' (duration: 105.327929ms)","trace[1917653183] 'applied index is now lower than readState.Index' (duration: 241.72µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:00:53.308877Z","caller":"traceutil/trace.go:171","msg":"trace[1334985180] transaction","detail":"{read_only:false; response_revision:2019; number_of_response:1; }","duration":"119.162497ms","start":"2026-09-22T02:00:53.189691Z","end":"2026-09-22T02:00:53.308853Z","steps":["trace[1334985180] 'process raft request' (duration: 118.964697ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:00:53.309033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.787059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.54\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-22T02:00:53.30907Z","caller":"traceutil/trace.go:171","msg":"trace[1138356676] range","detail":"{range_begin:/registry/masterleases/162.253.55.54; range_end:; response_count:1; response_revision:2019; }","duration":"105.874359ms","start":"2026-09-22T02:00:53.203187Z","end":"2026-09-22T02:00:53.309061Z","steps":["trace[1138356676] 'agreement among raft nodes before linearized reading' (duration: 105.749879ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:12.290458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.488143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-09-22T02:01:12.290551Z","caller":"traceutil/trace.go:171","msg":"trace[588240697] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2128; }","duration":"138.602363ms","start":"2026-09-22T02:01:12.151921Z","end":"2026-09-22T02:01:12.290523Z","steps":["trace[588240697] 'range keys from in-memory index tree' (duration: 138.268243ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:01:13.081401Z","caller":"traceutil/trace.go:171","msg":"trace[758916428] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2209; }","duration":"222.053157ms","start":"2026-09-22T02:01:12.859296Z","end":"2026-09-22T02:01:13.081349Z","steps":["trace[758916428] 'read index received' (duration: 178.524015ms)","trace[758916428] 'applied index is now lower than readState.Index' (duration: 43.528052ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:01:13.081504Z","caller":"traceutil/trace.go:171","msg":"trace[1992766798] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"232.863775ms","start":"2026-09-22T02:01:12.8486Z","end":"2026-09-22T02:01:13.081464Z","steps":["trace[1992766798] 'process raft request' (duration: 189.209183ms)","trace[1992766798] 'compare' (duration: 43.430062ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:01:13.081573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.255607ms","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-09-22T02:01:13.081929Z","caller":"traceutil/trace.go:171","msg":"trace[352605899] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:2131; }","duration":"222.660357ms","start":"2026-09-22T02:01:12.859245Z","end":"2026-09-22T02:01:13.081905Z","steps":["trace[352605899] 'agreement among raft nodes before linearized reading' (duration: 222.251647ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:01:13.314935Z","caller":"traceutil/trace.go:171","msg":"trace[378137141] linearizableReadLoop","detail":"{readStateIndex:2211; appliedIndex:2210; }","duration":"233.433644ms","start":"2026-09-22T02:01:13.081469Z","end":"2026-09-22T02:01:13.314902Z","steps":["trace[378137141] 'read index received' (duration: 142.501972ms)","trace[378137141] 'applied index is now lower than readState.Index' (duration: 90.930382ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:01:13.315093Z","caller":"traceutil/trace.go:171","msg":"trace[1616285968] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"400.468962ms","start":"2026-09-22T02:01:12.914585Z","end":"2026-09-22T02:01:13.315054Z","steps":["trace[1616285968] 'process raft request' (duration: 309.39035ms)","trace[1616285968] 'compare' (duration: 90.780863ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:01:13.315265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.676094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:01:13.315336Z","caller":"traceutil/trace.go:171","msg":"trace[890557764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2132; }","duration":"288.786554ms","start":"2026-09-22T02:01:13.026535Z","end":"2026-09-22T02:01:13.315321Z","steps":["trace[890557764] 'agreement among raft nodes before linearized reading' (duration: 288.604024ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:13.315615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.111515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T02:01:13.315663Z","caller":"traceutil/trace.go:171","msg":"trace[445124409] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2132; }","duration":"230.196965ms","start":"2026-09-22T02:01:13.085453Z","end":"2026-09-22T02:01:13.31565Z","steps":["trace[445124409] 'agreement among raft nodes before linearized reading' (duration: 230.121495ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:13.315941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.875847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-22T02:01:13.316027Z","caller":"traceutil/trace.go:171","msg":"trace[987450914] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2132; }","duration":"326.976437ms","start":"2026-09-22T02:01:12.989034Z","end":"2026-09-22T02:01:13.31601Z","steps":["trace[987450914] 'agreement among raft nodes before linearized reading' (duration: 326.809197ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:13.316108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.641378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.54\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-22T02:01:13.316148Z","caller":"traceutil/trace.go:171","msg":"trace[1891254907] range","detail":"{range_begin:/registry/masterleases/162.253.55.54; range_end:; response_count:1; response_revision:2132; }","duration":"111.786298ms","start":"2026-09-22T02:01:13.204352Z","end":"2026-09-22T02:01:13.316138Z","steps":["trace[1891254907] 'agreement among raft nodes before linearized reading' (duration: 111.631988ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:13.31534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:01:12.914569Z","time spent":"400.610812ms","remote":"127.0.0.1:37450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T02:01:13.316108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:01:12.989024Z","time spent":"327.048247ms","remote":"127.0.0.1:37450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-09-22T02:01:13.315651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.869472ms","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-09-22T02:01:13.316844Z","caller":"traceutil/trace.go:171","msg":"trace[1497015416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2132; }","duration":"451.088692ms","start":"2026-09-22T02:01:12.865734Z","end":"2026-09-22T02:01:13.316823Z","steps":["trace[1497015416] 'agreement among raft nodes before linearized reading' (duration: 449.707242ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:13.317002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:01:12.86571Z","time spent":"451.249002ms","remote":"127.0.0.1:37450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-22T02:01:13.538301Z","caller":"traceutil/trace.go:171","msg":"trace[461455454] linearizableReadLoop","detail":"{readStateIndex:2215; appliedIndex:2212; }","duration":"138.340373ms","start":"2026-09-22T02:01:13.399935Z","end":"2026-09-22T02:01:13.538276Z","steps":["trace[461455454] 'read index received' (duration: 114.812488ms)","trace[461455454] 'applied index is now lower than readState.Index' (duration: 23.526855ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:01:13.538293Z","caller":"traceutil/trace.go:171","msg":"trace[1240146471] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"218.424268ms","start":"2026-09-22T02:01:13.319812Z","end":"2026-09-22T02:01:13.538237Z","steps":["trace[1240146471] 'process raft request' (duration: 194.853103ms)","trace[1240146471] 'compare' (duration: 23.223625ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:01:13.538372Z","caller":"traceutil/trace.go:171","msg":"trace[1141010124] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"218.160168ms","start":"2026-09-22T02:01:13.320165Z","end":"2026-09-22T02:01:13.538326Z","steps":["trace[1141010124] 'process raft request' (duration: 217.997958ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:01:13.538428Z","caller":"traceutil/trace.go:171","msg":"trace[1782867175] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"211.147409ms","start":"2026-09-22T02:01:13.327255Z","end":"2026-09-22T02:01:13.538402Z","steps":["trace[1782867175] 'process raft request' (duration: 210.970849ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:13.538868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.825934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-22T02:01:13.538934Z","caller":"traceutil/trace.go:171","msg":"trace[1894111027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2135; }","duration":"133.951164ms","start":"2026-09-22T02:01:13.404967Z","end":"2026-09-22T02:01:13.538918Z","steps":["trace[1894111027] 'agreement among raft nodes before linearized reading' (duration: 133.788014ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:13.539103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.115563ms","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-09-22T02:01:13.53916Z","caller":"traceutil/trace.go:171","msg":"trace[1787721960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2135; }","duration":"139.268133ms","start":"2026-09-22T02:01:13.39988Z","end":"2026-09-22T02:01:13.539148Z","steps":["trace[1787721960] 'agreement among raft nodes before linearized reading' (duration: 138.570063ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:01:13.53948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.412084ms","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-09-22T02:01:13.539601Z","caller":"traceutil/trace.go:171","msg":"trace[390404264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2135; }","duration":"135.167184ms","start":"2026-09-22T02:01:13.404415Z","end":"2026-09-22T02:01:13.539583Z","steps":["trace[390404264] 'agreement among raft nodes before linearized reading' (duration: 134.327024ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:26.061144Z","caller":"traceutil/trace.go:171","msg":"trace[1281706871] linearizableReadLoop","detail":"{readStateIndex:2725; appliedIndex:2723; }","duration":"123.493228ms","start":"2026-09-22T02:02:25.937622Z","end":"2026-09-22T02:02:26.061116Z","steps":["trace[1281706871] 'read index received' (duration: 24.963038ms)","trace[1281706871] 'applied index is now lower than readState.Index' (duration: 98.52865ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:02:26.061442Z","caller":"traceutil/trace.go:171","msg":"trace[2021944919] transaction","detail":"{read_only:false; response_revision:2628; number_of_response:1; }","duration":"124.340204ms","start":"2026-09-22T02:02:25.937088Z","end":"2026-09-22T02:02:26.061428Z","steps":["trace[2021944919] 'process raft request' (duration: 123.326545ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:26.06175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.114706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-22T02:02:26.061788Z","caller":"traceutil/trace.go:171","msg":"trace[1335654932] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2628; }","duration":"124.214784ms","start":"2026-09-22T02:02:25.937562Z","end":"2026-09-22T02:02:26.061777Z","steps":["trace[1335654932] 'agreement among raft nodes before linearized reading' (duration: 124.062342ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:26.061999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.432876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-22T02:02:26.062032Z","caller":"traceutil/trace.go:171","msg":"trace[1256599208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2628; }","duration":"121.509341ms","start":"2026-09-22T02:02:25.940514Z","end":"2026-09-22T02:02:26.062023Z","steps":["trace[1256599208] 'agreement among raft nodes before linearized reading' (duration: 121.403073ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:02:26.062571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.657722ms","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-09-22T02:02:26.06268Z","caller":"traceutil/trace.go:171","msg":"trace[1998023498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2628; }","duration":"115.798554ms","start":"2026-09-22T02:02:25.946859Z","end":"2026-09-22T02:02:26.062657Z","steps":["trace[1998023498] 'agreement among raft nodes before linearized reading' (duration: 115.551324ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:26.515788Z","caller":"traceutil/trace.go:171","msg":"trace[1618932592] linearizableReadLoop","detail":"{readStateIndex:2729; appliedIndex:2728; }","duration":"121.702442ms","start":"2026-09-22T02:02:26.394052Z","end":"2026-09-22T02:02:26.515755Z","steps":["trace[1618932592] 'read index received' (duration: 121.54782ms)","trace[1618932592] 'applied index is now lower than readState.Index' (duration: 153.652µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:02:26.515921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.846023ms","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-09-22T02:02:26.515954Z","caller":"traceutil/trace.go:171","msg":"trace[213084416] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2632; }","duration":"121.977754ms","start":"2026-09-22T02:02:26.393966Z","end":"2026-09-22T02:02:26.515944Z","steps":["trace[213084416] 'agreement among raft nodes before linearized reading' (duration: 121.889597ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:02:26.516038Z","caller":"traceutil/trace.go:171","msg":"trace[895747547] transaction","detail":"{read_only:false; response_revision:2632; number_of_response:1; }","duration":"234.202678ms","start":"2026-09-22T02:02:26.281779Z","end":"2026-09-22T02:02:26.515982Z","steps":["trace[895747547] 'process raft request' (duration: 233.817288ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:19.97678Z","caller":"traceutil/trace.go:171","msg":"trace[304164673] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"182.481551ms","start":"2026-09-22T02:07:19.794275Z","end":"2026-09-22T02:07:19.976757Z","steps":["trace[304164673] 'process raft request' (duration: 182.276198ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:19.976957Z","caller":"traceutil/trace.go:171","msg":"trace[2096391925] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"181.428254ms","start":"2026-09-22T02:07:19.795519Z","end":"2026-09-22T02:07:19.976947Z","steps":["trace[2096391925] 'process raft request' (duration: 181.14612ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:19.977076Z","caller":"traceutil/trace.go:171","msg":"trace[59682826] linearizableReadLoop","detail":"{readStateIndex:4969; appliedIndex:4968; }","duration":"182.139426ms","start":"2026-09-22T02:07:19.794926Z","end":"2026-09-22T02:07:19.977065Z","steps":["trace[59682826] 'read index received' (duration: 90.429854ms)","trace[59682826] 'applied index is now lower than readState.Index' (duration: 91.708562ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:07:19.97716Z","caller":"traceutil/trace.go:171","msg":"trace[1264028356] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"115.952812ms","start":"2026-09-22T02:07:19.861199Z","end":"2026-09-22T02:07:19.977152Z","steps":["trace[1264028356] 'process raft request' (duration: 115.510435ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:07:19.977493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.553603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-22T02:07:19.977577Z","caller":"traceutil/trace.go:171","msg":"trace[880863086] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4788; }","duration":"182.653134ms","start":"2026-09-22T02:07:19.7949Z","end":"2026-09-22T02:07:19.977553Z","steps":["trace[880863086] 'agreement among raft nodes before linearized reading' (duration: 182.470511ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:07:19.9776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.226025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0.18d7827a5c0c5d54\" ","response":"range_response_count:1 size:1203"} {"level":"info","ts":"2026-09-22T02:07:19.977639Z","caller":"traceutil/trace.go:171","msg":"trace[678731421] range","detail":"{range_begin:/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0.18d7827a5c0c5d54; range_end:; response_count:1; response_revision:4788; }","duration":"155.278176ms","start":"2026-09-22T02:07:19.822347Z","end":"2026-09-22T02:07:19.977625Z","steps":["trace[678731421] 'agreement among raft nodes before linearized reading' (duration: 155.192715ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:07:19.977485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.122719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-09-22T02:07:19.977686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.874213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-421d5d05-2617-4e76-bbfe-ce7df1c4a3c8\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-09-22T02:07:19.977751Z","caller":"traceutil/trace.go:171","msg":"trace[1238944852] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4788; }","duration":"163.409243ms","start":"2026-09-22T02:07:19.814306Z","end":"2026-09-22T02:07:19.977715Z","steps":["trace[1238944852] 'agreement among raft nodes before linearized reading' (duration: 163.014827ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:19.977783Z","caller":"traceutil/trace.go:171","msg":"trace[1945100947] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-421d5d05-2617-4e76-bbfe-ce7df1c4a3c8; range_end:; response_count:1; response_revision:4788; }","duration":"129.007715ms","start":"2026-09-22T02:07:19.848754Z","end":"2026-09-22T02:07:19.977762Z","steps":["trace[1945100947] 'agreement among raft nodes before linearized reading' (duration: 128.752651ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:22.093219Z","caller":"traceutil/trace.go:171","msg":"trace[1869021789] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"105.057345ms","start":"2026-09-22T02:07:21.988118Z","end":"2026-09-22T02:07:22.093175Z","steps":["trace[1869021789] 'process raft request' (duration: 86.61238ms)","trace[1869021789] 'compare' (duration: 18.066859ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:07:24.330938Z","caller":"traceutil/trace.go:171","msg":"trace[844098749] linearizableReadLoop","detail":"{readStateIndex:5078; appliedIndex:5077; }","duration":"146.810464ms","start":"2026-09-22T02:07:24.184098Z","end":"2026-09-22T02:07:24.330908Z","steps":["trace[844098749] 'read index received' (duration: 146.479369ms)","trace[844098749] 'applied index is now lower than readState.Index' (duration: 329.795µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:07:24.331081Z","caller":"traceutil/trace.go:171","msg":"trace[553350098] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"156.29939ms","start":"2026-09-22T02:07:24.174738Z","end":"2026-09-22T02:07:24.331037Z","steps":["trace[553350098] 'process raft request' (duration: 155.929505ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:07:24.331213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.181691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-09-22T02:07:24.331256Z","caller":"traceutil/trace.go:171","msg":"trace[1471736880] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4892; }","duration":"147.332923ms","start":"2026-09-22T02:07:24.183911Z","end":"2026-09-22T02:07:24.331244Z","steps":["trace[1471736880] 'agreement among raft nodes before linearized reading' (duration: 147.14424ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:30.763418Z","caller":"traceutil/trace.go:171","msg":"trace[1912231] linearizableReadLoop","detail":"{readStateIndex:5196; appliedIndex:5195; }","duration":"373.318479ms","start":"2026-09-22T02:07:30.390067Z","end":"2026-09-22T02:07:30.763386Z","steps":["trace[1912231] 'read index received' (duration: 373.203087ms)","trace[1912231] 'applied index is now lower than readState.Index' (duration: 114.472µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:07:30.763523Z","caller":"traceutil/trace.go:171","msg":"trace[45210784] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"393.39655ms","start":"2026-09-22T02:07:30.370106Z","end":"2026-09-22T02:07:30.763502Z","steps":["trace[45210784] 'process raft request' (duration: 393.127406ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:07:30.763789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:07:30.370091Z","time spent":"393.522343ms","remote":"127.0.0.1:37246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T02:07:30.763841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.657614ms","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-09-22T02:07:30.763931Z","caller":"traceutil/trace.go:171","msg":"trace[148753276] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5008; }","duration":"373.876617ms","start":"2026-09-22T02:07:30.390014Z","end":"2026-09-22T02:07:30.763891Z","steps":["trace[148753276] 'agreement among raft nodes before linearized reading' (duration: 373.538252ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:07:30.763977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T02:07:30.389986Z","time spent":"373.975728ms","remote":"127.0.0.1:37450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-09-22T02:07:30.777577Z","caller":"traceutil/trace.go:171","msg":"trace[441861605] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"140.332372ms","start":"2026-09-22T02:07:30.637213Z","end":"2026-09-22T02:07:30.777545Z","steps":["trace[441861605] 'process raft request' (duration: 140.138239ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:31.14567Z","caller":"traceutil/trace.go:171","msg":"trace[1360928829] linearizableReadLoop","detail":"{readStateIndex:5201; appliedIndex:5200; }","duration":"120.095502ms","start":"2026-09-22T02:07:31.025546Z","end":"2026-09-22T02:07:31.145642Z","steps":["trace[1360928829] 'read index received' (duration: 119.872278ms)","trace[1360928829] 'applied index is now lower than readState.Index' (duration: 222.334µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:07:31.145701Z","caller":"traceutil/trace.go:171","msg":"trace[329412994] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"167.557635ms","start":"2026-09-22T02:07:30.978113Z","end":"2026-09-22T02:07:31.145671Z","steps":["trace[329412994] 'process raft request' (duration: 167.363552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:07:31.146021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.142832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T02:07:31.146002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.443876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-22T02:07:31.146084Z","caller":"traceutil/trace.go:171","msg":"trace[124193747] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5013; }","duration":"120.277624ms","start":"2026-09-22T02:07:31.025794Z","end":"2026-09-22T02:07:31.146071Z","steps":["trace[124193747] 'agreement among raft nodes before linearized reading' (duration: 120.169042ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:31.146102Z","caller":"traceutil/trace.go:171","msg":"trace[969654692] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5013; }","duration":"120.613149ms","start":"2026-09-22T02:07:31.025466Z","end":"2026-09-22T02:07:31.146079Z","steps":["trace[969654692] 'agreement among raft nodes before linearized reading' (duration: 120.277764ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:31.271634Z","caller":"traceutil/trace.go:171","msg":"trace[380120977] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"117.101147ms","start":"2026-09-22T02:07:31.154494Z","end":"2026-09-22T02:07:31.271595Z","steps":["trace[380120977] 'process raft request' (duration: 91.160677ms)","trace[380120977] 'compare' (duration: 25.809208ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:07:31.292942Z","caller":"traceutil/trace.go:171","msg":"trace[853467395] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"131.454072ms","start":"2026-09-22T02:07:31.161428Z","end":"2026-09-22T02:07:31.292882Z","steps":["trace[853467395] 'process raft request' (duration: 131.401931ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:31.293395Z","caller":"traceutil/trace.go:171","msg":"trace[999174661] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"132.913503ms","start":"2026-09-22T02:07:31.16047Z","end":"2026-09-22T02:07:31.293383Z","steps":["trace[999174661] 'process raft request' (duration: 132.03691ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:31.293605Z","caller":"traceutil/trace.go:171","msg":"trace[179359639] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"132.976415ms","start":"2026-09-22T02:07:31.160619Z","end":"2026-09-22T02:07:31.293595Z","steps":["trace[179359639] 'process raft request' (duration: 132.123612ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:39.689503Z","caller":"traceutil/trace.go:171","msg":"trace[1386585573] transaction","detail":"{read_only:false; response_revision:5152; number_of_response:1; }","duration":"122.636012ms","start":"2026-09-22T02:07:39.566829Z","end":"2026-09-22T02:07:39.689465Z","steps":["trace[1386585573] 'process raft request' (duration: 120.193637ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:44.010378Z","caller":"traceutil/trace.go:171","msg":"trace[290401475] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"295.078828ms","start":"2026-09-22T02:07:43.715243Z","end":"2026-09-22T02:07:44.010322Z","steps":["trace[290401475] 'process raft request' (duration: 294.877955ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:44.01122Z","caller":"traceutil/trace.go:171","msg":"trace[1120208116] linearizableReadLoop","detail":"{readStateIndex:5373; appliedIndex:5371; }","duration":"231.378939ms","start":"2026-09-22T02:07:43.779826Z","end":"2026-09-22T02:07:44.011205Z","steps":["trace[1120208116] 'read index received' (duration: 230.339694ms)","trace[1120208116] 'applied index is now lower than readState.Index' (duration: 1.036375ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:07:44.011499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.667543ms","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-09-22T02:07:44.011541Z","caller":"traceutil/trace.go:171","msg":"trace[720691049] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5180; }","duration":"231.781004ms","start":"2026-09-22T02:07:43.779749Z","end":"2026-09-22T02:07:44.01153Z","steps":["trace[720691049] 'agreement among raft nodes before linearized reading' (duration: 231.51314ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:44.011536Z","caller":"traceutil/trace.go:171","msg":"trace[1186876520] transaction","detail":"{read_only:false; response_revision:5179; number_of_response:1; }","duration":"282.505197ms","start":"2026-09-22T02:07:43.728983Z","end":"2026-09-22T02:07:44.011488Z","steps":["trace[1186876520] 'process raft request' (duration: 282.114211ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:07:44.011677Z","caller":"traceutil/trace.go:171","msg":"trace[1179991114] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"200.906509ms","start":"2026-09-22T02:07:43.81074Z","end":"2026-09-22T02:07:44.011647Z","steps":["trace[1179991114] 'process raft request' (duration: 200.427082ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:08:09.953841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2867} {"level":"info","ts":"2026-09-22T02:08:10.0487Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2867,"took":"93.525318ms","hash":4257730542,"current-db-size-bytes":52219904,"current-db-size":"52 MB","current-db-size-in-use-bytes":27672576,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-22T02:08:10.048799Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4257730542,"revision":2867,"compact-revision":-1} {"level":"info","ts":"2026-09-22T02:08:28.429273Z","caller":"traceutil/trace.go:171","msg":"trace[2098306951] transaction","detail":"{read_only:false; response_revision:5578; number_of_response:1; }","duration":"108.022983ms","start":"2026-09-22T02:08:28.321219Z","end":"2026-09-22T02:08:28.429242Z","steps":["trace[2098306951] 'process raft request' (duration: 66.462845ms)","trace[2098306951] 'compare' (duration: 41.204794ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:08:30.276318Z","caller":"traceutil/trace.go:171","msg":"trace[1729239392] transaction","detail":"{read_only:false; response_revision:5584; number_of_response:1; }","duration":"156.345808ms","start":"2026-09-22T02:08:30.119949Z","end":"2026-09-22T02:08:30.276295Z","steps":["trace[1729239392] 'process raft request' (duration: 156.207327ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:08:30.417658Z","caller":"traceutil/trace.go:171","msg":"trace[12142206] linearizableReadLoop","detail":"{readStateIndex:5791; appliedIndex:5789; }","duration":"179.307729ms","start":"2026-09-22T02:08:30.238321Z","end":"2026-09-22T02:08:30.417629Z","steps":["trace[12142206] 'read index received' (duration: 37.92978ms)","trace[12142206] 'applied index is now lower than readState.Index' (duration: 141.376929ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T02:08:30.417751Z","caller":"traceutil/trace.go:171","msg":"trace[1528115458] transaction","detail":"{read_only:false; response_revision:5585; number_of_response:1; }","duration":"205.598152ms","start":"2026-09-22T02:08:30.212108Z","end":"2026-09-22T02:08:30.417707Z","steps":["trace[1528115458] 'process raft request' (duration: 158.83084ms)","trace[1528115458] 'compare' (duration: 46.512909ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T02:08:30.417874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.544072ms","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-09-22T02:08:30.417923Z","caller":"traceutil/trace.go:171","msg":"trace[1118745042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5585; }","duration":"179.653424ms","start":"2026-09-22T02:08:30.238256Z","end":"2026-09-22T02:08:30.41791Z","steps":["trace[1118745042] 'agreement among raft nodes before linearized reading' (duration: 179.465771ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T02:08:30.417978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.074456ms","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-09-22T02:08:30.418017Z","caller":"traceutil/trace.go:171","msg":"trace[1146098384] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5585; }","duration":"100.163188ms","start":"2026-09-22T02:08:30.317842Z","end":"2026-09-22T02:08:30.418005Z","steps":["trace[1146098384] 'agreement among raft nodes before linearized reading' (duration: 99.941785ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:08:30.598652Z","caller":"traceutil/trace.go:171","msg":"trace[395121560] transaction","detail":"{read_only:false; response_revision:5589; number_of_response:1; }","duration":"113.588807ms","start":"2026-09-22T02:08:30.485034Z","end":"2026-09-22T02:08:30.598623Z","steps":["trace[395121560] 'process raft request' (duration: 113.243053ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:08:30.598772Z","caller":"traceutil/trace.go:171","msg":"trace[134836352] transaction","detail":"{read_only:false; response_revision:5590; number_of_response:1; }","duration":"110.441408ms","start":"2026-09-22T02:08:30.488275Z","end":"2026-09-22T02:08:30.598716Z","steps":["trace[134836352] 'process raft request' (duration: 110.287986ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:08:31.132837Z","caller":"traceutil/trace.go:171","msg":"trace[1520229651] transaction","detail":"{read_only:false; response_revision:5591; number_of_response:1; }","duration":"101.350929ms","start":"2026-09-22T02:08:31.031465Z","end":"2026-09-22T02:08:31.132816Z","steps":["trace[1520229651] 'process raft request' (duration: 101.220738ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T02:13:09.960924Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5354} {"level":"info","ts":"2026-09-22T02:13:10.040801Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5354,"took":"78.277608ms","hash":3828807198,"current-db-size-bytes":52219904,"current-db-size":"52 MB","current-db-size-in-use-bytes":18784256,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-22T02:13:10.04087Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3828807198,"revision":5354,"compact-revision":2867}