{"level":"warn","ts":"2026-03-02T02:05:56.47901Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-02T02:05:56.479121Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.43: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.43:2380","--initial-cluster=instance=https://162.253.55.43:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.43:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.43: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-03-02T02:05:56.479223Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-02T02:05:56.47924Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-03-02T02:05:56.479267Z","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-03-02T02:05:56.480119Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"]} {"level":"info","ts":"2026-03-02T02:05:56.480222Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.43: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-03-02T02:05:56.487937Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.885235ms"} {"level":"info","ts":"2026-03-02T02:05:56.505182Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"14f8f2dfdaccebdb","cluster-id":"5f02ccb15672f35d"} {"level":"info","ts":"2026-03-02T02:05:56.505366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=()"} {"level":"info","ts":"2026-03-02T02:05:56.505488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 0"} {"level":"info","ts":"2026-03-02T02:05:56.505588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 14f8f2dfdaccebdb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-02T02:05:56.505622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became follower at term 1"} {"level":"info","ts":"2026-03-02T02:05:56.505933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"warn","ts":"2026-03-02T02:05:56.513504Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-02T02:05:56.514964Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-02T02:05:56.516742Z","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-03-02T02:05:56.520586Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"14f8f2dfdaccebdb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-02T02:05:56.520816Z","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-03-02T02:05:56.520937Z","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-03-02T02:05:56.520963Z","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-03-02T02:05:56.521019Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"14f8f2dfdaccebdb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-02T02:05:56.52178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb switched to configuration voters=(1511224718245293019)"} {"level":"info","ts":"2026-03-02T02:05:56.521938Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","added-peer-id":"14f8f2dfdaccebdb","added-peer-peer-urls":["https://162.253.55.43:2380"]} {"level":"info","ts":"2026-03-02T02:05:56.523517Z","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-03-02T02:05:56.523678Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-03-02T02:05:56.523767Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.43:2380"} {"level":"info","ts":"2026-03-02T02:05:56.523838Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"14f8f2dfdaccebdb","initial-advertise-peer-urls":["https://162.253.55.43:2380"],"listen-peer-urls":["https://162.253.55.43:2380"],"advertise-client-urls":["https://162.253.55.43:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.43:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-02T02:05:56.523908Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-02T02:05:57.30695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb is starting a new election at term 1"} {"level":"info","ts":"2026-03-02T02:05:57.307051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became pre-candidate at term 1"} {"level":"info","ts":"2026-03-02T02:05:57.307094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgPreVoteResp from 14f8f2dfdaccebdb at term 1"} {"level":"info","ts":"2026-03-02T02:05:57.307114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became candidate at term 2"} {"level":"info","ts":"2026-03-02T02:05:57.307126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb received MsgVoteResp from 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-03-02T02:05:57.307143Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"14f8f2dfdaccebdb became leader at term 2"} {"level":"info","ts":"2026-03-02T02:05:57.307163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 14f8f2dfdaccebdb elected leader 14f8f2dfdaccebdb at term 2"} {"level":"info","ts":"2026-03-02T02:05:57.308164Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-02T02:05:57.309092Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"14f8f2dfdaccebdb","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.43:2379]}","request-path":"/0/members/14f8f2dfdaccebdb/attributes","cluster-id":"5f02ccb15672f35d","publish-timeout":"7s"} {"level":"info","ts":"2026-03-02T02:05:57.309104Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-02T02:05:57.309184Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-02T02:05:57.309903Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5f02ccb15672f35d","local-member-id":"14f8f2dfdaccebdb","cluster-version":"3.5"} {"level":"info","ts":"2026-03-02T02:05:57.310185Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-02T02:05:57.310137Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-02T02:05:57.31024Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-02T02:05:57.310248Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-02T02:05:57.315985Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-02T02:05:57.316481Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.43:2379"} {"level":"warn","ts":"2026-03-02T02:05:59.411558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.635257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3494"} {"level":"info","ts":"2026-03-02T02:05:59.41176Z","caller":"traceutil/trace.go:171","msg":"trace[392156776] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:69; }","duration":"390.902533ms","start":"2026-03-02T02:05:59.020832Z","end":"2026-03-02T02:05:59.411735Z","steps":["trace[392156776] 'range keys from in-memory index tree' (duration: 390.502974ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:05:59.411857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:05:59.020819Z","time spent":"391.023916ms","remote":"127.0.0.1:35838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3516,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-03-02T02:06:08.666753Z","caller":"traceutil/trace.go:171","msg":"trace[138690530] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:362; }","duration":"122.823075ms","start":"2026-03-02T02:06:08.543905Z","end":"2026-03-02T02:06:08.666728Z","steps":["trace[138690530] 'read index received' (duration: 122.59425ms)","trace[138690530] 'applied index is now lower than readState.Index' (duration: 227.915µs)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:06:08.666849Z","caller":"traceutil/trace.go:171","msg":"trace[133530498] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"129.426595ms","start":"2026-03-02T02:06:08.537394Z","end":"2026-03-02T02:06:08.666821Z","steps":["trace[133530498] 'process raft request' (duration: 129.187059ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:06:08.666935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.00671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-gwsbt\" ","response":"range_response_count:1 size:4462"} {"level":"info","ts":"2026-03-02T02:06:08.666992Z","caller":"traceutil/trace.go:171","msg":"trace[1573994411] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-gwsbt; range_end:; response_count:1; response_revision:348; }","duration":"123.111262ms","start":"2026-03-02T02:06:08.543862Z","end":"2026-03-02T02:06:08.666973Z","steps":["trace[1573994411] 'agreement among raft nodes before linearized reading' (duration: 122.987409ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:06:08.887786Z","caller":"traceutil/trace.go:171","msg":"trace[832289636] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"213.16778ms","start":"2026-03-02T02:06:08.67459Z","end":"2026-03-02T02:06:08.887758Z","steps":["trace[832289636] 'process raft request' (duration: 212.954765ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:06:09.021748Z","caller":"traceutil/trace.go:171","msg":"trace[338071464] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"125.937985ms","start":"2026-03-02T02:06:08.895789Z","end":"2026-03-02T02:06:09.021727Z","steps":["trace[338071464] 'process raft request' (duration: 125.809722ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:06:33.467456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.931239ms","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-03-02T02:06:33.467557Z","caller":"traceutil/trace.go:171","msg":"trace[26820513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:503; }","duration":"103.078832ms","start":"2026-03-02T02:06:33.364459Z","end":"2026-03-02T02:06:33.467538Z","steps":["trace[26820513] 'range keys from in-memory index tree' (duration: 102.779345ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:06:33.971409Z","caller":"traceutil/trace.go:171","msg":"trace[306499082] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"355.419904ms","start":"2026-03-02T02:06:33.61596Z","end":"2026-03-02T02:06:33.97138Z","steps":["trace[306499082] 'process raft request' (duration: 355.177699ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:06:33.972215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:06:33.61594Z","time spent":"355.552857ms","remote":"127.0.0.1:35926","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-03-02T02:06:34.247272Z","caller":"traceutil/trace.go:171","msg":"trace[137731365] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:525; }","duration":"530.925025ms","start":"2026-03-02T02:06:33.716325Z","end":"2026-03-02T02:06:34.24725Z","steps":["trace[137731365] 'read index received' (duration: 254.816658ms)","trace[137731365] 'applied index is now lower than readState.Index' (duration: 276.107167ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:06:34.247392Z","caller":"traceutil/trace.go:171","msg":"trace[1577846755] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"623.353427ms","start":"2026-03-02T02:06:33.623968Z","end":"2026-03-02T02:06:34.247321Z","steps":["trace[1577846755] 'process raft request' (duration: 588.073333ms)","trace[1577846755] 'compare' (duration: 35.11232ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:06:34.247444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.747218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T02:06:34.247517Z","caller":"traceutil/trace.go:171","msg":"trace[1801920215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:506; }","duration":"453.848051ms","start":"2026-03-02T02:06:33.793649Z","end":"2026-03-02T02:06:34.247497Z","steps":["trace[1801920215] 'agreement among raft nodes before linearized reading' (duration: 453.737088ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:06:34.247423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.071068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-02T02:06:34.247603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:06:33.793639Z","time spent":"453.946723ms","remote":"127.0.0.1:35670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-02T02:06:34.247633Z","caller":"traceutil/trace.go:171","msg":"trace[822005098] range","detail":"{range_begin:/registry/secrets/cert-manager/; range_end:/registry/secrets/cert-manager0; response_count:0; response_revision:506; }","duration":"531.323974ms","start":"2026-03-02T02:06:33.716296Z","end":"2026-03-02T02:06:34.24762Z","steps":["trace[822005098] 'agreement among raft nodes before linearized reading' (duration: 531.022998ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:06:34.247619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:06:33.623941Z","time spent":"623.561492ms","remote":"127.0.0.1:35840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T02:06:34.247659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:06:33.716281Z","time spent":"531.370545ms","remote":"127.0.0.1:35776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/cert-manager/\" range_end:\"/registry/secrets/cert-manager0\" "} {"level":"info","ts":"2026-03-02T02:06:53.193286Z","caller":"traceutil/trace.go:171","msg":"trace[19106776] linearizableReadLoop","detail":"{readStateIndex:905; appliedIndex:904; }","duration":"261.799389ms","start":"2026-03-02T02:06:52.931461Z","end":"2026-03-02T02:06:53.19326Z","steps":["trace[19106776] 'read index received' (duration: 261.671427ms)","trace[19106776] 'applied index is now lower than readState.Index' (duration: 126.622µs)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:06:53.193342Z","caller":"traceutil/trace.go:171","msg":"trace[1481411714] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"408.126981ms","start":"2026-03-02T02:06:52.78517Z","end":"2026-03-02T02:06:53.193296Z","steps":["trace[1481411714] 'process raft request' (duration: 407.922147ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:06:53.193613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:06:52.785146Z","time spent":"408.368947ms","remote":"127.0.0.1:36106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4734,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T02:06:53.193613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.118306ms","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-03-02T02:06:53.194104Z","caller":"traceutil/trace.go:171","msg":"trace[29174418] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:879; }","duration":"262.672119ms","start":"2026-03-02T02:06:52.931412Z","end":"2026-03-02T02:06:53.194084Z","steps":["trace[29174418] 'agreement among raft nodes before linearized reading' (duration: 262.005214ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:07:40.069749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.339207ms","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-03-02T02:07:40.069952Z","caller":"traceutil/trace.go:171","msg":"trace[1999687910] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1527; }","duration":"254.596343ms","start":"2026-03-02T02:07:39.815334Z","end":"2026-03-02T02:07:40.06993Z","steps":["trace[1999687910] 'range keys from in-memory index tree' (duration: 254.073341ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:07:40.070266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.812211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d167a1b8-aad2-4fc9-bbf0-24a2bf12c0fa\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-03-02T02:07:40.070332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.306485ms","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-03-02T02:07:40.070399Z","caller":"traceutil/trace.go:171","msg":"trace[1156043670] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d167a1b8-aad2-4fc9-bbf0-24a2bf12c0fa; range_end:; response_count:1; response_revision:1527; }","duration":"367.012155ms","start":"2026-03-02T02:07:39.703357Z","end":"2026-03-02T02:07:40.070369Z","steps":["trace[1156043670] 'range keys from in-memory index tree' (duration: 366.437142ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:07:40.070466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:07:39.703319Z","time spent":"367.134818ms","remote":"127.0.0.1:35840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d167a1b8-aad2-4fc9-bbf0-24a2bf12c0fa\" "} {"level":"info","ts":"2026-03-02T02:07:40.070473Z","caller":"traceutil/trace.go:171","msg":"trace[1175861319] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1527; }","duration":"253.545611ms","start":"2026-03-02T02:07:39.816895Z","end":"2026-03-02T02:07:40.07044Z","steps":["trace[1175861319] 'range keys from in-memory index tree' (duration: 253.011408ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:07:40.08094Z","caller":"traceutil/trace.go:171","msg":"trace[1743009230] transaction","detail":"{read_only:false; response_revision:1528; number_of_response:1; }","duration":"199.625495ms","start":"2026-03-02T02:07:39.881288Z","end":"2026-03-02T02:07:40.080913Z","steps":["trace[1743009230] 'process raft request' (duration: 199.462901ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:07:40.099178Z","caller":"traceutil/trace.go:171","msg":"trace[531420] transaction","detail":"{read_only:false; response_revision:1529; number_of_response:1; }","duration":"216.768108ms","start":"2026-03-02T02:07:39.882386Z","end":"2026-03-02T02:07:40.099154Z","steps":["trace[531420] 'process raft request' (duration: 216.451701ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:07:40.099357Z","caller":"traceutil/trace.go:171","msg":"trace[1219170405] linearizableReadLoop","detail":"{readStateIndex:1591; appliedIndex:1589; }","duration":"122.218485ms","start":"2026-03-02T02:07:39.977103Z","end":"2026-03-02T02:07:40.099322Z","steps":["trace[1219170405] 'read index received' (duration: 103.704501ms)","trace[1219170405] 'applied index is now lower than readState.Index' (duration: 18.511804ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:07:40.099583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.477101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"} {"level":"info","ts":"2026-03-02T02:07:40.099646Z","caller":"traceutil/trace.go:171","msg":"trace[1643184132] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1531; }","duration":"122.544802ms","start":"2026-03-02T02:07:39.977083Z","end":"2026-03-02T02:07:40.099628Z","steps":["trace[1643184132] 'agreement among raft nodes before linearized reading' (duration: 122.341338ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:07:40.559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.849689ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-02T02:07:40.559293Z","caller":"traceutil/trace.go:171","msg":"trace[1552730658] transaction","detail":"{read_only:false; response_revision:1534; number_of_response:1; }","duration":"423.768412ms","start":"2026-03-02T02:07:40.135507Z","end":"2026-03-02T02:07:40.559275Z","steps":["trace[1552730658] 'process raft request' (duration: 423.604939ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:07:40.559281Z","caller":"traceutil/trace.go:171","msg":"trace[972669346] transaction","detail":"{read_only:false; response_revision:1533; number_of_response:1; }","duration":"423.863644ms","start":"2026-03-02T02:07:40.135359Z","end":"2026-03-02T02:07:40.559223Z","steps":["trace[972669346] 'process raft request' (duration: 57.244549ms)","trace[972669346] 'compare' (duration: 365.701916ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:07:40.559378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:07:40.135488Z","time spent":"423.856955ms","remote":"127.0.0.1:35942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T02:07:40.559357Z","caller":"traceutil/trace.go:171","msg":"trace[686518387] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"423.506937ms","start":"2026-03-02T02:07:40.135803Z","end":"2026-03-02T02:07:40.55931Z","steps":["trace[686518387] 'process raft request' (duration: 423.383705ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:07:40.559444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:07:40.135342Z","time spent":"424.013799ms","remote":"127.0.0.1:35830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T02:07:40.559596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:07:40.135759Z","time spent":"423.699812ms","remote":"127.0.0.1:35942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T02:07:40.559636Z","caller":"traceutil/trace.go:171","msg":"trace[1422518723] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"423.512338ms","start":"2026-03-02T02:07:40.136097Z","end":"2026-03-02T02:07:40.559609Z","steps":["trace[1422518723] 'process raft request' (duration: 423.132118ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:07:40.55972Z","caller":"traceutil/trace.go:171","msg":"trace[288772827] linearizableReadLoop","detail":"{readStateIndex:1599; appliedIndex:1594; }","duration":"189.469393ms","start":"2026-03-02T02:07:40.370231Z","end":"2026-03-02T02:07:40.559701Z","steps":["trace[288772827] 'read index received' (duration: 49.991µs)","trace[288772827] 'applied index is now lower than readState.Index' (duration: 189.418012ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:07:40.559787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:07:40.136084Z","time spent":"423.619961ms","remote":"127.0.0.1:35830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T02:07:40.55979Z","caller":"traceutil/trace.go:171","msg":"trace[871482788] transaction","detail":"{read_only:false; response_revision:1537; number_of_response:1; }","duration":"420.064232ms","start":"2026-03-02T02:07:40.139683Z","end":"2026-03-02T02:07:40.559747Z","steps":["trace[871482788] 'process raft request' (duration: 419.834887ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:07:40.55988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.653827ms","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-03-02T02:07:40.559918Z","caller":"traceutil/trace.go:171","msg":"trace[323391628] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1537; }","duration":"189.736889ms","start":"2026-03-02T02:07:40.370169Z","end":"2026-03-02T02:07:40.559906Z","steps":["trace[323391628] 'agreement among raft nodes before linearized reading' (duration: 189.600986ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:07:40.559989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:07:40.139672Z","time spent":"420.203375ms","remote":"127.0.0.1:35840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3725,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T02:07:59.882878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.729415ms","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-03-02T02:07:59.882981Z","caller":"traceutil/trace.go:171","msg":"trace[704088922] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1672; }","duration":"160.654864ms","start":"2026-03-02T02:07:59.722302Z","end":"2026-03-02T02:07:59.882957Z","steps":["trace[704088922] 'range keys from in-memory index tree' (duration: 159.52866ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:08:29.907686Z","caller":"traceutil/trace.go:171","msg":"trace[923714609] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"160.479718ms","start":"2026-03-02T02:08:29.747171Z","end":"2026-03-02T02:08:29.907651Z","steps":["trace[923714609] 'process raft request' (duration: 160.286524ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:08:35.439694Z","caller":"traceutil/trace.go:171","msg":"trace[574504723] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1931; }","duration":"109.382412ms","start":"2026-03-02T02:08:35.330293Z","end":"2026-03-02T02:08:35.439676Z","steps":["trace[574504723] 'read index received' (duration: 109.224019ms)","trace[574504723] 'applied index is now lower than readState.Index' (duration: 157.473µs)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:08:35.439795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.489404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T02:08:35.439779Z","caller":"traceutil/trace.go:171","msg":"trace[2124578572] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"144.50361ms","start":"2026-03-02T02:08:35.29524Z","end":"2026-03-02T02:08:35.439744Z","steps":["trace[2124578572] 'process raft request' (duration: 144.325616ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:08:35.439828Z","caller":"traceutil/trace.go:171","msg":"trace[948357757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1857; }","duration":"109.534835ms","start":"2026-03-02T02:08:35.330283Z","end":"2026-03-02T02:08:35.439818Z","steps":["trace[948357757] 'agreement among raft nodes before linearized reading' (duration: 109.473194ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:08:36.035363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.087927ms","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-03-02T02:08:36.035454Z","caller":"traceutil/trace.go:171","msg":"trace[77611229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1858; }","duration":"105.23247ms","start":"2026-03-02T02:08:35.930201Z","end":"2026-03-02T02:08:36.035433Z","steps":["trace[77611229] 'range keys from in-memory index tree' (duration: 104.82046ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:09:24.721629Z","caller":"traceutil/trace.go:171","msg":"trace[1964548817] linearizableReadLoop","detail":"{readStateIndex:2363; appliedIndex:2362; }","duration":"112.565156ms","start":"2026-03-02T02:09:24.609043Z","end":"2026-03-02T02:09:24.721608Z","steps":["trace[1964548817] 'read index received' (duration: 112.441324ms)","trace[1964548817] 'applied index is now lower than readState.Index' (duration: 123.062µs)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:09:24.721681Z","caller":"traceutil/trace.go:171","msg":"trace[1069043734] transaction","detail":"{read_only:false; response_revision:2270; number_of_response:1; }","duration":"114.330684ms","start":"2026-03-02T02:09:24.60732Z","end":"2026-03-02T02:09:24.721651Z","steps":["trace[1069043734] 'process raft request' (duration: 114.166701ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:09:24.721818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.76441ms","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-03-02T02:09:24.721875Z","caller":"traceutil/trace.go:171","msg":"trace[443721645] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2270; }","duration":"112.880953ms","start":"2026-03-02T02:09:24.608986Z","end":"2026-03-02T02:09:24.721867Z","steps":["trace[443721645] 'agreement among raft nodes before linearized reading' (duration: 112.72174ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:09:25.24878Z","caller":"traceutil/trace.go:171","msg":"trace[934589468] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"123.051522ms","start":"2026-03-02T02:09:25.125695Z","end":"2026-03-02T02:09:25.248747Z","steps":["trace[934589468] 'process raft request' (duration: 122.848468ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:09:59.149001Z","caller":"traceutil/trace.go:171","msg":"trace[710774368] transaction","detail":"{read_only:false; response_revision:2460; number_of_response:1; }","duration":"155.524947ms","start":"2026-03-02T02:09:58.993437Z","end":"2026-03-02T02:09:59.148962Z","steps":["trace[710774368] 'process raft request' (duration: 155.318253ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:09:59.752981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.518949ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-02T02:09:59.753086Z","caller":"traceutil/trace.go:171","msg":"trace[1253190036] transaction","detail":"{read_only:false; response_revision:2462; number_of_response:1; }","duration":"252.1583ms","start":"2026-03-02T02:09:59.500908Z","end":"2026-03-02T02:09:59.753066Z","steps":["trace[1253190036] 'process raft request' (duration: 122.281374ms)","trace[1253190036] 'compare' (duration: 129.295904ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:13:38.950879Z","caller":"traceutil/trace.go:171","msg":"trace[647706588] transaction","detail":"{read_only:false; response_revision:4168; number_of_response:1; }","duration":"103.856753ms","start":"2026-03-02T02:13:38.846931Z","end":"2026-03-02T02:13:38.950788Z","steps":["trace[647706588] 'process raft request' (duration: 102.85516ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:13:38.960994Z","caller":"traceutil/trace.go:171","msg":"trace[1633211333] transaction","detail":"{read_only:false; response_revision:4169; number_of_response:1; }","duration":"112.383132ms","start":"2026-03-02T02:13:38.848542Z","end":"2026-03-02T02:13:38.960925Z","steps":["trace[1633211333] 'process raft request' (duration: 112.234479ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:13:46.982024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.372066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9cbc6ae9-6433-484f-91ae-0465bd7bc34c\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-03-02T02:13:46.982127Z","caller":"traceutil/trace.go:171","msg":"trace[159889990] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9cbc6ae9-6433-484f-91ae-0465bd7bc34c; range_end:; response_count:1; response_revision:4434; }","duration":"201.539469ms","start":"2026-03-02T02:13:46.780571Z","end":"2026-03-02T02:13:46.98211Z","steps":["trace[159889990] 'range keys from in-memory index tree' (duration: 201.15597ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:13:52.228781Z","caller":"traceutil/trace.go:171","msg":"trace[1305068277] linearizableReadLoop","detail":"{readStateIndex:4744; appliedIndex:4742; }","duration":"133.028071ms","start":"2026-03-02T02:13:52.09573Z","end":"2026-03-02T02:13:52.228758Z","steps":["trace[1305068277] 'read index received' (duration: 101.715496ms)","trace[1305068277] 'applied index is now lower than readState.Index' (duration: 31.311465ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:13:52.228948Z","caller":"traceutil/trace.go:171","msg":"trace[104115884] transaction","detail":"{read_only:false; response_revision:4558; number_of_response:1; }","duration":"135.567447ms","start":"2026-03-02T02:13:52.093338Z","end":"2026-03-02T02:13:52.228906Z","steps":["trace[104115884] 'process raft request' (duration: 104.012687ms)","trace[104115884] 'compare' (duration: 31.186422ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:13:52.229132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.288726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-03-02T02:13:52.229184Z","caller":"traceutil/trace.go:171","msg":"trace[517387956] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4559; }","duration":"133.45906ms","start":"2026-03-02T02:13:52.095713Z","end":"2026-03-02T02:13:52.229172Z","steps":["trace[517387956] 'agreement among raft nodes before linearized reading' (duration: 133.206134ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:13:52.229651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.577882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:26 size:787202"} {"level":"info","ts":"2026-03-02T02:13:52.229715Z","caller":"traceutil/trace.go:171","msg":"trace[1703629851] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:26; response_revision:4559; }","duration":"128.678173ms","start":"2026-03-02T02:13:52.101019Z","end":"2026-03-02T02:13:52.229697Z","steps":["trace[1703629851] 'agreement among raft nodes before linearized reading' (duration: 127.995048ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:13:52.22885Z","caller":"traceutil/trace.go:171","msg":"trace[1194809836] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4559; }","duration":"135.24808ms","start":"2026-03-02T02:13:52.093564Z","end":"2026-03-02T02:13:52.228813Z","steps":["trace[1194809836] 'process raft request' (duration: 135.119837ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:13:52.343728Z","caller":"traceutil/trace.go:171","msg":"trace[1560409653] transaction","detail":"{read_only:false; response_revision:4562; number_of_response:1; }","duration":"102.783699ms","start":"2026-03-02T02:13:52.240907Z","end":"2026-03-02T02:13:52.34369Z","steps":["trace[1560409653] 'process raft request' (duration: 102.660477ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:13:52.343741Z","caller":"traceutil/trace.go:171","msg":"trace[1148244724] transaction","detail":"{read_only:false; response_revision:4561; number_of_response:1; }","duration":"107.724579ms","start":"2026-03-02T02:13:52.235946Z","end":"2026-03-02T02:13:52.34367Z","steps":["trace[1148244724] 'process raft request' (duration: 107.445843ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:13:58.346163Z","caller":"traceutil/trace.go:171","msg":"trace[2071663593] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"146.019648ms","start":"2026-03-02T02:13:58.200118Z","end":"2026-03-02T02:13:58.346138Z","steps":["trace[2071663593] 'process raft request' (duration: 116.004524ms)","trace[2071663593] 'compare' (duration: 29.662307ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:14:07.382095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.726243ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-02T02:14:07.382227Z","caller":"traceutil/trace.go:171","msg":"trace[910731115] linearizableReadLoop","detail":"{readStateIndex:5009; appliedIndex:5008; }","duration":"130.611417ms","start":"2026-03-02T02:14:07.251596Z","end":"2026-03-02T02:14:07.382207Z","steps":["trace[910731115] 'read index received' (duration: 50.211µs)","trace[910731115] 'applied index is now lower than readState.Index' (duration: 130.559766ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:14:07.38232Z","caller":"traceutil/trace.go:171","msg":"trace[885947333] transaction","detail":"{read_only:false; response_revision:4818; number_of_response:1; }","duration":"296.080226ms","start":"2026-03-02T02:14:07.086224Z","end":"2026-03-02T02:14:07.382304Z","steps":["trace[885947333] 'process raft request' (duration: 52.74633ms)","trace[885947333] 'compare' (duration: 242.101549ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:14:07.38258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.596754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gpqx4\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-03-02T02:14:07.382688Z","caller":"traceutil/trace.go:171","msg":"trace[1827717454] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gpqx4; range_end:; response_count:1; response_revision:4818; }","duration":"106.738047ms","start":"2026-03-02T02:14:07.275928Z","end":"2026-03-02T02:14:07.382666Z","steps":["trace[1827717454] 'agreement among raft nodes before linearized reading' (duration: 106.491981ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:14:07.382804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.189659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-03-02T02:14:07.382912Z","caller":"traceutil/trace.go:171","msg":"trace[1244302455] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4818; }","duration":"131.349852ms","start":"2026-03-02T02:14:07.251534Z","end":"2026-03-02T02:14:07.382884Z","steps":["trace[1244302455] 'agreement among raft nodes before linearized reading' (duration: 131.094637ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:14:07.626325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.934609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-02T02:14:07.626664Z","caller":"traceutil/trace.go:171","msg":"trace[1754094830] transaction","detail":"{read_only:false; response_revision:4820; number_of_response:1; }","duration":"238.435358ms","start":"2026-03-02T02:14:07.388196Z","end":"2026-03-02T02:14:07.626632Z","steps":["trace[1754094830] 'process raft request' (duration: 109.062709ms)","trace[1754094830] 'compare' (duration: 128.753935ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:14:07.626733Z","caller":"traceutil/trace.go:171","msg":"trace[1570689414] transaction","detail":"{read_only:false; response_revision:4821; number_of_response:1; }","duration":"238.379537ms","start":"2026-03-02T02:14:07.388291Z","end":"2026-03-02T02:14:07.626671Z","steps":["trace[1570689414] 'process raft request' (duration: 238.172722ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:14:07.626874Z","caller":"traceutil/trace.go:171","msg":"trace[522330067] transaction","detail":"{read_only:false; response_revision:4822; number_of_response:1; }","duration":"238.275124ms","start":"2026-03-02T02:14:07.388582Z","end":"2026-03-02T02:14:07.626857Z","steps":["trace[522330067] 'process raft request' (duration: 237.965287ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:14:07.627113Z","caller":"traceutil/trace.go:171","msg":"trace[1131415620] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"237.704402ms","start":"2026-03-02T02:14:07.389381Z","end":"2026-03-02T02:14:07.627086Z","steps":["trace[1131415620] 'process raft request' (duration: 237.416015ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:14:07.627178Z","caller":"traceutil/trace.go:171","msg":"trace[1002560533] transaction","detail":"{read_only:false; response_revision:4824; number_of_response:1; }","duration":"237.743522ms","start":"2026-03-02T02:14:07.389421Z","end":"2026-03-02T02:14:07.627164Z","steps":["trace[1002560533] 'process raft request' (duration: 237.563988ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:14:07.627165Z","caller":"traceutil/trace.go:171","msg":"trace[1746450688] transaction","detail":"{read_only:false; response_revision:4825; number_of_response:1; }","duration":"237.65703ms","start":"2026-03-02T02:14:07.389481Z","end":"2026-03-02T02:14:07.627138Z","steps":["trace[1746450688] 'process raft request' (duration: 237.577998ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:14:07.627478Z","caller":"traceutil/trace.go:171","msg":"trace[1469730765] linearizableReadLoop","detail":"{readStateIndex:5012; appliedIndex:5010; }","duration":"238.867217ms","start":"2026-03-02T02:14:07.388596Z","end":"2026-03-02T02:14:07.627463Z","steps":["trace[1469730765] 'read index received' (duration: 50.928329ms)","trace[1469730765] 'applied index is now lower than readState.Index' (duration: 187.937668ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:14:07.62747Z","caller":"traceutil/trace.go:171","msg":"trace[586601331] transaction","detail":"{read_only:false; response_revision:4826; number_of_response:1; }","duration":"237.185409ms","start":"2026-03-02T02:14:07.390251Z","end":"2026-03-02T02:14:07.627437Z","steps":["trace[586601331] 'process raft request' (duration: 236.844292ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:14:07.627784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.177645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80201"} {"level":"info","ts":"2026-03-02T02:14:07.627842Z","caller":"traceutil/trace.go:171","msg":"trace[451824575] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:4828; }","duration":"239.257746ms","start":"2026-03-02T02:14:07.388571Z","end":"2026-03-02T02:14:07.627829Z","steps":["trace[451824575] 'agreement among raft nodes before linearized reading' (duration: 238.965698ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:14:07.628328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.273912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-b6l9z.1898e4720bea5026\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-03-02T02:14:07.628401Z","caller":"traceutil/trace.go:171","msg":"trace[482653219] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-b6l9z.1898e4720bea5026; range_end:; response_count:1; response_revision:4828; }","duration":"113.371465ms","start":"2026-03-02T02:14:07.515013Z","end":"2026-03-02T02:14:07.628385Z","steps":["trace[482653219] 'agreement among raft nodes before linearized reading' (duration: 113.193801ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:14:21.953421Z","caller":"traceutil/trace.go:171","msg":"trace[931828673] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"266.124181ms","start":"2026-03-02T02:14:21.687256Z","end":"2026-03-02T02:14:21.95338Z","steps":["trace[931828673] 'process raft request' (duration: 187.661541ms)","trace[931828673] 'compare' (duration: 78.078131ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:14:21.953204Z","caller":"traceutil/trace.go:171","msg":"trace[725401393] linearizableReadLoop","detail":"{readStateIndex:5225; appliedIndex:5224; }","duration":"259.980015ms","start":"2026-03-02T02:14:21.693186Z","end":"2026-03-02T02:14:21.953166Z","steps":["trace[725401393] 'read index received' (duration: 181.669709ms)","trace[725401393] 'applied index is now lower than readState.Index' (duration: 78.308916ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:14:21.953742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.534077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gpqx4\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-03-02T02:14:21.953914Z","caller":"traceutil/trace.go:171","msg":"trace[605493076] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gpqx4; range_end:; response_count:1; response_revision:5027; }","duration":"260.755273ms","start":"2026-03-02T02:14:21.693146Z","end":"2026-03-02T02:14:21.953901Z","steps":["trace[605493076] 'agreement among raft nodes before linearized reading' (duration: 260.452215ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:14:21.954067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.879179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-02T02:14:21.954113Z","caller":"traceutil/trace.go:171","msg":"trace[1244437709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5027; }","duration":"179.975931ms","start":"2026-03-02T02:14:21.774127Z","end":"2026-03-02T02:14:21.954103Z","steps":["trace[1244437709] 'agreement among raft nodes before linearized reading' (duration: 179.826578ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:14:22.297432Z","caller":"traceutil/trace.go:171","msg":"trace[776273224] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"338.426675ms","start":"2026-03-02T02:14:21.958981Z","end":"2026-03-02T02:14:22.297408Z","steps":["trace[776273224] 'process raft request' (duration: 338.144839ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:14:22.297603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:14:21.958968Z","time spent":"338.534578ms","remote":"127.0.0.1:35926","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-03-02T02:14:22.297973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.427435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:13288"} {"level":"info","ts":"2026-03-02T02:14:22.298145Z","caller":"traceutil/trace.go:171","msg":"trace[575187640] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5028; }","duration":"104.64038ms","start":"2026-03-02T02:14:22.193452Z","end":"2026-03-02T02:14:22.298093Z","steps":["trace[575187640] 'agreement among raft nodes before linearized reading' (duration: 104.146399ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:14:22.297338Z","caller":"traceutil/trace.go:171","msg":"trace[992309946] linearizableReadLoop","detail":"{readStateIndex:5226; appliedIndex:5225; }","duration":"103.797282ms","start":"2026-03-02T02:14:22.193514Z","end":"2026-03-02T02:14:22.297312Z","steps":["trace[992309946] 'read index received' (duration: 103.550856ms)","trace[992309946] 'applied index is now lower than readState.Index' (duration: 244.646µs)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:14:22.445045Z","caller":"traceutil/trace.go:171","msg":"trace[725219754] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5227; }","duration":"115.188615ms","start":"2026-03-02T02:14:22.32979Z","end":"2026-03-02T02:14:22.444978Z","steps":["trace[725219754] 'read index received' (duration: 92.490231ms)","trace[725219754] 'applied index is now lower than readState.Index' (duration: 22.696604ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:14:22.44516Z","caller":"traceutil/trace.go:171","msg":"trace[1811539467] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"133.308937ms","start":"2026-03-02T02:14:22.311804Z","end":"2026-03-02T02:14:22.445113Z","steps":["trace[1811539467] 'process raft request' (duration: 110.604663ms)","trace[1811539467] 'compare' (duration: 22.306345ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:14:22.44524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.43674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T02:14:22.445279Z","caller":"traceutil/trace.go:171","msg":"trace[1178986297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5030; }","duration":"115.519472ms","start":"2026-03-02T02:14:22.329748Z","end":"2026-03-02T02:14:22.445268Z","steps":["trace[1178986297] 'agreement among raft nodes before linearized reading' (duration: 115.41708ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:15:08.927115Z","caller":"traceutil/trace.go:171","msg":"trace[1774858161] linearizableReadLoop","detail":"{readStateIndex:5607; appliedIndex:5606; }","duration":"103.554866ms","start":"2026-03-02T02:15:08.823522Z","end":"2026-03-02T02:15:08.927077Z","steps":["trace[1774858161] 'read index received' (duration: 4.454949ms)","trace[1774858161] 'applied index is now lower than readState.Index' (duration: 99.098317ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:15:08.927224Z","caller":"traceutil/trace.go:171","msg":"trace[287602440] transaction","detail":"{read_only:false; response_revision:5398; number_of_response:1; }","duration":"112.962526ms","start":"2026-03-02T02:15:08.814202Z","end":"2026-03-02T02:15:08.927164Z","steps":["trace[287602440] 'process raft request' (duration: 13.719894ms)","trace[287602440] 'compare' (duration: 98.970155ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:15:08.927626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.055508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-03-02T02:15:08.927719Z","caller":"traceutil/trace.go:171","msg":"trace[1231432301] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5398; }","duration":"104.170221ms","start":"2026-03-02T02:15:08.823499Z","end":"2026-03-02T02:15:08.927669Z","steps":["trace[1231432301] 'agreement among raft nodes before linearized reading' (duration: 103.728751ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:15:57.338451Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2746} {"level":"info","ts":"2026-03-02T02:15:57.398254Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2746,"took":"58.090687ms","hash":406045521,"current-db-size-bytes":42041344,"current-db-size":"42 MB","current-db-size-in-use-bytes":31748096,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-03-02T02:15:57.398315Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":406045521,"revision":2746,"compact-revision":-1} {"level":"info","ts":"2026-03-02T02:17:06.632626Z","caller":"traceutil/trace.go:171","msg":"trace[369997458] transaction","detail":"{read_only:false; response_revision:6082; number_of_response:1; }","duration":"102.722119ms","start":"2026-03-02T02:17:06.529859Z","end":"2026-03-02T02:17:06.632581Z","steps":["trace[369997458] 'process raft request' (duration: 102.589287ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:12.518748Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349882628070327,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-02T02:19:13.019432Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349882628070327,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-02T02:19:13.519926Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16995349882628070327,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-02T02:19:13.825816Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.117124307s","expected-duration":"1s"} {"level":"info","ts":"2026-03-02T02:19:13.826236Z","caller":"traceutil/trace.go:171","msg":"trace[1449332320] transaction","detail":"{read_only:false; response_revision:6992; number_of_response:1; }","duration":"2.117617428s","start":"2026-03-02T02:19:11.708585Z","end":"2026-03-02T02:19:13.826203Z","steps":["trace[1449332320] 'process raft request' (duration: 2.117427334s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.826422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:11.708566Z","time spent":"2.11775521s","remote":"127.0.0.1:35926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-02T02:19:13.902516Z","caller":"traceutil/trace.go:171","msg":"trace[264390949] linearizableReadLoop","detail":"{readStateIndex:7260; appliedIndex:7255; }","duration":"1.883832531s","start":"2026-03-02T02:19:12.018662Z","end":"2026-03-02T02:19:13.902494Z","steps":["trace[264390949] 'read index received' (duration: 1.807368655s)","trace[264390949] 'applied index is now lower than readState.Index' (duration: 76.463146ms)"],"step_count":2} {"level":"info","ts":"2026-03-02T02:19:13.90276Z","caller":"traceutil/trace.go:171","msg":"trace[1889417946] transaction","detail":"{read_only:false; response_revision:6993; number_of_response:1; }","duration":"1.884346933s","start":"2026-03-02T02:19:12.018404Z","end":"2026-03-02T02:19:13.902751Z","steps":["trace[1889417946] 'process raft request' (duration: 1.883872112s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.902827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.018379Z","time spent":"1.884405813s","remote":"127.0.0.1:35754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":739,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-02T02:19:13.903056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.81398989s","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-03-02T02:19:13.903082Z","caller":"traceutil/trace.go:171","msg":"trace[1431110997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6996; }","duration":"1.814048561s","start":"2026-03-02T02:19:12.089026Z","end":"2026-03-02T02:19:13.903075Z","steps":["trace[1431110997] 'agreement among raft nodes before linearized reading' (duration: 1.813935498s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.9031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.089008Z","time spent":"1.814088232s","remote":"127.0.0.1:35926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-02T02:19:13.903182Z","caller":"traceutil/trace.go:171","msg":"trace[99344413] transaction","detail":"{read_only:false; response_revision:6994; number_of_response:1; }","duration":"1.696050328s","start":"2026-03-02T02:19:12.207105Z","end":"2026-03-02T02:19:13.903155Z","steps":["trace[99344413] 'process raft request' (duration: 1.695301972s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.903287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.81501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-gpqx4\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-03-02T02:19:13.903313Z","caller":"traceutil/trace.go:171","msg":"trace[1286247295] range","detail":"{range_begin:/registry/pods/openstack/keepalived-gpqx4; range_end:; response_count:1; response_revision:6996; }","duration":"191.878722ms","start":"2026-03-02T02:19:13.711428Z","end":"2026-03-02T02:19:13.903307Z","steps":["trace[1286247295] 'agreement among raft nodes before linearized reading' (duration: 191.79738ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.903434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.232727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T02:19:13.903456Z","caller":"traceutil/trace.go:171","msg":"trace[633593562] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:6996; }","duration":"298.308459ms","start":"2026-03-02T02:19:13.605142Z","end":"2026-03-02T02:19:13.90345Z","steps":["trace[633593562] 'agreement among raft nodes before linearized reading' (duration: 298.273278ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.903591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.364003085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-03-02T02:19:13.903616Z","caller":"traceutil/trace.go:171","msg":"trace[605345315] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6996; }","duration":"1.364066766s","start":"2026-03-02T02:19:12.539543Z","end":"2026-03-02T02:19:13.903609Z","steps":["trace[605345315] 'agreement among raft nodes before linearized reading' (duration: 1.363976274s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.903632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.539519Z","time spent":"1.364109728s","remote":"127.0.0.1:35926","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":"warn","ts":"2026-03-02T02:19:13.903645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.884966665s","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-03-02T02:19:13.90369Z","caller":"traceutil/trace.go:171","msg":"trace[139055390] transaction","detail":"{read_only:false; response_revision:6995; number_of_response:1; }","duration":"1.020201202s","start":"2026-03-02T02:19:12.883482Z","end":"2026-03-02T02:19:13.903684Z","steps":["trace[139055390] 'process raft request' (duration: 1.018960245s)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:19:13.903706Z","caller":"traceutil/trace.go:171","msg":"trace[630161863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6996; }","duration":"1.885083338s","start":"2026-03-02T02:19:12.01861Z","end":"2026-03-02T02:19:13.903694Z","steps":["trace[630161863] 'agreement among raft nodes before linearized reading' (duration: 1.884350042s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.903734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.883458Z","time spent":"1.020252512s","remote":"127.0.0.1:35926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T02:19:13.90374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.018595Z","time spent":"1.885138689s","remote":"127.0.0.1:35926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-02T02:19:13.903744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.257008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T02:19:13.903762Z","caller":"traceutil/trace.go:171","msg":"trace[315837770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6996; }","duration":"575.306009ms","start":"2026-03-02T02:19:13.328451Z","end":"2026-03-02T02:19:13.903757Z","steps":["trace[315837770] 'agreement among raft nodes before linearized reading' (duration: 575.275859ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.903779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:13.328436Z","time spent":"575.34057ms","remote":"127.0.0.1:35670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-03-02T02:19:13.903311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.207079Z","time spent":"1.696169791s","remote":"127.0.0.1:35926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T02:19:13.903877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.282332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T02:19:13.903895Z","caller":"traceutil/trace.go:171","msg":"trace[1710350497] range","detail":"{range_begin:/registry/jobs/openstack/barbican-ks-user; range_end:; response_count:0; response_revision:6996; }","duration":"995.361694ms","start":"2026-03-02T02:19:12.908529Z","end":"2026-03-02T02:19:13.903891Z","steps":["trace[1710350497] 'agreement among raft nodes before linearized reading' (duration: 995.335084ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.903907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.908501Z","time spent":"995.403645ms","remote":"127.0.0.1:35894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/barbican-ks-user\" "} {"level":"info","ts":"2026-03-02T02:19:13.903943Z","caller":"traceutil/trace.go:171","msg":"trace[1549928049] transaction","detail":"{read_only:false; response_revision:6996; number_of_response:1; }","duration":"983.265027ms","start":"2026-03-02T02:19:12.92067Z","end":"2026-03-02T02:19:13.903935Z","steps":["trace[1549928049] 'process raft request' (duration: 981.800215ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.90395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.360789243s","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-03-02T02:19:13.903975Z","caller":"traceutil/trace.go:171","msg":"trace[1661277871] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6996; }","duration":"1.360842135s","start":"2026-03-02T02:19:12.543124Z","end":"2026-03-02T02:19:13.903967Z","steps":["trace[1661277871] 'agreement among raft nodes before linearized reading' (duration: 1.360780474s)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.903996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.543111Z","time spent":"1.360881055s","remote":"127.0.0.1:35926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-02T02:19:13.904009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.920651Z","time spent":"983.311759ms","remote":"127.0.0.1:35926","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-02T02:19:13.90416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.701161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-02T02:19:13.904223Z","caller":"traceutil/trace.go:171","msg":"trace[1886853858] range","detail":"{range_begin:/registry/jobs/openstack/barbican-ks-endpoints; range_end:; response_count:0; response_revision:6996; }","duration":"995.812403ms","start":"2026-03-02T02:19:12.908396Z","end":"2026-03-02T02:19:13.904209Z","steps":["trace[1886853858] 'agreement among raft nodes before linearized reading' (duration: 995.65606ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:19:13.904261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-02T02:19:12.908384Z","time spent":"995.871076ms","remote":"127.0.0.1:35894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/barbican-ks-endpoints\" "} {"level":"info","ts":"2026-03-02T02:20:57.347884Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5759} {"level":"info","ts":"2026-03-02T02:20:57.439621Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5759,"took":"89.105175ms","hash":1248480191,"current-db-size-bytes":43597824,"current-db-size":"44 MB","current-db-size-in-use-bytes":21405696,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-03-02T02:20:57.439703Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1248480191,"revision":5759,"compact-revision":2746} {"level":"info","ts":"2026-03-02T02:21:54.846386Z","caller":"traceutil/trace.go:171","msg":"trace[1001488174] transaction","detail":"{read_only:false; response_revision:7858; number_of_response:1; }","duration":"116.416438ms","start":"2026-03-02T02:21:54.729945Z","end":"2026-03-02T02:21:54.846361Z","steps":["trace[1001488174] 'process raft request' (duration: 116.274515ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:21:54.863299Z","caller":"traceutil/trace.go:171","msg":"trace[1083506331] linearizableReadLoop","detail":"{readStateIndex:8162; appliedIndex:8160; }","duration":"103.735718ms","start":"2026-03-02T02:21:54.759537Z","end":"2026-03-02T02:21:54.863272Z","steps":["trace[1083506331] 'read index received' (duration: 86.741093ms)","trace[1083506331] 'applied index is now lower than readState.Index' (duration: 16.993585ms)"],"step_count":2} {"level":"warn","ts":"2026-03-02T02:21:54.863619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.196138ms","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-03-02T02:21:54.863673Z","caller":"traceutil/trace.go:171","msg":"trace[491846192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7859; }","duration":"104.345161ms","start":"2026-03-02T02:21:54.759307Z","end":"2026-03-02T02:21:54.863652Z","steps":["trace[491846192] 'agreement among raft nodes before linearized reading' (duration: 104.092216ms)"],"step_count":1} {"level":"warn","ts":"2026-03-02T02:21:54.863631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.535964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-03-02T02:21:54.863794Z","caller":"traceutil/trace.go:171","msg":"trace[1297237745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7859; }","duration":"103.744228ms","start":"2026-03-02T02:21:54.760035Z","end":"2026-03-02T02:21:54.86378Z","steps":["trace[1297237745] 'agreement among raft nodes before linearized reading' (duration: 103.432171ms)"],"step_count":1} {"level":"info","ts":"2026-03-02T02:21:54.863965Z","caller":"traceutil/trace.go:171","msg":"trace[902277252] transaction","detail":"{read_only:false; response_revision:7859; number_of_response:1; }","duration":"131.94312ms","start":"2026-03-02T02:21:54.731396Z","end":"2026-03-02T02:21:54.863339Z","steps":["trace[902277252] 'process raft request' (duration: 131.741855ms)"],"step_count":1}