{"level":"warn","ts":"2026-04-22T00:21:37.834431Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T00:21:37.834517Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.140:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.140:2380","--initial-cluster=instance=https://199.204.45.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.140:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-22T00:21:37.834581Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T00:21:37.834588Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-04-22T00:21:37.834603Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T00:21:37.835229Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"]} {"level":"info","ts":"2026-04-22T00:21:37.83531Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.140:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-22T00:21:37.839709Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.68568ms"} {"level":"info","ts":"2026-04-22T00:21:37.849278Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"35b2766da46a76bb","cluster-id":"f5fd3aeb8d9f53dc"} {"level":"info","ts":"2026-04-22T00:21:37.849393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T00:21:37.84942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 0"} {"level":"info","ts":"2026-04-22T00:21:37.849437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 35b2766da46a76bb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T00:21:37.849451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became follower at term 1"} {"level":"info","ts":"2026-04-22T00:21:37.849502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"warn","ts":"2026-04-22T00:21:37.857158Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T00:21:37.859152Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T00:21:37.863551Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-22T00:21:37.868052Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"35b2766da46a76bb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T00:21:37.869926Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"35b2766da46a76bb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T00:21:37.870154Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T00:21:37.870257Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T00:21:37.87028Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-22T00:21:37.875775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb switched to configuration voters=(3869285243146630843)"} {"level":"info","ts":"2026-04-22T00:21:37.876152Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","added-peer-id":"35b2766da46a76bb","added-peer-peer-urls":["https://199.204.45.140:2380"]} {"level":"info","ts":"2026-04-22T00:21:37.877825Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-22T00:21:37.877888Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-04-22T00:21:37.877934Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.140:2380"} {"level":"info","ts":"2026-04-22T00:21:37.878016Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"35b2766da46a76bb","initial-advertise-peer-urls":["https://199.204.45.140:2380"],"listen-peer-urls":["https://199.204.45.140:2380"],"advertise-client-urls":["https://199.204.45.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T00:21:37.878052Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T00:21:38.252158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T00:21:38.252265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T00:21:38.252289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgPreVoteResp from 35b2766da46a76bb at term 1"} {"level":"info","ts":"2026-04-22T00:21:38.252309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became candidate at term 2"} {"level":"info","ts":"2026-04-22T00:21:38.252331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb received MsgVoteResp from 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-04-22T00:21:38.252351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"35b2766da46a76bb became leader at term 2"} {"level":"info","ts":"2026-04-22T00:21:38.252364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 35b2766da46a76bb elected leader 35b2766da46a76bb at term 2"} {"level":"info","ts":"2026-04-22T00:21:38.253563Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"35b2766da46a76bb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.140:2379]}","request-path":"/0/members/35b2766da46a76bb/attributes","cluster-id":"f5fd3aeb8d9f53dc","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T00:21:38.253582Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:21:38.253775Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:21:38.25411Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:21:38.25449Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T00:21:38.254509Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T00:21:38.254724Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5fd3aeb8d9f53dc","local-member-id":"35b2766da46a76bb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:21:38.254831Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:21:38.254867Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:21:38.256607Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T00:21:38.258029Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.140:2379"} {"level":"info","ts":"2026-04-22T00:21:40.172178Z","caller":"traceutil/trace.go:171","msg":"trace[1664312881] transaction","detail":"{read_only:false; response_revision:70; number_of_response:1; }","duration":"132.420766ms","start":"2026-04-22T00:21:40.039726Z","end":"2026-04-22T00:21:40.172146Z","steps":["trace[1664312881] 'process raft request' (duration: 132.288505ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:21:40.445792Z","caller":"traceutil/trace.go:171","msg":"trace[1819988077] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"382.417904ms","start":"2026-04-22T00:21:40.063338Z","end":"2026-04-22T00:21:40.445756Z","steps":["trace[1819988077] 'process raft request' (duration: 315.343652ms)","trace[1819988077] 'compare' (duration: 66.8861ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:21:40.446493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:21:40.063315Z","time spent":"382.574796ms","remote":"127.0.0.1:52094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T00:22:14.233807Z","caller":"traceutil/trace.go:171","msg":"trace[1188518517] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"146.799189ms","start":"2026-04-22T00:22:14.086966Z","end":"2026-04-22T00:22:14.233765Z","steps":["trace[1188518517] 'read index received' (duration: 145.569899ms)","trace[1188518517] 'applied index is now lower than readState.Index' (duration: 1.22777ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:14.233885Z","caller":"traceutil/trace.go:171","msg":"trace[1334091434] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"400.606842ms","start":"2026-04-22T00:22:13.833211Z","end":"2026-04-22T00:22:14.233818Z","steps":["trace[1334091434] 'process raft request' (duration: 399.633324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:14.234509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.506165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T00:22:14.234637Z","caller":"traceutil/trace.go:171","msg":"trace[445714116] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"147.698196ms","start":"2026-04-22T00:22:14.086918Z","end":"2026-04-22T00:22:14.234616Z","steps":["trace[445714116] 'agreement among raft nodes before linearized reading' (duration: 147.013231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:14.234701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:13.833164Z","time spent":"401.035025ms","remote":"127.0.0.1:51976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:22:14.60478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.720271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:22:14.604959Z","caller":"traceutil/trace.go:171","msg":"trace[195743096] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"156.019274ms","start":"2026-04-22T00:22:14.448908Z","end":"2026-04-22T00:22:14.604927Z","steps":["trace[195743096] 'range keys from in-memory index tree' (duration: 155.58892ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:14.743386Z","caller":"traceutil/trace.go:171","msg":"trace[1742626719] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"120.519297ms","start":"2026-04-22T00:22:14.622844Z","end":"2026-04-22T00:22:14.743363Z","steps":["trace[1742626719] 'process raft request' (duration: 120.338955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:29.830073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.957954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T00:22:29.830185Z","caller":"traceutil/trace.go:171","msg":"trace[1326740349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:780; }","duration":"115.140951ms","start":"2026-04-22T00:22:29.715023Z","end":"2026-04-22T00:22:29.830164Z","steps":["trace[1326740349] 'range keys from in-memory index tree' (duration: 114.704834ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:39.302527Z","caller":"traceutil/trace.go:171","msg":"trace[1955710597] linearizableReadLoop","detail":"{readStateIndex:920; appliedIndex:919; }","duration":"329.279476ms","start":"2026-04-22T00:22:38.973223Z","end":"2026-04-22T00:22:39.302502Z","steps":["trace[1955710597] 'read index received' (duration: 329.11339ms)","trace[1955710597] 'applied index is now lower than readState.Index' (duration: 165.005µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:39.302652Z","caller":"traceutil/trace.go:171","msg":"trace[1764406144] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"439.370226ms","start":"2026-04-22T00:22:38.863248Z","end":"2026-04-22T00:22:39.302618Z","steps":["trace[1764406144] 'process raft request' (duration: 439.114598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:39.30285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:38.863232Z","time spent":"439.532013ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:22:39.302975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.721961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T00:22:39.303088Z","caller":"traceutil/trace.go:171","msg":"trace[1373664818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:895; }","duration":"329.868836ms","start":"2026-04-22T00:22:38.973198Z","end":"2026-04-22T00:22:39.303067Z","steps":["trace[1373664818] 'agreement among raft nodes before linearized reading' (duration: 329.521704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:39.303182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:38.973175Z","time spent":"329.99426ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-22T00:23:50.707543Z","caller":"traceutil/trace.go:171","msg":"trace[1919191092] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"326.535009ms","start":"2026-04-22T00:23:50.380974Z","end":"2026-04-22T00:23:50.707509Z","steps":["trace[1919191092] 'read index received' (duration: 326.265524ms)","trace[1919191092] 'applied index is now lower than readState.Index' (duration: 268.235µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:23:50.707761Z","caller":"traceutil/trace.go:171","msg":"trace[342960184] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"341.306023ms","start":"2026-04-22T00:23:50.366423Z","end":"2026-04-22T00:23:50.707729Z","steps":["trace[342960184] 'process raft request' (duration: 340.906565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:23:50.707839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.849245ms","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-04-22T00:23:50.70789Z","caller":"traceutil/trace.go:171","msg":"trace[673610273] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1857; }","duration":"326.922597ms","start":"2026-04-22T00:23:50.380953Z","end":"2026-04-22T00:23:50.707876Z","steps":["trace[673610273] 'agreement among raft nodes before linearized reading' (duration: 326.702883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:23:50.707929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:23:50.380878Z","time spent":"327.041338ms","remote":"127.0.0.1:52190","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-04-22T00:23:50.707938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:23:50.36641Z","time spent":"341.429525ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:23:51.070195Z","caller":"traceutil/trace.go:171","msg":"trace[161560056] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"162.272139ms","start":"2026-04-22T00:23:50.907889Z","end":"2026-04-22T00:23:51.070161Z","steps":["trace[161560056] 'process raft request' (duration: 118.716967ms)","trace[161560056] 'compare' (duration: 43.42018ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:24:06.189949Z","caller":"traceutil/trace.go:171","msg":"trace[329006066] transaction","detail":"{read_only:false; response_revision:1988; number_of_response:1; }","duration":"151.130548ms","start":"2026-04-22T00:24:06.038773Z","end":"2026-04-22T00:24:06.189904Z","steps":["trace[329006066] 'process raft request' (duration: 150.783273ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:24:19.452329Z","caller":"traceutil/trace.go:171","msg":"trace[144600031] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"141.009821ms","start":"2026-04-22T00:24:19.311265Z","end":"2026-04-22T00:24:19.452275Z","steps":["trace[144600031] 'process raft request' (duration: 140.625995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:25:31.732691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.178398ms","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-04-22T00:25:31.732777Z","caller":"traceutil/trace.go:171","msg":"trace[1163201213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2563; }","duration":"130.298889ms","start":"2026-04-22T00:25:31.602462Z","end":"2026-04-22T00:25:31.732761Z","steps":["trace[1163201213] 'range keys from in-memory index tree' (duration: 130.040146ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:02.822137Z","caller":"traceutil/trace.go:171","msg":"trace[1101566579] transaction","detail":"{read_only:false; response_revision:2733; number_of_response:1; }","duration":"139.898791ms","start":"2026-04-22T00:26:02.682213Z","end":"2026-04-22T00:26:02.822111Z","steps":["trace[1101566579] 'process raft request' (duration: 139.366485ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:02.984522Z","caller":"traceutil/trace.go:171","msg":"trace[726067791] linearizableReadLoop","detail":"{readStateIndex:2832; appliedIndex:2831; }","duration":"161.373834ms","start":"2026-04-22T00:26:02.823111Z","end":"2026-04-22T00:26:02.984484Z","steps":["trace[726067791] 'read index received' (duration: 117.851863ms)","trace[726067791] 'applied index is now lower than readState.Index' (duration: 43.519851ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:26:02.984832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.690337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:26:02.984948Z","caller":"traceutil/trace.go:171","msg":"trace[710336053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2734; }","duration":"161.819229ms","start":"2026-04-22T00:26:02.823104Z","end":"2026-04-22T00:26:02.984923Z","steps":["trace[710336053] 'agreement among raft nodes before linearized reading' (duration: 161.619846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:02.98518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.679667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-22T00:26:02.985236Z","caller":"traceutil/trace.go:171","msg":"trace[2092234807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2734; }","duration":"138.777658ms","start":"2026-04-22T00:26:02.846441Z","end":"2026-04-22T00:26:02.985219Z","steps":["trace[2092234807] 'agreement among raft nodes before linearized reading' (duration: 138.569916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:02.985715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.075895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-22T00:26:02.985799Z","caller":"traceutil/trace.go:171","msg":"trace[424035596] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2734; }","duration":"152.201336ms","start":"2026-04-22T00:26:02.83358Z","end":"2026-04-22T00:26:02.985781Z","steps":["trace[424035596] 'agreement among raft nodes before linearized reading' (duration: 151.228564ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:02.984835Z","caller":"traceutil/trace.go:171","msg":"trace[1760732165] transaction","detail":"{read_only:false; response_revision:2734; number_of_response:1; }","duration":"190.144071ms","start":"2026-04-22T00:26:02.79465Z","end":"2026-04-22T00:26:02.984794Z","steps":["trace[1760732165] 'process raft request' (duration: 146.311637ms)","trace[1760732165] 'compare' (duration: 43.343178ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:27:23.53895Z","caller":"traceutil/trace.go:171","msg":"trace[1120403842] transaction","detail":"{read_only:false; response_revision:3157; number_of_response:1; }","duration":"337.330241ms","start":"2026-04-22T00:27:23.201582Z","end":"2026-04-22T00:27:23.538912Z","steps":["trace[1120403842] 'process raft request' (duration: 336.351379ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:27:23.539183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:27:23.201557Z","time spent":"337.513547ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:27:25.733211Z","caller":"traceutil/trace.go:171","msg":"trace[588827687] transaction","detail":"{read_only:false; response_revision:3170; number_of_response:1; }","duration":"176.458461ms","start":"2026-04-22T00:27:25.556732Z","end":"2026-04-22T00:27:25.73319Z","steps":["trace[588827687] 'process raft request' (duration: 175.20446ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:27:25.733421Z","caller":"traceutil/trace.go:171","msg":"trace[1843158703] transaction","detail":"{read_only:false; response_revision:3171; number_of_response:1; }","duration":"176.564895ms","start":"2026-04-22T00:27:25.556848Z","end":"2026-04-22T00:27:25.733413Z","steps":["trace[1843158703] 'process raft request' (duration: 175.987796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:08.03693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.380478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194901"} {"level":"info","ts":"2026-04-22T00:30:08.037018Z","caller":"traceutil/trace.go:171","msg":"trace[744577527] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4698; }","duration":"146.51258ms","start":"2026-04-22T00:30:07.890483Z","end":"2026-04-22T00:30:08.036995Z","steps":["trace[744577527] 'range keys from bolt db' (duration: 146.159554ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:13.71966Z","caller":"traceutil/trace.go:171","msg":"trace[601359749] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"166.223429ms","start":"2026-04-22T00:30:13.553412Z","end":"2026-04-22T00:30:13.719635Z","steps":["trace[601359749] 'process raft request' (duration: 166.078756ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:14.960273Z","caller":"traceutil/trace.go:171","msg":"trace[1464630064] linearizableReadLoop","detail":"{readStateIndex:4992; appliedIndex:4991; }","duration":"289.123478ms","start":"2026-04-22T00:30:14.671124Z","end":"2026-04-22T00:30:14.960248Z","steps":["trace[1464630064] 'read index received' (duration: 288.944795ms)","trace[1464630064] 'applied index is now lower than readState.Index' (duration: 177.913µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:14.960371Z","caller":"traceutil/trace.go:171","msg":"trace[1187107166] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"290.203609ms","start":"2026-04-22T00:30:14.670139Z","end":"2026-04-22T00:30:14.960343Z","steps":["trace[1187107166] 'process raft request' (duration: 289.878493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:14.960528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.359832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7582"} {"level":"info","ts":"2026-04-22T00:30:14.960599Z","caller":"traceutil/trace.go:171","msg":"trace[959645043] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4816; }","duration":"289.483145ms","start":"2026-04-22T00:30:14.671099Z","end":"2026-04-22T00:30:14.960582Z","steps":["trace[959645043] 'agreement among raft nodes before linearized reading' (duration: 289.248311ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:14.98189Z","caller":"traceutil/trace.go:171","msg":"trace[1024782715] transaction","detail":"{read_only:false; response_revision:4817; number_of_response:1; }","duration":"155.179951ms","start":"2026-04-22T00:30:14.826684Z","end":"2026-04-22T00:30:14.981864Z","steps":["trace[1024782715] 'process raft request' (duration: 154.981417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:14.982032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.93527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-22T00:30:14.982114Z","caller":"traceutil/trace.go:171","msg":"trace[771318454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4817; }","duration":"305.055803ms","start":"2026-04-22T00:30:14.677038Z","end":"2026-04-22T00:30:14.982094Z","steps":["trace[771318454] 'agreement among raft nodes before linearized reading' (duration: 304.789218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:14.982118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.577319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"warn","ts":"2026-04-22T00:30:14.982156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:30:14.677027Z","time spent":"305.118674ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-22T00:30:14.982196Z","caller":"traceutil/trace.go:171","msg":"trace[1404441593] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4817; }","duration":"123.69744ms","start":"2026-04-22T00:30:14.858481Z","end":"2026-04-22T00:30:14.982178Z","steps":["trace[1404441593] 'agreement among raft nodes before linearized reading' (duration: 123.454686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:14.982268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.494931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:14.982316Z","caller":"traceutil/trace.go:171","msg":"trace[1049550914] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4817; }","duration":"250.595433ms","start":"2026-04-22T00:30:14.731707Z","end":"2026-04-22T00:30:14.982302Z","steps":["trace[1049550914] 'agreement among raft nodes before linearized reading' (duration: 250.512281ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:15.548854Z","caller":"traceutil/trace.go:171","msg":"trace[1604473833] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"133.456542ms","start":"2026-04-22T00:30:15.41537Z","end":"2026-04-22T00:30:15.548827Z","steps":["trace[1604473833] 'process raft request' (duration: 133.278298ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:15.55418Z","caller":"traceutil/trace.go:171","msg":"trace[1832155789] linearizableReadLoop","detail":"{readStateIndex:5010; appliedIndex:5008; }","duration":"130.667989ms","start":"2026-04-22T00:30:15.423485Z","end":"2026-04-22T00:30:15.554153Z","steps":["trace[1832155789] 'read index received' (duration: 125.161794ms)","trace[1832155789] 'applied index is now lower than readState.Index' (duration: 5.505125ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:15.554219Z","caller":"traceutil/trace.go:171","msg":"trace[1756862171] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"132.451483ms","start":"2026-04-22T00:30:15.421731Z","end":"2026-04-22T00:30:15.554182Z","steps":["trace[1756862171] 'process raft request' (duration: 132.28083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:15.554444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.930994ms","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-04-22T00:30:15.554622Z","caller":"traceutil/trace.go:171","msg":"trace[359304225] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4834; }","duration":"131.165638ms","start":"2026-04-22T00:30:15.423444Z","end":"2026-04-22T00:30:15.554609Z","steps":["trace[359304225] 'agreement among raft nodes before linearized reading' (duration: 130.807431ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:23.11886Z","caller":"traceutil/trace.go:171","msg":"trace[1270552027] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"105.903825ms","start":"2026-04-22T00:30:23.012904Z","end":"2026-04-22T00:30:23.118808Z","steps":["trace[1270552027] 'process raft request' (duration: 55.571032ms)","trace[1270552027] 'compare' (duration: 50.15508ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:30:26.897741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.066259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:30:26.897885Z","caller":"traceutil/trace.go:171","msg":"trace[15502444] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4986; }","duration":"229.239383ms","start":"2026-04-22T00:30:26.668572Z","end":"2026-04-22T00:30:26.897811Z","steps":["trace[15502444] 'count revisions from in-memory index tree' (duration: 228.942417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:26.89803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.221318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:26.898161Z","caller":"traceutil/trace.go:171","msg":"trace[1506953857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4986; }","duration":"166.442953ms","start":"2026-04-22T00:30:26.73168Z","end":"2026-04-22T00:30:26.898123Z","steps":["trace[1506953857] 'range keys from in-memory index tree' (duration: 166.068775ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:11.46308Z","caller":"traceutil/trace.go:171","msg":"trace[1502178276] linearizableReadLoop","detail":"{readStateIndex:5560; appliedIndex:5559; }","duration":"115.03591ms","start":"2026-04-22T00:31:11.348008Z","end":"2026-04-22T00:31:11.463044Z","steps":["trace[1502178276] 'read index received' (duration: 114.724215ms)","trace[1502178276] 'applied index is now lower than readState.Index' (duration: 310.305µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:31:11.463361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.780208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:11.463422Z","caller":"traceutil/trace.go:171","msg":"trace[1864221858] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5369; }","duration":"113.93458ms","start":"2026-04-22T00:31:11.349469Z","end":"2026-04-22T00:31:11.463404Z","steps":["trace[1864221858] 'agreement among raft nodes before linearized reading' (duration: 113.801018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:11.463403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.373126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:11.463398Z","caller":"traceutil/trace.go:171","msg":"trace[1003481436] transaction","detail":"{read_only:false; response_revision:5369; number_of_response:1; }","duration":"179.407913ms","start":"2026-04-22T00:31:11.283934Z","end":"2026-04-22T00:31:11.463341Z","steps":["trace[1003481436] 'process raft request' (duration: 178.897514ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:11.463529Z","caller":"traceutil/trace.go:171","msg":"trace[1881891334] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5369; }","duration":"115.562059ms","start":"2026-04-22T00:31:11.347935Z","end":"2026-04-22T00:31:11.463497Z","steps":["trace[1881891334] 'agreement among raft nodes before linearized reading' (duration: 115.338545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:11.464306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.548619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"} {"level":"info","ts":"2026-04-22T00:31:11.464483Z","caller":"traceutil/trace.go:171","msg":"trace[194809266] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5369; }","duration":"111.775414ms","start":"2026-04-22T00:31:11.352686Z","end":"2026-04-22T00:31:11.464461Z","steps":["trace[194809266] 'agreement among raft nodes before linearized reading' (duration: 111.034091ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:11.880065Z","caller":"traceutil/trace.go:171","msg":"trace[1981952186] transaction","detail":"{read_only:false; response_revision:5371; number_of_response:1; }","duration":"392.258214ms","start":"2026-04-22T00:31:11.487771Z","end":"2026-04-22T00:31:11.880029Z","steps":["trace[1981952186] 'process raft request' (duration: 392.04866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:11.880245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:11.487759Z","time spent":"392.390847ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:11.882118Z","caller":"traceutil/trace.go:171","msg":"trace[554486105] transaction","detail":"{read_only:false; response_revision:5373; number_of_response:1; }","duration":"394.130326ms","start":"2026-04-22T00:31:11.487957Z","end":"2026-04-22T00:31:11.882088Z","steps":["trace[554486105] 'process raft request' (duration: 394.031775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:11.882743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:11.487944Z","time spent":"394.689666ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:11.882139Z","caller":"traceutil/trace.go:171","msg":"trace[565669068] transaction","detail":"{read_only:false; response_revision:5372; number_of_response:1; }","duration":"394.160997ms","start":"2026-04-22T00:31:11.487926Z","end":"2026-04-22T00:31:11.882087Z","steps":["trace[565669068] 'process raft request' (duration: 393.881812ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:11.88225Z","caller":"traceutil/trace.go:171","msg":"trace[1919958907] transaction","detail":"{read_only:false; response_revision:5374; number_of_response:1; }","duration":"105.23787ms","start":"2026-04-22T00:31:11.77699Z","end":"2026-04-22T00:31:11.882228Z","steps":["trace[1919958907] 'process raft request' (duration: 105.051056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:11.883084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:11.487894Z","time spent":"395.056012ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:11.882264Z","caller":"traceutil/trace.go:171","msg":"trace[1729113900] linearizableReadLoop","detail":"{readStateIndex:5564; appliedIndex:5561; }","duration":"364.131148ms","start":"2026-04-22T00:31:11.518093Z","end":"2026-04-22T00:31:11.882224Z","steps":["trace[1729113900] 'read index received' (duration: 361.681935ms)","trace[1729113900] 'applied index is now lower than readState.Index' (duration: 2.445313ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:31:11.882531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.419892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-22T00:31:11.88332Z","caller":"traceutil/trace.go:171","msg":"trace[155977691] range","detail":"{range_begin:/registry/masterleases/199.204.45.140; range_end:; response_count:1; response_revision:5374; }","duration":"365.260357ms","start":"2026-04-22T00:31:11.518021Z","end":"2026-04-22T00:31:11.883281Z","steps":["trace[155977691] 'agreement among raft nodes before linearized reading' (duration: 364.30066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:11.883363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.10536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:11.883405Z","caller":"traceutil/trace.go:171","msg":"trace[1156297199] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:5374; }","duration":"182.199702ms","start":"2026-04-22T00:31:11.70119Z","end":"2026-04-22T00:31:11.88339Z","steps":["trace[1156297199] 'agreement among raft nodes before linearized reading' (duration: 182.11716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:11.883429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:11.517993Z","time spent":"365.39954ms","remote":"127.0.0.1:51920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.140\" "} {"level":"warn","ts":"2026-04-22T00:31:15.280384Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555605307371940353,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T00:31:15.781466Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555605307371940353,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T00:31:16.393784Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555605307371940353,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T00:31:16.894632Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8555605307371940353,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-22T00:31:17.238417Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.348809991s","expected-duration":"1s"} {"level":"info","ts":"2026-04-22T00:31:17.239025Z","caller":"traceutil/trace.go:171","msg":"trace[575223530] transaction","detail":"{read_only:false; response_revision:5400; number_of_response:1; }","duration":"3.349504723s","start":"2026-04-22T00:31:13.889495Z","end":"2026-04-22T00:31:17.238999Z","steps":["trace[575223530] 'process raft request' (duration: 3.349236978s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.239192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:13.889477Z","time spent":"3.349633365s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:17.258017Z","caller":"traceutil/trace.go:171","msg":"trace[955949574] transaction","detail":"{read_only:false; response_revision:5404; number_of_response:1; }","duration":"3.105627418s","start":"2026-04-22T00:31:14.152357Z","end":"2026-04-22T00:31:17.257985Z","steps":["trace[955949574] 'process raft request' (duration: 3.105212161s)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:17.258036Z","caller":"traceutil/trace.go:171","msg":"trace[1551573837] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"2.869808438s","start":"2026-04-22T00:31:14.388198Z","end":"2026-04-22T00:31:17.258007Z","steps":["trace[1551573837] 'process raft request' (duration: 2.869415581s)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:17.25815Z","caller":"traceutil/trace.go:171","msg":"trace[122380995] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"2.723679992s","start":"2026-04-22T00:31:14.53445Z","end":"2026-04-22T00:31:17.25813Z","steps":["trace[122380995] 'process raft request' (duration: 2.723250654s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.25818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:14.15234Z","time spent":"3.10575649s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:17.258198Z","caller":"traceutil/trace.go:171","msg":"trace[35649738] transaction","detail":"{read_only:false; response_revision:5401; number_of_response:1; }","duration":"3.367866248s","start":"2026-04-22T00:31:13.890318Z","end":"2026-04-22T00:31:17.258184Z","steps":["trace[35649738] 'process raft request' (duration: 3.367055534s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.258227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:14.534431Z","time spent":"2.723754183s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:17.258241Z","caller":"traceutil/trace.go:171","msg":"trace[354230435] transaction","detail":"{read_only:false; response_revision:5402; number_of_response:1; }","duration":"3.36748477s","start":"2026-04-22T00:31:13.890739Z","end":"2026-04-22T00:31:17.258224Z","steps":["trace[354230435] 'process raft request' (duration: 3.366751568s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.258259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:13.890302Z","time spent":"3.367926419s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:31:17.258305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:13.890714Z","time spent":"3.367561072s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:31:17.258301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:14.388186Z","time spent":"2.86995562s","remote":"127.0.0.1:52086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12031,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:17.25833Z","caller":"traceutil/trace.go:171","msg":"trace[379421090] transaction","detail":"{read_only:false; response_revision:5403; number_of_response:1; }","duration":"3.366782739s","start":"2026-04-22T00:31:13.891541Z","end":"2026-04-22T00:31:17.258324Z","steps":["trace[379421090] 'process raft request' (duration: 3.365979155s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.258364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:13.891525Z","time spent":"3.36681958s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:17.25841Z","caller":"traceutil/trace.go:171","msg":"trace[1227379245] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"1.424640542s","start":"2026-04-22T00:31:15.833723Z","end":"2026-04-22T00:31:17.258363Z","steps":["trace[1227379245] 'process raft request' (duration: 1.424012881s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.25872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:15.833706Z","time spent":"1.424871586s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:31:17.264435Z","caller":"traceutil/trace.go:171","msg":"trace[364907638] linearizableReadLoop","detail":"{readStateIndex:5600; appliedIndex:5592; }","duration":"3.308653126s","start":"2026-04-22T00:31:13.955764Z","end":"2026-04-22T00:31:17.264417Z","steps":["trace[364907638] 'read index received' (duration: 3.283014406s)","trace[364907638] 'applied index is now lower than readState.Index' (duration: 25.63779ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:31:17.264741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.30890501s","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-04-22T00:31:17.264787Z","caller":"traceutil/trace.go:171","msg":"trace[382690799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5407; }","duration":"3.309034272s","start":"2026-04-22T00:31:13.955744Z","end":"2026-04-22T00:31:17.264778Z","steps":["trace[382690799] 'agreement among raft nodes before linearized reading' (duration: 3.308806338s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.264813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:13.955672Z","time spent":"3.309134144s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-22T00:31:17.265053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.164166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.265101Z","caller":"traceutil/trace.go:171","msg":"trace[956005303] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5407; }","duration":"870.264838ms","start":"2026-04-22T00:31:16.394824Z","end":"2026-04-22T00:31:17.265089Z","steps":["trace[956005303] 'agreement among raft nodes before linearized reading' (duration: 870.189757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.265128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:16.394793Z","time spent":"870.329099ms","remote":"127.0.0.1:51612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:31:17.265141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.477119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.265168Z","caller":"traceutil/trace.go:171","msg":"trace[239648616] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5407; }","duration":"871.559491ms","start":"2026-04-22T00:31:16.393601Z","end":"2026-04-22T00:31:17.26516Z","steps":["trace[239648616] 'agreement among raft nodes before linearized reading' (duration: 871.50727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.265194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:16.393577Z","time spent":"871.608171ms","remote":"127.0.0.1:51690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:31:17.265296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.995997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.26532Z","caller":"traceutil/trace.go:171","msg":"trace[544192818] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:5407; }","duration":"409.056668ms","start":"2026-04-22T00:31:16.856257Z","end":"2026-04-22T00:31:17.265313Z","steps":["trace[544192818] 'agreement among raft nodes before linearized reading' (duration: 409.010747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.265339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:16.856238Z","time spent":"409.095848ms","remote":"127.0.0.1:54118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:31:17.26549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.266021014s","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-04-22T00:31:17.265539Z","caller":"traceutil/trace.go:171","msg":"trace[1796232433] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5407; }","duration":"1.266119516s","start":"2026-04-22T00:31:15.999405Z","end":"2026-04-22T00:31:17.265525Z","steps":["trace[1796232433] 'agreement among raft nodes before linearized reading' (duration: 1.266029684s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.265567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:15.999388Z","time spent":"1.266172136s","remote":"127.0.0.1:34980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:31:17.265686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.789266721s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.265717Z","caller":"traceutil/trace.go:171","msg":"trace[1474125423] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5407; }","duration":"1.789331723s","start":"2026-04-22T00:31:15.476376Z","end":"2026-04-22T00:31:17.265707Z","steps":["trace[1474125423] 'agreement among raft nodes before linearized reading' (duration: 1.789280732s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.265737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:15.476359Z","time spent":"1.789373233s","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" "} {"level":"warn","ts":"2026-04-22T00:31:17.265871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.424722594s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.265895Z","caller":"traceutil/trace.go:171","msg":"trace[761869511] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5407; }","duration":"1.424772904s","start":"2026-04-22T00:31:15.841116Z","end":"2026-04-22T00:31:17.265889Z","steps":["trace[761869511] 'agreement among raft nodes before linearized reading' (duration: 1.424721503s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.265913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:15.8411Z","time spent":"1.424808874s","remote":"127.0.0.1:51894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-22T00:31:17.266071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.435515598s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-db-init-72znr\" ","response":"range_response_count:1 size:7101"} {"level":"info","ts":"2026-04-22T00:31:17.266093Z","caller":"traceutil/trace.go:171","msg":"trace[1498980170] range","detail":"{range_begin:/registry/pods/openstack/keystone-db-init-72znr; range_end:; response_count:1; response_revision:5407; }","duration":"1.435578699s","start":"2026-04-22T00:31:15.830506Z","end":"2026-04-22T00:31:17.266085Z","steps":["trace[1498980170] 'agreement among raft nodes before linearized reading' (duration: 1.435498798s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.266116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:15.830485Z","time spent":"1.4356244s","remote":"127.0.0.1:52094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":7124,"request content":"key:\"/registry/pods/openstack/keystone-db-init-72znr\" "} {"level":"warn","ts":"2026-04-22T00:31:17.266304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.782953463s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-22T00:31:17.266329Z","caller":"traceutil/trace.go:171","msg":"trace[1894229736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5407; }","duration":"1.783000764s","start":"2026-04-22T00:31:15.483321Z","end":"2026-04-22T00:31:17.266322Z","steps":["trace[1894229736] 'agreement among raft nodes before linearized reading' (duration: 1.782926483s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.26635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:15.48331Z","time spent":"1.783035505s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-22T00:31:17.266443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.788719252s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.266463Z","caller":"traceutil/trace.go:171","msg":"trace[1371790060] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5407; }","duration":"1.788760413s","start":"2026-04-22T00:31:15.477695Z","end":"2026-04-22T00:31:17.266455Z","steps":["trace[1371790060] 'agreement among raft nodes before linearized reading' (duration: 1.788730612s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.26649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:15.477655Z","time spent":"1.788829024s","remote":"127.0.0.1:52162","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"warn","ts":"2026-04-22T00:31:17.26684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.544343893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.266885Z","caller":"traceutil/trace.go:171","msg":"trace[465518752] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:5407; }","duration":"2.544449895s","start":"2026-04-22T00:31:14.722424Z","end":"2026-04-22T00:31:17.266874Z","steps":["trace[465518752] 'agreement among raft nodes before linearized reading' (duration: 2.544322783s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.266915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:14.722343Z","time spent":"2.544561897s","remote":"127.0.0.1:59020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:31:17.267098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.851995141s","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-04-22T00:31:17.267133Z","caller":"traceutil/trace.go:171","msg":"trace[1560272414] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5407; }","duration":"1.852081182s","start":"2026-04-22T00:31:15.415043Z","end":"2026-04-22T00:31:17.267124Z","steps":["trace[1560272414] 'agreement among raft nodes before linearized reading' (duration: 1.852031581s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.267165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:15.415005Z","time spent":"1.852152283s","remote":"127.0.0.1:35054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:31:17.267388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.406404968s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-22T00:31:17.267428Z","caller":"traceutil/trace.go:171","msg":"trace[699130454] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5407; }","duration":"2.406482019s","start":"2026-04-22T00:31:14.860935Z","end":"2026-04-22T00:31:17.267417Z","steps":["trace[699130454] 'agreement among raft nodes before linearized reading' (duration: 2.406369417s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.267564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:14.860914Z","time spent":"2.406625681s","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-22T00:31:17.267651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.885335424s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.267688Z","caller":"traceutil/trace.go:171","msg":"trace[1268446120] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5407; }","duration":"2.885406486s","start":"2026-04-22T00:31:14.382271Z","end":"2026-04-22T00:31:17.267678Z","steps":["trace[1268446120] 'agreement among raft nodes before linearized reading' (duration: 2.885349595s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.267716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:14.382256Z","time spent":"2.885453456s","remote":"127.0.0.1:45836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:31:17.267874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.885587109s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-22T00:31:17.267902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.886668567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:31:17.26794Z","caller":"traceutil/trace.go:171","msg":"trace[1884000239] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:5407; }","duration":"2.886775759s","start":"2026-04-22T00:31:14.381155Z","end":"2026-04-22T00:31:17.267931Z","steps":["trace[1884000239] 'agreement among raft nodes before linearized reading' (duration: 2.884413169s)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:17.267921Z","caller":"traceutil/trace.go:171","msg":"trace[1765307794] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5407; }","duration":"2.885685711s","start":"2026-04-22T00:31:14.382225Z","end":"2026-04-22T00:31:17.267911Z","steps":["trace[1765307794] 'agreement among raft nodes before linearized reading' (duration: 2.885592259s)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:17.26797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:14.381128Z","time spent":"2.886831301s","remote":"127.0.0.1:59044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-04-22T00:31:17.267973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:31:14.382181Z","time spent":"2.885784602s","remote":"127.0.0.1:52434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":6,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-04-22T00:31:38.436834Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2922} {"level":"info","ts":"2026-04-22T00:31:38.510395Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2922,"took":"72.037153ms","hash":910348008,"current-db-size-bytes":53805056,"current-db-size":"54 MB","current-db-size-in-use-bytes":29147136,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-22T00:31:38.510458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":910348008,"revision":2922,"compact-revision":-1} {"level":"info","ts":"2026-04-22T00:31:41.540952Z","caller":"traceutil/trace.go:171","msg":"trace[1828046410] transaction","detail":"{read_only:false; response_revision:5585; number_of_response:1; }","duration":"173.427864ms","start":"2026-04-22T00:31:41.367487Z","end":"2026-04-22T00:31:41.540914Z","steps":["trace[1828046410] 'process raft request' (duration: 173.15243ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:41.542609Z","caller":"traceutil/trace.go:171","msg":"trace[1623963007] linearizableReadLoop","detail":"{readStateIndex:5786; appliedIndex:5783; }","duration":"142.973358ms","start":"2026-04-22T00:31:41.399604Z","end":"2026-04-22T00:31:41.542578Z","steps":["trace[1623963007] 'read index received' (duration: 140.978225ms)","trace[1623963007] 'applied index is now lower than readState.Index' (duration: 1.994233ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:31:41.542729Z","caller":"traceutil/trace.go:171","msg":"trace[242779674] transaction","detail":"{read_only:false; response_revision:5587; number_of_response:1; }","duration":"167.394394ms","start":"2026-04-22T00:31:41.375302Z","end":"2026-04-22T00:31:41.542697Z","steps":["trace[242779674] 'process raft request' (duration: 167.224691ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:41.54271Z","caller":"traceutil/trace.go:171","msg":"trace[89770835] transaction","detail":"{read_only:false; response_revision:5586; number_of_response:1; }","duration":"168.592584ms","start":"2026-04-22T00:31:41.374076Z","end":"2026-04-22T00:31:41.542668Z","steps":["trace[89770835] 'process raft request' (duration: 168.311829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:41.543001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.367794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-22T00:31:41.543054Z","caller":"traceutil/trace.go:171","msg":"trace[1534264670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5587; }","duration":"143.500367ms","start":"2026-04-22T00:31:41.399545Z","end":"2026-04-22T00:31:41.543045Z","steps":["trace[1534264670] 'agreement among raft nodes before linearized reading' (duration: 143.244493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:41.546128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.983851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-22T00:31:41.546391Z","caller":"traceutil/trace.go:171","msg":"trace[1561873898] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5587; }","duration":"142.278976ms","start":"2026-04-22T00:31:41.404083Z","end":"2026-04-22T00:31:41.546362Z","steps":["trace[1561873898] 'agreement among raft nodes before linearized reading' (duration: 141.790728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:41.546838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.015648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T00:31:41.546878Z","caller":"traceutil/trace.go:171","msg":"trace[1054881799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5587; }","duration":"119.08064ms","start":"2026-04-22T00:31:41.427788Z","end":"2026-04-22T00:31:41.546869Z","steps":["trace[1054881799] 'agreement among raft nodes before linearized reading' (duration: 118.972828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:41.546919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.345558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-22T00:31:41.546973Z","caller":"traceutil/trace.go:171","msg":"trace[664791426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5587; }","duration":"136.433449ms","start":"2026-04-22T00:31:41.410527Z","end":"2026-04-22T00:31:41.546961Z","steps":["trace[664791426] 'agreement among raft nodes before linearized reading' (duration: 136.316907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:31:41.547079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.894153ms","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":"warn","ts":"2026-04-22T00:31:41.547124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.922706ms","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-04-22T00:31:41.547139Z","caller":"traceutil/trace.go:171","msg":"trace[2056956397] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5587; }","duration":"117.002185ms","start":"2026-04-22T00:31:41.430109Z","end":"2026-04-22T00:31:41.547111Z","steps":["trace[2056956397] 'agreement among raft nodes before linearized reading' (duration: 116.891853ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:41.547167Z","caller":"traceutil/trace.go:171","msg":"trace[1810731272] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5587; }","duration":"140.003768ms","start":"2026-04-22T00:31:41.407156Z","end":"2026-04-22T00:31:41.54716Z","steps":["trace[1810731272] 'agreement among raft nodes before linearized reading' (duration: 139.922237ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:33:06.113002Z","caller":"traceutil/trace.go:171","msg":"trace[2050569452] transaction","detail":"{read_only:false; response_revision:6077; number_of_response:1; }","duration":"173.400712ms","start":"2026-04-22T00:33:05.939576Z","end":"2026-04-22T00:33:06.112977Z","steps":["trace[2050569452] 'process raft request' (duration: 173.24292ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:33:06.115726Z","caller":"traceutil/trace.go:171","msg":"trace[261308105] linearizableReadLoop","detail":"{readStateIndex:6296; appliedIndex:6293; }","duration":"100.864634ms","start":"2026-04-22T00:33:06.014847Z","end":"2026-04-22T00:33:06.115712Z","steps":["trace[261308105] 'read index received' (duration: 98.00449ms)","trace[261308105] 'applied index is now lower than readState.Index' (duration: 2.859144ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:33:06.115808Z","caller":"traceutil/trace.go:171","msg":"trace[1356827238] transaction","detail":"{read_only:false; response_revision:6078; number_of_response:1; }","duration":"175.84623ms","start":"2026-04-22T00:33:05.939955Z","end":"2026-04-22T00:33:06.115801Z","steps":["trace[1356827238] 'process raft request' (duration: 175.671327ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:33:06.115953Z","caller":"traceutil/trace.go:171","msg":"trace[174476010] transaction","detail":"{read_only:false; response_revision:6079; number_of_response:1; }","duration":"175.717587ms","start":"2026-04-22T00:33:05.940203Z","end":"2026-04-22T00:33:06.11592Z","steps":["trace[174476010] 'process raft request' (duration: 175.486584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:33:06.116016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.139888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T00:33:06.116505Z","caller":"traceutil/trace.go:171","msg":"trace[1168748304] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6079; }","duration":"101.681546ms","start":"2026-04-22T00:33:06.014799Z","end":"2026-04-22T00:33:06.116481Z","steps":["trace[1168748304] 'agreement among raft nodes before linearized reading' (duration: 101.102917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:33:06.118381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.831783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T00:33:06.118437Z","caller":"traceutil/trace.go:171","msg":"trace[1007849379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6079; }","duration":"100.900744ms","start":"2026-04-22T00:33:06.017526Z","end":"2026-04-22T00:33:06.118426Z","steps":["trace[1007849379] 'agreement among raft nodes before linearized reading' (duration: 100.778822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:34:02.810658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.644599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:34:02.810768Z","caller":"traceutil/trace.go:171","msg":"trace[194225230] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:6559; }","duration":"109.825401ms","start":"2026-04-22T00:34:02.700918Z","end":"2026-04-22T00:34:02.810744Z","steps":["trace[194225230] 'count revisions from in-memory index tree' (duration: 109.580437ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:35.249198Z","caller":"traceutil/trace.go:171","msg":"trace[1223640075] transaction","detail":"{read_only:false; response_revision:7407; number_of_response:1; }","duration":"345.025733ms","start":"2026-04-22T00:36:34.90413Z","end":"2026-04-22T00:36:35.249156Z","steps":["trace[1223640075] 'process raft request' (duration: 344.667229ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:35.249776Z","caller":"traceutil/trace.go:171","msg":"trace[1707414344] transaction","detail":"{read_only:false; response_revision:7408; number_of_response:1; }","duration":"341.446939ms","start":"2026-04-22T00:36:34.908317Z","end":"2026-04-22T00:36:35.249764Z","steps":["trace[1707414344] 'process raft request' (duration: 341.284113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:35.249856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:34.908286Z","time spent":"341.543012ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:36:35.250009Z","caller":"traceutil/trace.go:171","msg":"trace[2108506637] linearizableReadLoop","detail":"{readStateIndex:7676; appliedIndex:7673; }","duration":"287.567107ms","start":"2026-04-22T00:36:34.962406Z","end":"2026-04-22T00:36:35.249973Z","steps":["trace[2108506637] 'read index received' (duration: 286.616742ms)","trace[2108506637] 'applied index is now lower than readState.Index' (duration: 948.495µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:36:35.250177Z","caller":"traceutil/trace.go:171","msg":"trace[1210273277] transaction","detail":"{read_only:false; response_revision:7409; number_of_response:1; }","duration":"337.785071ms","start":"2026-04-22T00:36:34.912379Z","end":"2026-04-22T00:36:35.250164Z","steps":["trace[1210273277] 'process raft request' (duration: 337.352274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:35.250334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:34.912341Z","time spent":"337.867573ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:36:35.250343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.03683ms","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-04-22T00:36:35.250383Z","caller":"traceutil/trace.go:171","msg":"trace[2102693149] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7409; }","duration":"143.123802ms","start":"2026-04-22T00:36:35.107246Z","end":"2026-04-22T00:36:35.250369Z","steps":["trace[2102693149] 'agreement among raft nodes before linearized reading' (duration: 143.007888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:35.249504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:36:34.904097Z","time spent":"345.297464ms","remote":"127.0.0.1:52190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:36:35.250753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.228546ms","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-04-22T00:36:35.250782Z","caller":"traceutil/trace.go:171","msg":"trace[277530174] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7409; }","duration":"114.258947ms","start":"2026-04-22T00:36:35.136517Z","end":"2026-04-22T00:36:35.250776Z","steps":["trace[277530174] 'agreement among raft nodes before linearized reading' (duration: 113.947135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:36:35.251245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.828605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T00:36:35.251298Z","caller":"traceutil/trace.go:171","msg":"trace[942601903] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:7409; }","duration":"288.94435ms","start":"2026-04-22T00:36:34.962339Z","end":"2026-04-22T00:36:35.251284Z","steps":["trace[942601903] 'agreement among raft nodes before linearized reading' (duration: 287.948042ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:36:38.442637Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5570} {"level":"info","ts":"2026-04-22T00:36:38.521768Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5570,"took":"77.789027ms","hash":713667923,"current-db-size-bytes":53805056,"current-db-size":"54 MB","current-db-size-in-use-bytes":18317312,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-22T00:36:38.521842Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":713667923,"revision":5570,"compact-revision":2922} {"level":"info","ts":"2026-04-22T00:36:39.156527Z","caller":"traceutil/trace.go:171","msg":"trace[1250939297] transaction","detail":"{read_only:false; response_revision:7429; number_of_response:1; }","duration":"205.066803ms","start":"2026-04-22T00:36:38.951431Z","end":"2026-04-22T00:36:39.156498Z","steps":["trace[1250939297] 'process raft request' (duration: 204.936938ms)"],"step_count":1}