{"level":"warn","ts":"2026-05-19T04:58:50.94652Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T04:58:50.946618Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-05-19T04:58:50.946695Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T04:58:50.946708Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-19T04:58:50.946725Z","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-05-19T04:58:50.947601Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-05-19T04:58:50.947687Z","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.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-05-19T04:58:50.952133Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.233672ms"} {"level":"info","ts":"2026-05-19T04:58:50.964412Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-05-19T04:58:50.964524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T04:58:50.964551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-05-19T04:58:50.964563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T04:58:50.964576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-05-19T04:58:50.964613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-05-19T04:58:50.973734Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T04:58:50.975267Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T04:58:50.976686Z","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-05-19T04:58:50.978712Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T04:58:50.979667Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T04:58:50.979859Z","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-05-19T04:58:50.979905Z","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-05-19T04:58:50.979916Z","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-05-19T04:58:50.980134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-05-19T04:58:50.980212Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-19T04:58:50.986366Z","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-05-19T04:58:50.98647Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-19T04:58:50.986556Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-19T04:58:50.987003Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T04:58:50.987044Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T04:58:51.865097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T04:58:51.865171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T04:58:51.865216Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-05-19T04:58:51.865236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-05-19T04:58:51.865246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-19T04:58:51.865262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-05-19T04:58:51.865275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-19T04:58:52.218561Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T04:58:52.218911Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T04:58:52.219068Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T04:58:52.219134Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T04:58:52.219298Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T04:58:52.219376Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T04:58:52.222591Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T04:58:52.223326Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-05-19T04:58:52.237111Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T04:58:52.237226Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T04:58:52.237256Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T04:59:08.818241Z","caller":"traceutil/trace.go:171","msg":"trace[927707878] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"119.978316ms","start":"2026-05-19T04:59:08.698248Z","end":"2026-05-19T04:59:08.818226Z","steps":["trace[927707878] 'process raft request' (duration: 119.887022ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T04:59:28.153166Z","caller":"traceutil/trace.go:171","msg":"trace[1494463311] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"104.8074ms","start":"2026-05-19T04:59:28.048332Z","end":"2026-05-19T04:59:28.153139Z","steps":["trace[1494463311] 'process raft request' (duration: 104.250084ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T04:59:28.163883Z","caller":"traceutil/trace.go:171","msg":"trace[1714113621] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"104.532798ms","start":"2026-05-19T04:59:28.059328Z","end":"2026-05-19T04:59:28.163861Z","steps":["trace[1714113621] 'process raft request' (duration: 104.173881ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T04:59:28.346643Z","caller":"traceutil/trace.go:171","msg":"trace[306644651] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"131.789816ms","start":"2026-05-19T04:59:28.21483Z","end":"2026-05-19T04:59:28.34662Z","steps":["trace[306644651] 'process raft request' (duration: 131.650699ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T04:59:29.198476Z","caller":"traceutil/trace.go:171","msg":"trace[973297857] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"137.921164ms","start":"2026-05-19T04:59:29.060536Z","end":"2026-05-19T04:59:29.198457Z","steps":["trace[973297857] 'read index received' (duration: 137.3996ms)","trace[973297857] 'applied index is now lower than readState.Index' (duration: 520.824µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T04:59:29.198562Z","caller":"traceutil/trace.go:171","msg":"trace[1063744410] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"415.651032ms","start":"2026-05-19T04:59:28.782902Z","end":"2026-05-19T04:59:29.198553Z","steps":["trace[1063744410] 'process raft request' (duration: 415.156859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:29.198994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.440409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hc59k\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-19T04:59:29.199122Z","caller":"traceutil/trace.go:171","msg":"trace[761213893] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hc59k; range_end:; response_count:1; response_revision:620; }","duration":"138.614137ms","start":"2026-05-19T04:59:29.060486Z","end":"2026-05-19T04:59:29.1991Z","steps":["trace[761213893] 'agreement among raft nodes before linearized reading' (duration: 138.392837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:29.199128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T04:59:28.782873Z","time spent":"415.707845ms","remote":"127.0.0.1:47434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T04:59:29.689113Z","caller":"traceutil/trace.go:171","msg":"trace[150203222] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"473.083879ms","start":"2026-05-19T04:59:29.215987Z","end":"2026-05-19T04:59:29.689071Z","steps":["trace[150203222] 'process raft request' (duration: 472.638728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:29.689529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T04:59:29.215967Z","time spent":"473.220485ms","remote":"127.0.0.1:47512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T04:59:29.694145Z","caller":"traceutil/trace.go:171","msg":"trace[340588326] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"439.658654ms","start":"2026-05-19T04:59:29.254446Z","end":"2026-05-19T04:59:29.694104Z","steps":["trace[340588326] 'process raft request' (duration: 438.947651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:29.6943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T04:59:29.254429Z","time spent":"439.79056ms","remote":"127.0.0.1:47578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T04:59:31.345362Z","caller":"traceutil/trace.go:171","msg":"trace[557847583] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"105.624968ms","start":"2026-05-19T04:59:31.239722Z","end":"2026-05-19T04:59:31.345347Z","steps":["trace[557847583] 'read index received' (duration: 105.480501ms)","trace[557847583] 'applied index is now lower than readState.Index' (duration: 143.767µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T04:59:31.345445Z","caller":"traceutil/trace.go:171","msg":"trace[312350382] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"131.141626ms","start":"2026-05-19T04:59:31.214296Z","end":"2026-05-19T04:59:31.345438Z","steps":["trace[312350382] 'process raft request' (duration: 130.957018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:31.345671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.915801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T04:59:31.345762Z","caller":"traceutil/trace.go:171","msg":"trace[600336937] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:643; }","duration":"106.064068ms","start":"2026-05-19T04:59:31.239679Z","end":"2026-05-19T04:59:31.345743Z","steps":["trace[600336937] 'agreement among raft nodes before linearized reading' (duration: 105.867369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:31.345793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.834678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T04:59:31.345867Z","caller":"traceutil/trace.go:171","msg":"trace[1912908727] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:643; }","duration":"106.037197ms","start":"2026-05-19T04:59:31.239812Z","end":"2026-05-19T04:59:31.345849Z","steps":["trace[1912908727] 'agreement among raft nodes before linearized reading' (duration: 105.729973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:31.346436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.31043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T04:59:31.346481Z","caller":"traceutil/trace.go:171","msg":"trace[2036149532] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:643; }","duration":"106.371543ms","start":"2026-05-19T04:59:31.240099Z","end":"2026-05-19T04:59:31.34647Z","steps":["trace[2036149532] 'agreement among raft nodes before linearized reading' (duration: 106.30732ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:44.447612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.230975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dg85d\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-19T04:59:44.447704Z","caller":"traceutil/trace.go:171","msg":"trace[466451253] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dg85d; range_end:; response_count:1; response_revision:775; }","duration":"296.376752ms","start":"2026-05-19T04:59:44.151305Z","end":"2026-05-19T04:59:44.447682Z","steps":["trace[466451253] 'range keys from in-memory index tree' (duration: 296.067617ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T04:59:44.447749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.656364ms","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-05-19T04:59:44.448038Z","caller":"traceutil/trace.go:171","msg":"trace[132992180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:775; }","duration":"185.990251ms","start":"2026-05-19T04:59:44.262018Z","end":"2026-05-19T04:59:44.448008Z","steps":["trace[132992180] 'range keys from in-memory index tree' (duration: 185.417883ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:00:12.870685Z","caller":"traceutil/trace.go:171","msg":"trace[1619956614] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"223.679258ms","start":"2026-05-19T05:00:12.646978Z","end":"2026-05-19T05:00:12.870657Z","steps":["trace[1619956614] 'process raft request' (duration: 223.518588ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:00:12.897489Z","caller":"traceutil/trace.go:171","msg":"trace[1329030410] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"249.01918ms","start":"2026-05-19T05:00:12.648439Z","end":"2026-05-19T05:00:12.897459Z","steps":["trace[1329030410] 'process raft request' (duration: 242.54005ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:00:35.642239Z","caller":"traceutil/trace.go:171","msg":"trace[1059459992] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"161.719061ms","start":"2026-05-19T05:00:35.480488Z","end":"2026-05-19T05:00:35.642207Z","steps":["trace[1059459992] 'process raft request' (duration: 132.129901ms)","trace[1059459992] 'compare' (duration: 29.444808ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:01:00.399233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.845981ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T05:01:00.399354Z","caller":"traceutil/trace.go:171","msg":"trace[1976012408] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"302.499182ms","start":"2026-05-19T05:01:00.096838Z","end":"2026-05-19T05:01:00.399337Z","steps":["trace[1976012408] 'read index received' (duration: 172.17484ms)","trace[1976012408] 'applied index is now lower than readState.Index' (duration: 130.323112ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:01:00.399494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.658365ms","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-05-19T05:01:00.399529Z","caller":"traceutil/trace.go:171","msg":"trace[1269222850] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1856; }","duration":"302.733617ms","start":"2026-05-19T05:01:00.096785Z","end":"2026-05-19T05:01:00.399519Z","steps":["trace[1269222850] 'agreement among raft nodes before linearized reading' (duration: 302.598164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:00.39957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:01:00.096761Z","time spent":"302.800529ms","remote":"127.0.0.1:45130","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-19T05:01:00.399542Z","caller":"traceutil/trace.go:171","msg":"trace[189364432] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"464.789917ms","start":"2026-05-19T05:00:59.934689Z","end":"2026-05-19T05:01:00.399479Z","steps":["trace[189364432] 'process raft request' (duration: 334.411224ms)","trace[189364432] 'compare' (duration: 129.637276ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:01:00.399747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:00:59.934664Z","time spent":"464.995881ms","remote":"127.0.0.1:47412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":967,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T05:01:00.562068Z","caller":"traceutil/trace.go:171","msg":"trace[2093734113] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"144.50919ms","start":"2026-05-19T05:01:00.417534Z","end":"2026-05-19T05:01:00.562044Z","steps":["trace[2093734113] 'read index received' (duration: 144.320855ms)","trace[2093734113] 'applied index is now lower than readState.Index' (duration: 187.435µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:01:00.562283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.745586ms","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-05-19T05:01:00.562168Z","caller":"traceutil/trace.go:171","msg":"trace[446118667] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"145.202786ms","start":"2026-05-19T05:01:00.416936Z","end":"2026-05-19T05:01:00.562139Z","steps":["trace[446118667] 'process raft request' (duration: 144.985351ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:01:00.562324Z","caller":"traceutil/trace.go:171","msg":"trace[2058639698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1857; }","duration":"144.843108ms","start":"2026-05-19T05:01:00.417471Z","end":"2026-05-19T05:01:00.562314Z","steps":["trace[2058639698] 'agreement among raft nodes before linearized reading' (duration: 144.692684ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:01:00.8374Z","caller":"traceutil/trace.go:171","msg":"trace[1762399267] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"267.20317ms","start":"2026-05-19T05:01:00.570182Z","end":"2026-05-19T05:01:00.837385Z","steps":["trace[1762399267] 'process raft request' (duration: 260.317706ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:01:00.858546Z","caller":"traceutil/trace.go:171","msg":"trace[1412518490] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1931; }","duration":"160.460567ms","start":"2026-05-19T05:01:00.698055Z","end":"2026-05-19T05:01:00.858516Z","steps":["trace[1412518490] 'read index received' (duration: 132.408608ms)","trace[1412518490] 'applied index is now lower than readState.Index' (duration: 28.050259ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:01:00.858712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.644122ms","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-05-19T05:01:00.85877Z","caller":"traceutil/trace.go:171","msg":"trace[1893796680] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1859; }","duration":"160.735193ms","start":"2026-05-19T05:01:00.69802Z","end":"2026-05-19T05:01:00.858755Z","steps":["trace[1893796680] 'agreement among raft nodes before linearized reading' (duration: 160.57638ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:01:18.169118Z","caller":"traceutil/trace.go:171","msg":"trace[1476174640] linearizableReadLoop","detail":"{readStateIndex:2078; appliedIndex:2077; }","duration":"123.68361ms","start":"2026-05-19T05:01:18.045419Z","end":"2026-05-19T05:01:18.169102Z","steps":["trace[1476174640] 'read index received' (duration: 123.496504ms)","trace[1476174640] 'applied index is now lower than readState.Index' (duration: 186.636µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:01:18.169182Z","caller":"traceutil/trace.go:171","msg":"trace[646340974] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"158.474161ms","start":"2026-05-19T05:01:18.010689Z","end":"2026-05-19T05:01:18.169163Z","steps":["trace[646340974] 'process raft request' (duration: 158.319667ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:18.169294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.867915ms","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-05-19T05:01:18.169333Z","caller":"traceutil/trace.go:171","msg":"trace[746181502] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2000; }","duration":"123.947308ms","start":"2026-05-19T05:01:18.045376Z","end":"2026-05-19T05:01:18.169323Z","steps":["trace[746181502] 'agreement among raft nodes before linearized reading' (duration: 123.791263ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:01:39.444125Z","caller":"traceutil/trace.go:171","msg":"trace[690477897] linearizableReadLoop","detail":"{readStateIndex:2203; appliedIndex:2200; }","duration":"109.903393ms","start":"2026-05-19T05:01:39.334199Z","end":"2026-05-19T05:01:39.444103Z","steps":["trace[690477897] 'read index received' (duration: 91.970536ms)","trace[690477897] 'applied index is now lower than readState.Index' (duration: 17.931917ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:01:39.444195Z","caller":"traceutil/trace.go:171","msg":"trace[96462996] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"114.397488ms","start":"2026-05-19T05:01:39.329768Z","end":"2026-05-19T05:01:39.444166Z","steps":["trace[96462996] 'process raft request' (duration: 114.286274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:39.444276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.052158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T05:01:39.444316Z","caller":"traceutil/trace.go:171","msg":"trace[299908798] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:2121; }","duration":"110.13011ms","start":"2026-05-19T05:01:39.334173Z","end":"2026-05-19T05:01:39.444304Z","steps":["trace[299908798] 'agreement among raft nodes before linearized reading' (duration: 110.051247ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:01:39.444151Z","caller":"traceutil/trace.go:171","msg":"trace[1075148062] transaction","detail":"{read_only:false; response_revision:2120; number_of_response:1; }","duration":"116.233156ms","start":"2026-05-19T05:01:39.327892Z","end":"2026-05-19T05:01:39.444126Z","steps":["trace[1075148062] 'process raft request' (duration: 116.03717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:39.444569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.853687ms","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-05-19T05:01:39.444661Z","caller":"traceutil/trace.go:171","msg":"trace[776456902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2121; }","duration":"107.968461ms","start":"2026-05-19T05:01:39.33664Z","end":"2026-05-19T05:01:39.444609Z","steps":["trace[776456902] 'agreement among raft nodes before linearized reading' (duration: 107.754844ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:41.275598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.955918ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-19T05:01:41.275711Z","caller":"traceutil/trace.go:171","msg":"trace[1635890648] linearizableReadLoop","detail":"{readStateIndex:2209; appliedIndex:2208; }","duration":"517.083512ms","start":"2026-05-19T05:01:40.75861Z","end":"2026-05-19T05:01:41.275694Z","steps":["trace[1635890648] 'read index received' (duration: 12.956998ms)","trace[1635890648] 'applied index is now lower than readState.Index' (duration: 504.125414ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:01:41.276218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.624308ms","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-05-19T05:01:41.276318Z","caller":"traceutil/trace.go:171","msg":"trace[1225827374] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2126; }","duration":"512.748503ms","start":"2026-05-19T05:01:40.763551Z","end":"2026-05-19T05:01:41.276299Z","steps":["trace[1225827374] 'agreement among raft nodes before linearized reading' (duration: 512.520855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:41.276356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:01:40.76354Z","time spent":"512.806364ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T05:01:41.27626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.650611ms","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-05-19T05:01:41.276447Z","caller":"traceutil/trace.go:171","msg":"trace[1150889811] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2126; }","duration":"517.866098ms","start":"2026-05-19T05:01:40.758554Z","end":"2026-05-19T05:01:41.27642Z","steps":["trace[1150889811] 'agreement among raft nodes before linearized reading' (duration: 517.435774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:41.276509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:01:40.758533Z","time spent":"517.960271ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-19T05:01:41.467219Z","caller":"traceutil/trace.go:171","msg":"trace[893558008] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"185.409066ms","start":"2026-05-19T05:01:41.281784Z","end":"2026-05-19T05:01:41.467193Z","steps":["trace[893558008] 'process raft request' (duration: 159.538525ms)","trace[893558008] 'compare' (duration: 25.297793ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:01:41.467276Z","caller":"traceutil/trace.go:171","msg":"trace[1964122146] linearizableReadLoop","detail":"{readStateIndex:2211; appliedIndex:2209; }","duration":"143.541665ms","start":"2026-05-19T05:01:41.323709Z","end":"2026-05-19T05:01:41.467251Z","steps":["trace[1964122146] 'read index received' (duration: 4.63019ms)","trace[1964122146] 'applied index is now lower than readState.Index' (duration: 138.909165ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:01:41.467878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.151225ms","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-05-19T05:01:41.467931Z","caller":"traceutil/trace.go:171","msg":"trace[1688374574] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2128; }","duration":"144.233348ms","start":"2026-05-19T05:01:41.323682Z","end":"2026-05-19T05:01:41.467915Z","steps":["trace[1688374574] 'agreement among raft nodes before linearized reading' (duration: 143.657529ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:01:41.670991Z","caller":"traceutil/trace.go:171","msg":"trace[1924398227] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"218.624927ms","start":"2026-05-19T05:01:41.452339Z","end":"2026-05-19T05:01:41.670964Z","steps":["trace[1924398227] 'process raft request' (duration: 203.95589ms)","trace[1924398227] 'compare' (duration: 14.45794ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:01:41.671149Z","caller":"traceutil/trace.go:171","msg":"trace[915398428] linearizableReadLoop","detail":"{readStateIndex:2214; appliedIndex:2212; }","duration":"188.866818ms","start":"2026-05-19T05:01:41.482271Z","end":"2026-05-19T05:01:41.671138Z","steps":["trace[915398428] 'read index received' (duration: 174.123699ms)","trace[915398428] 'applied index is now lower than readState.Index' (duration: 14.742409ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:01:41.671224Z","caller":"traceutil/trace.go:171","msg":"trace[1704633719] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"218.524953ms","start":"2026-05-19T05:01:41.452692Z","end":"2026-05-19T05:01:41.671217Z","steps":["trace[1704633719] 'process raft request' (duration: 218.227463ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:01:41.671567Z","caller":"traceutil/trace.go:171","msg":"trace[177749110] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"144.351452ms","start":"2026-05-19T05:01:41.527209Z","end":"2026-05-19T05:01:41.67156Z","steps":["trace[177749110] 'process raft request' (duration: 143.884417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:41.671681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.672422ms","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-05-19T05:01:41.671741Z","caller":"traceutil/trace.go:171","msg":"trace[127923027] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2132; }","duration":"144.743944ms","start":"2026-05-19T05:01:41.526985Z","end":"2026-05-19T05:01:41.671729Z","steps":["trace[127923027] 'agreement among raft nodes before linearized reading' (duration: 144.533858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:01:41.671785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.50464ms","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-05-19T05:01:41.671862Z","caller":"traceutil/trace.go:171","msg":"trace[1943940656] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2132; }","duration":"189.606363ms","start":"2026-05-19T05:01:41.482237Z","end":"2026-05-19T05:01:41.671844Z","steps":["trace[1943940656] 'agreement among raft nodes before linearized reading' (duration: 189.425647ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:02:40.084761Z","caller":"traceutil/trace.go:171","msg":"trace[392844841] transaction","detail":"{read_only:false; response_revision:2547; number_of_response:1; }","duration":"330.794409ms","start":"2026-05-19T05:02:39.753937Z","end":"2026-05-19T05:02:40.084731Z","steps":["trace[392844841] 'process raft request' (duration: 328.218197ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:02:40.085045Z","caller":"traceutil/trace.go:171","msg":"trace[693722442] transaction","detail":"{read_only:false; response_revision:2548; number_of_response:1; }","duration":"201.482235ms","start":"2026-05-19T05:02:39.883539Z","end":"2026-05-19T05:02:40.085021Z","steps":["trace[693722442] 'process raft request' (duration: 201.060038ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:02:40.08505Z","caller":"traceutil/trace.go:171","msg":"trace[231301568] transaction","detail":"{read_only:false; response_revision:2550; number_of_response:1; }","duration":"144.099008ms","start":"2026-05-19T05:02:39.940894Z","end":"2026-05-19T05:02:40.084993Z","steps":["trace[231301568] 'process raft request' (duration: 143.832757ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:02:40.085123Z","caller":"traceutil/trace.go:171","msg":"trace[657698619] transaction","detail":"{read_only:false; response_revision:2549; number_of_response:1; }","duration":"177.263196ms","start":"2026-05-19T05:02:39.907836Z","end":"2026-05-19T05:02:40.0851Z","steps":["trace[657698619] 'process raft request' (duration: 176.841659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:02:40.085807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:02:39.753926Z","time spent":"330.938644ms","remote":"127.0.0.1:47616","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-05-19T05:03:12.294974Z","caller":"traceutil/trace.go:171","msg":"trace[654024049] linearizableReadLoop","detail":"{readStateIndex:2827; appliedIndex:2826; }","duration":"109.289966ms","start":"2026-05-19T05:03:12.185653Z","end":"2026-05-19T05:03:12.294943Z","steps":["trace[654024049] 'read index received' (duration: 109.055206ms)","trace[654024049] 'applied index is now lower than readState.Index' (duration: 233.39µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:03:12.295183Z","caller":"traceutil/trace.go:171","msg":"trace[2010222071] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"191.548295ms","start":"2026-05-19T05:03:12.103491Z","end":"2026-05-19T05:03:12.295039Z","steps":["trace[2010222071] 'process raft request' (duration: 191.17415ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:03:12.295228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.541796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:03:12.295448Z","caller":"traceutil/trace.go:171","msg":"trace[1081001491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2723; }","duration":"109.808917ms","start":"2026-05-19T05:03:12.18562Z","end":"2026-05-19T05:03:12.295429Z","steps":["trace[1081001491] 'agreement among raft nodes before linearized reading' (duration: 109.500074ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:03:18.057845Z","caller":"traceutil/trace.go:171","msg":"trace[400602440] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"195.637016ms","start":"2026-05-19T05:03:17.862175Z","end":"2026-05-19T05:03:18.057812Z","steps":["trace[400602440] 'process raft request' (duration: 189.398428ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:04:41.418511Z","caller":"traceutil/trace.go:171","msg":"trace[1391190251] transaction","detail":"{read_only:false; response_revision:3193; number_of_response:1; }","duration":"104.162991ms","start":"2026-05-19T05:04:41.314324Z","end":"2026-05-19T05:04:41.418487Z","steps":["trace[1391190251] 'process raft request' (duration: 103.98865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:04:46.818423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.70069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T05:04:46.818674Z","caller":"traceutil/trace.go:171","msg":"trace[1172334949] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:3217; }","duration":"174.009752ms","start":"2026-05-19T05:04:46.644626Z","end":"2026-05-19T05:04:46.818636Z","steps":["trace[1172334949] 'count revisions from in-memory index tree' (duration: 173.578709ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:04:46.909481Z","caller":"traceutil/trace.go:171","msg":"trace[1875724870] transaction","detail":"{read_only:false; response_revision:3218; number_of_response:1; }","duration":"225.859647ms","start":"2026-05-19T05:04:46.683602Z","end":"2026-05-19T05:04:46.909461Z","steps":["trace[1875724870] 'process raft request' (duration: 225.707837ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:04:46.918529Z","caller":"traceutil/trace.go:171","msg":"trace[1007517927] transaction","detail":"{read_only:false; response_revision:3219; number_of_response:1; }","duration":"149.177052ms","start":"2026-05-19T05:04:46.769337Z","end":"2026-05-19T05:04:46.918514Z","steps":["trace[1007517927] 'process raft request' (duration: 149.096312ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:04:46.99693Z","caller":"traceutil/trace.go:171","msg":"trace[916297998] transaction","detail":"{read_only:false; response_revision:3220; number_of_response:1; }","duration":"226.973872ms","start":"2026-05-19T05:04:46.769899Z","end":"2026-05-19T05:04:46.996873Z","steps":["trace[916297998] 'process raft request' (duration: 148.60725ms)","trace[916297998] 'compare' (duration: 78.05017ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:05:11.334612Z","caller":"traceutil/trace.go:171","msg":"trace[1787155530] transaction","detail":"{read_only:false; response_revision:3425; number_of_response:1; }","duration":"183.405282ms","start":"2026-05-19T05:05:11.151169Z","end":"2026-05-19T05:05:11.334574Z","steps":["trace[1787155530] 'process raft request' (duration: 180.774725ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:11.359521Z","caller":"traceutil/trace.go:171","msg":"trace[1791400482] linearizableReadLoop","detail":"{readStateIndex:3559; appliedIndex:3556; }","duration":"186.662644ms","start":"2026-05-19T05:05:11.172815Z","end":"2026-05-19T05:05:11.359477Z","steps":["trace[1791400482] 'read index received' (duration: 159.105596ms)","trace[1791400482] 'applied index is now lower than readState.Index' (duration: 27.555598ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:05:11.359593Z","caller":"traceutil/trace.go:171","msg":"trace[413496139] transaction","detail":"{read_only:false; response_revision:3427; number_of_response:1; }","duration":"206.554145ms","start":"2026-05-19T05:05:11.153015Z","end":"2026-05-19T05:05:11.359569Z","steps":["trace[413496139] 'process raft request' (duration: 206.417634ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:11.359583Z","caller":"traceutil/trace.go:171","msg":"trace[150799853] transaction","detail":"{read_only:false; response_revision:3426; number_of_response:1; }","duration":"207.259112ms","start":"2026-05-19T05:05:11.152287Z","end":"2026-05-19T05:05:11.359546Z","steps":["trace[150799853] 'process raft request' (duration: 206.963419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:05:11.359759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.905286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:05:11.359815Z","caller":"traceutil/trace.go:171","msg":"trace[1374747369] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:3427; }","duration":"187.043088ms","start":"2026-05-19T05:05:11.172755Z","end":"2026-05-19T05:05:11.359798Z","steps":["trace[1374747369] 'agreement among raft nodes before linearized reading' (duration: 186.922907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:05:11.359909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.981574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:05:11.359942Z","caller":"traceutil/trace.go:171","msg":"trace[825377055] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:3427; }","duration":"155.094826ms","start":"2026-05-19T05:05:11.20484Z","end":"2026-05-19T05:05:11.359935Z","steps":["trace[825377055] 'agreement among raft nodes before linearized reading' (duration: 155.012685ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:21.590735Z","caller":"traceutil/trace.go:171","msg":"trace[91250502] linearizableReadLoop","detail":"{readStateIndex:3618; appliedIndex:3617; }","duration":"161.264061ms","start":"2026-05-19T05:05:21.42945Z","end":"2026-05-19T05:05:21.590715Z","steps":["trace[91250502] 'read index received' (duration: 103.84993ms)","trace[91250502] 'applied index is now lower than readState.Index' (duration: 57.413071ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:05:21.590898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.428473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/monitoring\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:05:21.590939Z","caller":"traceutil/trace.go:171","msg":"trace[1762788404] range","detail":"{range_begin:/registry/namespaces/monitoring; range_end:; response_count:0; response_revision:3484; }","duration":"161.507484ms","start":"2026-05-19T05:05:21.42942Z","end":"2026-05-19T05:05:21.590928Z","steps":["trace[1762788404] 'agreement among raft nodes before linearized reading' (duration: 161.383462ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:21.591247Z","caller":"traceutil/trace.go:171","msg":"trace[227956257] transaction","detail":"{read_only:false; response_revision:3484; number_of_response:1; }","duration":"179.683946ms","start":"2026-05-19T05:05:21.411524Z","end":"2026-05-19T05:05:21.591208Z","steps":["trace[227956257] 'process raft request' (duration: 121.760999ms)","trace[227956257] 'compare' (duration: 57.33788ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:05:21.791179Z","caller":"traceutil/trace.go:171","msg":"trace[1313441897] linearizableReadLoop","detail":"{readStateIndex:3621; appliedIndex:3620; }","duration":"131.478457ms","start":"2026-05-19T05:05:21.659679Z","end":"2026-05-19T05:05:21.791158Z","steps":["trace[1313441897] 'read index received' (duration: 129.176369ms)","trace[1313441897] 'applied index is now lower than readState.Index' (duration: 2.301248ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:05:21.791282Z","caller":"traceutil/trace.go:171","msg":"trace[906933185] transaction","detail":"{read_only:false; response_revision:3487; number_of_response:1; }","duration":"163.63144ms","start":"2026-05-19T05:05:21.627623Z","end":"2026-05-19T05:05:21.791255Z","steps":["trace[906933185] 'process raft request' (duration: 161.264761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:05:21.791598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.472564ms","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-05-19T05:05:21.791644Z","caller":"traceutil/trace.go:171","msg":"trace[554162631] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3487; }","duration":"134.568285ms","start":"2026-05-19T05:05:21.657065Z","end":"2026-05-19T05:05:21.791633Z","steps":["trace[554162631] 'agreement among raft nodes before linearized reading' (duration: 134.17877ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:21.797552Z","caller":"traceutil/trace.go:171","msg":"trace[23666018] transaction","detail":"{read_only:false; response_revision:3488; number_of_response:1; }","duration":"130.981861ms","start":"2026-05-19T05:05:21.666551Z","end":"2026-05-19T05:05:21.797533Z","steps":["trace[23666018] 'process raft request' (duration: 130.87459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:05:25.300187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.258709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:05:25.300272Z","caller":"traceutil/trace.go:171","msg":"trace[100560450] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3508; }","duration":"114.405061ms","start":"2026-05-19T05:05:25.185849Z","end":"2026-05-19T05:05:25.300254Z","steps":["trace[100560450] 'range keys from in-memory index tree' (duration: 114.154848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:05:37.824213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.091826ms","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-05-19T05:05:37.824322Z","caller":"traceutil/trace.go:171","msg":"trace[658937545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3579; }","duration":"146.217688ms","start":"2026-05-19T05:05:37.67808Z","end":"2026-05-19T05:05:37.824297Z","steps":["trace[658937545] 'range keys from in-memory index tree' (duration: 145.518728ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:41.3847Z","caller":"traceutil/trace.go:171","msg":"trace[1435836245] transaction","detail":"{read_only:false; response_revision:3597; number_of_response:1; }","duration":"118.725092ms","start":"2026-05-19T05:05:41.265957Z","end":"2026-05-19T05:05:41.384682Z","steps":["trace[1435836245] 'process raft request' (duration: 80.058853ms)","trace[1435836245] 'compare' (duration: 38.551677ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:05:43.311918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.350415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T05:05:43.312033Z","caller":"traceutil/trace.go:171","msg":"trace[1800896899] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:3605; }","duration":"267.472827ms","start":"2026-05-19T05:05:43.044524Z","end":"2026-05-19T05:05:43.311997Z","steps":["trace[1800896899] 'count revisions from in-memory index tree' (duration: 267.264234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:05:43.312183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.076203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:05:43.312323Z","caller":"traceutil/trace.go:171","msg":"trace[1318239830] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3605; }","duration":"126.292287ms","start":"2026-05-19T05:05:43.186003Z","end":"2026-05-19T05:05:43.312296Z","steps":["trace[1318239830] 'range keys from in-memory index tree' (duration: 125.631666ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:43.406063Z","caller":"traceutil/trace.go:171","msg":"trace[1292037386] transaction","detail":"{read_only:false; response_revision:3606; number_of_response:1; }","duration":"114.939771ms","start":"2026-05-19T05:05:43.291099Z","end":"2026-05-19T05:05:43.406039Z","steps":["trace[1292037386] 'process raft request' (duration: 114.665336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:05:43.40633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.426144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T05:05:43.406447Z","caller":"traceutil/trace.go:171","msg":"trace[1147833115] linearizableReadLoop","detail":"{readStateIndex:3744; appliedIndex:3743; }","duration":"111.099188ms","start":"2026-05-19T05:05:43.294873Z","end":"2026-05-19T05:05:43.405972Z","steps":["trace[1147833115] 'read index received' (duration: 111.012566ms)","trace[1147833115] 'applied index is now lower than readState.Index' (duration: 84.792µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:05:43.406474Z","caller":"traceutil/trace.go:171","msg":"trace[1504350211] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:3606; }","duration":"111.641307ms","start":"2026-05-19T05:05:43.294802Z","end":"2026-05-19T05:05:43.406443Z","steps":["trace[1504350211] 'agreement among raft nodes before linearized reading' (duration: 111.334322ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:43.562039Z","caller":"traceutil/trace.go:171","msg":"trace[1554023500] linearizableReadLoop","detail":"{readStateIndex:3746; appliedIndex:3744; }","duration":"155.517875ms","start":"2026-05-19T05:05:43.4065Z","end":"2026-05-19T05:05:43.562018Z","steps":["trace[1554023500] 'read index received' (duration: 155.313122ms)","trace[1554023500] 'applied index is now lower than readState.Index' (duration: 203.643µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:05:43.562094Z","caller":"traceutil/trace.go:171","msg":"trace[992519311] transaction","detail":"{read_only:false; response_revision:3607; number_of_response:1; }","duration":"172.3041ms","start":"2026-05-19T05:05:43.389748Z","end":"2026-05-19T05:05:43.562052Z","steps":["trace[992519311] 'process raft request' (duration: 172.076606ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:05:43.562331Z","caller":"traceutil/trace.go:171","msg":"trace[1703772890] transaction","detail":"{read_only:false; response_revision:3608; number_of_response:1; }","duration":"165.867855ms","start":"2026-05-19T05:05:43.396298Z","end":"2026-05-19T05:05:43.562165Z","steps":["trace[1703772890] 'process raft request' (duration: 165.678642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:05:43.56269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.605588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:05:43.562816Z","caller":"traceutil/trace.go:171","msg":"trace[544609764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3608; }","duration":"248.836102ms","start":"2026-05-19T05:05:43.313953Z","end":"2026-05-19T05:05:43.562789Z","steps":["trace[544609764] 'agreement among raft nodes before linearized reading' (duration: 248.519707ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:06:17.602518Z","caller":"traceutil/trace.go:171","msg":"trace[1271156707] transaction","detail":"{read_only:false; response_revision:3838; number_of_response:1; }","duration":"112.263245ms","start":"2026-05-19T05:06:17.490225Z","end":"2026-05-19T05:06:17.602488Z","steps":["trace[1271156707] 'process raft request' (duration: 96.998206ms)","trace[1271156707] 'compare' (duration: 14.916901ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:06:18.4127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.563336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T05:06:18.412836Z","caller":"traceutil/trace.go:171","msg":"trace[808068220] transaction","detail":"{read_only:false; response_revision:3858; number_of_response:1; }","duration":"135.063062ms","start":"2026-05-19T05:06:18.277752Z","end":"2026-05-19T05:06:18.412815Z","steps":["trace[808068220] 'compare' (duration: 125.206489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:06:24.019048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.76098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T05:06:24.019288Z","caller":"traceutil/trace.go:171","msg":"trace[946739776] transaction","detail":"{read_only:false; response_revision:3891; number_of_response:1; }","duration":"143.128211ms","start":"2026-05-19T05:06:23.876138Z","end":"2026-05-19T05:06:24.019266Z","steps":["trace[946739776] 'process raft request' (duration: 143.056199ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:06:24.019488Z","caller":"traceutil/trace.go:171","msg":"trace[1523787435] transaction","detail":"{read_only:false; response_revision:3890; number_of_response:1; }","duration":"143.98693ms","start":"2026-05-19T05:06:23.875488Z","end":"2026-05-19T05:06:24.019475Z","steps":["trace[1523787435] 'process raft request' (duration: 41.665538ms)","trace[1523787435] 'compare' (duration: 101.562545ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:02.104818Z","caller":"traceutil/trace.go:171","msg":"trace[1305894895] transaction","detail":"{read_only:false; response_revision:4122; number_of_response:1; }","duration":"134.141394ms","start":"2026-05-19T05:07:01.970655Z","end":"2026-05-19T05:07:02.104796Z","steps":["trace[1305894895] 'process raft request' (duration: 133.875507ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:03.121102Z","caller":"traceutil/trace.go:171","msg":"trace[1684323492] transaction","detail":"{read_only:false; response_revision:4223; number_of_response:1; }","duration":"107.532102ms","start":"2026-05-19T05:07:03.013541Z","end":"2026-05-19T05:07:03.121073Z","steps":["trace[1684323492] 'process raft request' (duration: 107.45854ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:03.121265Z","caller":"traceutil/trace.go:171","msg":"trace[651417632] transaction","detail":"{read_only:false; response_revision:4221; number_of_response:1; }","duration":"149.576348ms","start":"2026-05-19T05:07:02.97165Z","end":"2026-05-19T05:07:03.121227Z","steps":["trace[651417632] 'process raft request' (duration: 62.134861ms)","trace[651417632] 'compare' (duration: 86.962104ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:03.121515Z","caller":"traceutil/trace.go:171","msg":"trace[1470069718] transaction","detail":"{read_only:false; response_revision:4222; number_of_response:1; }","duration":"108.22361ms","start":"2026-05-19T05:07:03.013248Z","end":"2026-05-19T05:07:03.121472Z","steps":["trace[1470069718] 'process raft request' (duration: 107.698756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:05.0302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.510047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T05:07:05.030452Z","caller":"traceutil/trace.go:171","msg":"trace[194884733] transaction","detail":"{read_only:false; response_revision:4456; number_of_response:1; }","duration":"245.568488ms","start":"2026-05-19T05:07:04.784834Z","end":"2026-05-19T05:07:05.030402Z","steps":["trace[194884733] 'process raft request' (duration: 245.497566ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:05.03046Z","caller":"traceutil/trace.go:171","msg":"trace[1667466822] transaction","detail":"{read_only:false; response_revision:4455; number_of_response:1; }","duration":"246.721609ms","start":"2026-05-19T05:07:04.783702Z","end":"2026-05-19T05:07:05.030424Z","steps":["trace[1667466822] 'compare' (duration: 239.312991ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:05.036071Z","caller":"traceutil/trace.go:171","msg":"trace[1326711148] transaction","detail":"{read_only:false; response_revision:4457; number_of_response:1; }","duration":"190.036516ms","start":"2026-05-19T05:07:04.845972Z","end":"2026-05-19T05:07:05.036008Z","steps":["trace[1326711148] 'process raft request' (duration: 189.657366ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:05.036388Z","caller":"traceutil/trace.go:171","msg":"trace[459517779] transaction","detail":"{read_only:false; response_revision:4459; number_of_response:1; }","duration":"101.671167ms","start":"2026-05-19T05:07:04.934692Z","end":"2026-05-19T05:07:05.036363Z","steps":["trace[459517779] 'process raft request' (duration: 101.137723ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:05.036842Z","caller":"traceutil/trace.go:171","msg":"trace[697705845] transaction","detail":"{read_only:false; response_revision:4458; number_of_response:1; }","duration":"152.119113ms","start":"2026-05-19T05:07:04.884682Z","end":"2026-05-19T05:07:05.036801Z","steps":["trace[697705845] 'process raft request' (duration: 151.096146ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:05.920759Z","caller":"traceutil/trace.go:171","msg":"trace[602945533] transaction","detail":"{read_only:false; response_revision:4486; number_of_response:1; }","duration":"136.337423ms","start":"2026-05-19T05:07:05.784399Z","end":"2026-05-19T05:07:05.920736Z","steps":["trace[602945533] 'process raft request' (duration: 136.180959ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:07.608942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.81279ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T05:07:07.609225Z","caller":"traceutil/trace.go:171","msg":"trace[1565432423] transaction","detail":"{read_only:false; response_revision:4593; number_of_response:1; }","duration":"213.991191ms","start":"2026-05-19T05:07:07.395211Z","end":"2026-05-19T05:07:07.609202Z","steps":["trace[1565432423] 'process raft request' (duration: 79.820702ms)","trace[1565432423] 'compare' (duration: 133.371788ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:09.543444Z","caller":"traceutil/trace.go:171","msg":"trace[1948742658] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4625; }","duration":"106.408719ms","start":"2026-05-19T05:07:09.436955Z","end":"2026-05-19T05:07:09.543363Z","steps":["trace[1948742658] 'process raft request' (duration: 79.681024ms)","trace[1948742658] 'compare' (duration: 26.53362ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:12.252137Z","caller":"traceutil/trace.go:171","msg":"trace[1706345108] transaction","detail":"{read_only:false; response_revision:4676; number_of_response:1; }","duration":"124.846702ms","start":"2026-05-19T05:07:12.127258Z","end":"2026-05-19T05:07:12.252105Z","steps":["trace[1706345108] 'process raft request' (duration: 124.606616ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:12.286259Z","caller":"traceutil/trace.go:171","msg":"trace[2064033489] linearizableReadLoop","detail":"{readStateIndex:4856; appliedIndex:4854; }","duration":"148.882061ms","start":"2026-05-19T05:07:12.137345Z","end":"2026-05-19T05:07:12.286227Z","steps":["trace[2064033489] 'read index received' (duration: 114.57035ms)","trace[2064033489] 'applied index is now lower than readState.Index' (duration: 34.310421ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:12.286424Z","caller":"traceutil/trace.go:171","msg":"trace[1227533451] transaction","detail":"{read_only:false; response_revision:4677; number_of_response:1; }","duration":"149.227401ms","start":"2026-05-19T05:07:12.137175Z","end":"2026-05-19T05:07:12.286402Z","steps":["trace[1227533451] 'process raft request' (duration: 148.966813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:12.287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.628911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-05-19T05:07:12.287102Z","caller":"traceutil/trace.go:171","msg":"trace[906107255] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4677; }","duration":"149.797286ms","start":"2026-05-19T05:07:12.137288Z","end":"2026-05-19T05:07:12.287085Z","steps":["trace[906107255] 'agreement among raft nodes before linearized reading' (duration: 149.100107ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:12.464368Z","caller":"traceutil/trace.go:171","msg":"trace[1164467096] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"131.007361ms","start":"2026-05-19T05:07:12.333335Z","end":"2026-05-19T05:07:12.464343Z","steps":["trace[1164467096] 'process raft request' (duration: 92.333241ms)","trace[1164467096] 'compare' (duration: 38.545486ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:12.674964Z","caller":"traceutil/trace.go:171","msg":"trace[1716828423] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4683; }","duration":"185.777802ms","start":"2026-05-19T05:07:12.489161Z","end":"2026-05-19T05:07:12.674939Z","steps":["trace[1716828423] 'process raft request' (duration: 185.635728ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:12.67503Z","caller":"traceutil/trace.go:171","msg":"trace[131644979] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"186.645246ms","start":"2026-05-19T05:07:12.488354Z","end":"2026-05-19T05:07:12.674999Z","steps":["trace[131644979] 'process raft request' (duration: 186.196134ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:12.740594Z","caller":"traceutil/trace.go:171","msg":"trace[936877539] linearizableReadLoop","detail":"{readStateIndex:4864; appliedIndex:4861; }","duration":"145.269572ms","start":"2026-05-19T05:07:12.595297Z","end":"2026-05-19T05:07:12.740566Z","steps":["trace[936877539] 'read index received' (duration: 79.246552ms)","trace[936877539] 'applied index is now lower than readState.Index' (duration: 66.02194ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:12.740632Z","caller":"traceutil/trace.go:171","msg":"trace[1334708134] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"226.756285ms","start":"2026-05-19T05:07:12.513845Z","end":"2026-05-19T05:07:12.740601Z","steps":["trace[1334708134] 'process raft request' (duration: 226.514499ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:12.740932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.545489ms","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-05-19T05:07:12.740982Z","caller":"traceutil/trace.go:171","msg":"trace[1423673595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4684; }","duration":"145.734895ms","start":"2026-05-19T05:07:12.595231Z","end":"2026-05-19T05:07:12.740966Z","steps":["trace[1423673595] 'agreement among raft nodes before linearized reading' (duration: 145.458808ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:12.800865Z","caller":"traceutil/trace.go:171","msg":"trace[685802531] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"108.973547ms","start":"2026-05-19T05:07:12.691839Z","end":"2026-05-19T05:07:12.800813Z","steps":["trace[685802531] 'process raft request' (duration: 107.548527ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:12.911408Z","caller":"traceutil/trace.go:171","msg":"trace[836507087] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"105.107621ms","start":"2026-05-19T05:07:12.806268Z","end":"2026-05-19T05:07:12.911376Z","steps":["trace[836507087] 'process raft request' (duration: 94.684856ms)","trace[836507087] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/cilium-operator-resource-lock; req_size:473; } (duration: 10.197399ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:12.91157Z","caller":"traceutil/trace.go:171","msg":"trace[1877753316] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"103.436705ms","start":"2026-05-19T05:07:12.808119Z","end":"2026-05-19T05:07:12.911556Z","steps":["trace[1877753316] 'process raft request' (duration: 103.184428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.1461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.019951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T05:07:14.146205Z","caller":"traceutil/trace.go:171","msg":"trace[651310718] linearizableReadLoop","detail":"{readStateIndex:4898; appliedIndex:4897; }","duration":"553.748059ms","start":"2026-05-19T05:07:13.592439Z","end":"2026-05-19T05:07:14.146187Z","steps":["trace[651310718] 'read index received' (duration: 29.394868ms)","trace[651310718] 'applied index is now lower than readState.Index' (duration: 524.351811ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:14.146274Z","caller":"traceutil/trace.go:171","msg":"trace[558777566] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"554.15973ms","start":"2026-05-19T05:07:13.592103Z","end":"2026-05-19T05:07:14.146263Z","steps":["trace[558777566] 'process raft request' (duration: 29.882452ms)","trace[558777566] 'compare' (duration: 523.740963ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:07:14.14634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:13.592079Z","time spent":"554.228402ms","remote":"127.0.0.1:47412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T05:07:14.146756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.307454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-05-19T05:07:14.146802Z","caller":"traceutil/trace.go:171","msg":"trace[429038412] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4716; }","duration":"554.367495ms","start":"2026-05-19T05:07:13.592424Z","end":"2026-05-19T05:07:14.146791Z","steps":["trace[429038412] 'agreement among raft nodes before linearized reading' (duration: 554.097698ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.146835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:13.592417Z","time spent":"554.411096ms","remote":"127.0.0.1:47434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":731,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" "} {"level":"info","ts":"2026-05-19T05:07:14.335545Z","caller":"traceutil/trace.go:171","msg":"trace[1642729787] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"743.07097ms","start":"2026-05-19T05:07:13.592433Z","end":"2026-05-19T05:07:14.335504Z","steps":["trace[1642729787] 'process raft request' (duration: 710.980365ms)","trace[1642729787] 'compare' (duration: 31.780936ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:07:14.335738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:13.592424Z","time spent":"743.209344ms","remote":"127.0.0.1:59480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1952,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T05:07:14.544342Z","caller":"traceutil/trace.go:171","msg":"trace[1276526509] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"581.30619ms","start":"2026-05-19T05:07:13.96301Z","end":"2026-05-19T05:07:14.544317Z","steps":["trace[1276526509] 'process raft request' (duration: 580.992902ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:14.544459Z","caller":"traceutil/trace.go:171","msg":"trace[266290524] linearizableReadLoop","detail":"{readStateIndex:4900; appliedIndex:4898; }","duration":"398.212453ms","start":"2026-05-19T05:07:14.146231Z","end":"2026-05-19T05:07:14.544443Z","steps":["trace[266290524] 'read index received' (duration: 157.326869ms)","trace[266290524] 'applied index is now lower than readState.Index' (duration: 240.884644ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:07:14.5445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:13.962983Z","time spent":"581.432953ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T05:07:14.544791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.467672ms","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-05-19T05:07:14.544837Z","caller":"traceutil/trace.go:171","msg":"trace[1839212482] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4720; }","duration":"393.550594ms","start":"2026-05-19T05:07:14.151276Z","end":"2026-05-19T05:07:14.544826Z","steps":["trace[1839212482] 'agreement among raft nodes before linearized reading' (duration: 393.422461ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.544869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:14.151246Z","time spent":"393.615556ms","remote":"127.0.0.1:47524","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1308,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"warn","ts":"2026-05-19T05:07:14.545127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.651328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-k2zdv\" ","response":"range_response_count:1 size:9674"} {"level":"info","ts":"2026-05-19T05:07:14.545169Z","caller":"traceutil/trace.go:171","msg":"trace[1762779852] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-k2zdv; range_end:; response_count:1; response_revision:4720; }","duration":"132.800662ms","start":"2026-05-19T05:07:14.412354Z","end":"2026-05-19T05:07:14.545155Z","steps":["trace[1762779852] 'agreement among raft nodes before linearized reading' (duration: 132.70492ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:14.545286Z","caller":"traceutil/trace.go:171","msg":"trace[1539278568] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"286.865232ms","start":"2026-05-19T05:07:14.258407Z","end":"2026-05-19T05:07:14.545273Z","steps":["trace[1539278568] 'process raft request' (duration: 285.745011ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:14.545321Z","caller":"traceutil/trace.go:171","msg":"trace[439091755] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"252.319209ms","start":"2026-05-19T05:07:14.292958Z","end":"2026-05-19T05:07:14.545278Z","steps":["trace[439091755] 'process raft request' (duration: 251.428154ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.545597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.667152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:07:14.545641Z","caller":"traceutil/trace.go:171","msg":"trace[1392505808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4720; }","duration":"358.820047ms","start":"2026-05-19T05:07:14.186809Z","end":"2026-05-19T05:07:14.545629Z","steps":["trace[1392505808] 'agreement among raft nodes before linearized reading' (duration: 358.754965ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.545671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:14.186783Z","time spent":"358.881219ms","remote":"127.0.0.1:47330","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-05-19T05:07:14.545884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.783899ms","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-05-19T05:07:14.545913Z","caller":"traceutil/trace.go:171","msg":"trace[1721727908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4720; }","duration":"220.833791ms","start":"2026-05-19T05:07:14.325071Z","end":"2026-05-19T05:07:14.545905Z","steps":["trace[1721727908] 'agreement among raft nodes before linearized reading' (duration: 220.749649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.545976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"890.649365ms","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-05-19T05:07:14.546027Z","caller":"traceutil/trace.go:171","msg":"trace[940154801] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4720; }","duration":"890.773329ms","start":"2026-05-19T05:07:13.655241Z","end":"2026-05-19T05:07:14.546015Z","steps":["trace[940154801] 'agreement among raft nodes before linearized reading' (duration: 890.558573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.546026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.733125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206169"} {"level":"warn","ts":"2026-05-19T05:07:14.546066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:13.655207Z","time spent":"890.850701ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-19T05:07:14.546073Z","caller":"traceutil/trace.go:171","msg":"trace[1449058808] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4720; }","duration":"911.820397ms","start":"2026-05-19T05:07:13.63424Z","end":"2026-05-19T05:07:14.546061Z","steps":["trace[1449058808] 'agreement among raft nodes before linearized reading' (duration: 910.392098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.546111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:13.63422Z","time spent":"911.88051ms","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206192,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-05-19T05:07:14.54612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.220449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T05:07:14.546213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.21593ms","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-05-19T05:07:14.546253Z","caller":"traceutil/trace.go:171","msg":"trace[143620246] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4720; }","duration":"242.305533ms","start":"2026-05-19T05:07:14.303939Z","end":"2026-05-19T05:07:14.546244Z","steps":["trace[143620246] 'agreement among raft nodes before linearized reading' (duration: 242.213191ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:14.546316Z","caller":"traceutil/trace.go:171","msg":"trace[490696483] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:4720; }","duration":"309.544577ms","start":"2026-05-19T05:07:14.236692Z","end":"2026-05-19T05:07:14.546237Z","steps":["trace[490696483] 'agreement among raft nodes before linearized reading' (duration: 309.159147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.546429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:14.236647Z","time spent":"309.742123ms","remote":"127.0.0.1:44994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true "} {"level":"warn","ts":"2026-05-19T05:07:14.795434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.686978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T05:07:14.795713Z","caller":"traceutil/trace.go:171","msg":"trace[950881756] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"241.262234ms","start":"2026-05-19T05:07:14.554429Z","end":"2026-05-19T05:07:14.795691Z","steps":["trace[950881756] 'process raft request' (duration: 241.109ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:14.795725Z","caller":"traceutil/trace.go:171","msg":"trace[1417695537] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"242.682883ms","start":"2026-05-19T05:07:14.553003Z","end":"2026-05-19T05:07:14.795686Z","steps":["trace[1417695537] 'process raft request' (duration: 71.615535ms)","trace[1417695537] 'compare' (duration: 170.471482ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:14.796057Z","caller":"traceutil/trace.go:171","msg":"trace[1177723860] linearizableReadLoop","detail":"{readStateIndex:4905; appliedIndex:4902; }","duration":"240.629577ms","start":"2026-05-19T05:07:14.555404Z","end":"2026-05-19T05:07:14.796033Z","steps":["trace[1177723860] 'read index received' (duration: 39.802968ms)","trace[1177723860] 'applied index is now lower than readState.Index' (duration: 200.825379ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:14.796202Z","caller":"traceutil/trace.go:171","msg":"trace[1655047118] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"237.211413ms","start":"2026-05-19T05:07:14.558974Z","end":"2026-05-19T05:07:14.796185Z","steps":["trace[1655047118] 'process raft request' (duration: 236.628127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.796389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.962506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-19T05:07:14.796699Z","caller":"traceutil/trace.go:171","msg":"trace[1830307955] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4724; }","duration":"241.256184ms","start":"2026-05-19T05:07:14.55539Z","end":"2026-05-19T05:07:14.796646Z","steps":["trace[1830307955] 'agreement among raft nodes before linearized reading' (duration: 240.866913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.798174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.492508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60280"} {"level":"info","ts":"2026-05-19T05:07:14.798234Z","caller":"traceutil/trace.go:171","msg":"trace[1302300519] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4724; }","duration":"242.57434ms","start":"2026-05-19T05:07:14.555644Z","end":"2026-05-19T05:07:14.798219Z","steps":["trace[1302300519] 'agreement among raft nodes before linearized reading' (duration: 242.280562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:14.798073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.333171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"info","ts":"2026-05-19T05:07:14.798427Z","caller":"traceutil/trace.go:171","msg":"trace[570565359] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4724; }","duration":"222.719513ms","start":"2026-05-19T05:07:14.575676Z","end":"2026-05-19T05:07:14.798395Z","steps":["trace[570565359] 'agreement among raft nodes before linearized reading' (duration: 222.26654ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:15.518236Z","caller":"traceutil/trace.go:171","msg":"trace[1631596308] linearizableReadLoop","detail":"{readStateIndex:4912; appliedIndex:4911; }","duration":"231.089544ms","start":"2026-05-19T05:07:15.287117Z","end":"2026-05-19T05:07:15.518206Z","steps":["trace[1631596308] 'read index received' (duration: 230.859017ms)","trace[1631596308] 'applied index is now lower than readState.Index' (duration: 228.267µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:15.518317Z","caller":"traceutil/trace.go:171","msg":"trace[2140527828] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"253.537824ms","start":"2026-05-19T05:07:15.26474Z","end":"2026-05-19T05:07:15.518278Z","steps":["trace[2140527828] 'process raft request' (duration: 253.109782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:15.518586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.443623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-19T05:07:15.518677Z","caller":"traceutil/trace.go:171","msg":"trace[235123941] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:4730; }","duration":"231.584907ms","start":"2026-05-19T05:07:15.287071Z","end":"2026-05-19T05:07:15.518656Z","steps":["trace[235123941] 'agreement among raft nodes before linearized reading' (duration: 231.302919ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:20.726682Z","caller":"traceutil/trace.go:171","msg":"trace[2055256728] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"158.556151ms","start":"2026-05-19T05:07:20.56808Z","end":"2026-05-19T05:07:20.726636Z","steps":["trace[2055256728] 'process raft request' (duration: 158.341845ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:20.741445Z","caller":"traceutil/trace.go:171","msg":"trace[385353791] linearizableReadLoop","detail":"{readStateIndex:4946; appliedIndex:4943; }","duration":"124.824015ms","start":"2026-05-19T05:07:20.616598Z","end":"2026-05-19T05:07:20.741422Z","steps":["trace[385353791] 'read index received' (duration: 7.317826ms)","trace[385353791] 'applied index is now lower than readState.Index' (duration: 117.505149ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:07:20.741641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.03796ms","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-05-19T05:07:20.741672Z","caller":"traceutil/trace.go:171","msg":"trace[1392964782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4762; }","duration":"125.128694ms","start":"2026-05-19T05:07:20.616533Z","end":"2026-05-19T05:07:20.741662Z","steps":["trace[1392964782] 'agreement among raft nodes before linearized reading' (duration: 124.99736ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:20.741833Z","caller":"traceutil/trace.go:171","msg":"trace[1115238658] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"171.111534ms","start":"2026-05-19T05:07:20.570675Z","end":"2026-05-19T05:07:20.741787Z","steps":["trace[1115238658] 'process raft request' (duration: 155.921297ms)","trace[1115238658] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; req_size:532; } (duration: 14.549018ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:21.231414Z","caller":"traceutil/trace.go:171","msg":"trace[1176958925] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"123.160098ms","start":"2026-05-19T05:07:21.108234Z","end":"2026-05-19T05:07:21.231394Z","steps":["trace[1176958925] 'process raft request' (duration: 80.64156ms)","trace[1176958925] 'compare' (duration: 41.91228ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:21.231722Z","caller":"traceutil/trace.go:171","msg":"trace[905926848] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"106.19749ms","start":"2026-05-19T05:07:21.125516Z","end":"2026-05-19T05:07:21.231713Z","steps":["trace[905926848] 'process raft request' (duration: 105.580243ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:21.45191Z","caller":"traceutil/trace.go:171","msg":"trace[1252755204] linearizableReadLoop","detail":"{readStateIndex:4976; appliedIndex:4975; }","duration":"119.903036ms","start":"2026-05-19T05:07:21.331976Z","end":"2026-05-19T05:07:21.451879Z","steps":["trace[1252755204] 'read index received' (duration: 119.687269ms)","trace[1252755204] 'applied index is now lower than readState.Index' (duration: 214.707µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:21.451979Z","caller":"traceutil/trace.go:171","msg":"trace[617827792] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"123.95741ms","start":"2026-05-19T05:07:21.327972Z","end":"2026-05-19T05:07:21.451929Z","steps":["trace[617827792] 'process raft request' (duration: 123.741734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:21.452241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.238286ms","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-05-19T05:07:21.452322Z","caller":"traceutil/trace.go:171","msg":"trace[708641864] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4791; }","duration":"120.347079ms","start":"2026-05-19T05:07:21.331957Z","end":"2026-05-19T05:07:21.452304Z","steps":["trace[708641864] 'agreement among raft nodes before linearized reading' (duration: 120.062841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.359571Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828745152102023,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T05:07:22.443369Z","caller":"traceutil/trace.go:171","msg":"trace[557608311] transaction","detail":"{read_only:false; response_revision:4830; number_of_response:1; }","duration":"595.310126ms","start":"2026-05-19T05:07:21.848021Z","end":"2026-05-19T05:07:22.443331Z","steps":["trace[557608311] 'process raft request' (duration: 595.064919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.443589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:21.848003Z","time spent":"595.472661ms","remote":"127.0.0.1:47412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T05:07:22.775296Z","caller":"traceutil/trace.go:171","msg":"trace[1478309906] linearizableReadLoop","detail":"{readStateIndex:5016; appliedIndex:5014; }","duration":"916.560489ms","start":"2026-05-19T05:07:21.858712Z","end":"2026-05-19T05:07:22.775272Z","steps":["trace[1478309906] 'read index received' (duration: 584.330438ms)","trace[1478309906] 'applied index is now lower than readState.Index' (duration: 332.228831ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:22.775339Z","caller":"traceutil/trace.go:171","msg":"trace[642249155] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"897.367048ms","start":"2026-05-19T05:07:21.87793Z","end":"2026-05-19T05:07:22.775297Z","steps":["trace[642249155] 'process raft request' (duration: 811.615697ms)","trace[642249155] 'compare' (duration: 85.615968ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:07:22.775606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:21.877916Z","time spent":"897.499512ms","remote":"127.0.0.1:47412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T05:07:22.775624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.884318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-05-19T05:07:22.77571Z","caller":"traceutil/trace.go:171","msg":"trace[2127467905] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4831; }","duration":"917.014141ms","start":"2026-05-19T05:07:21.858676Z","end":"2026-05-19T05:07:22.775691Z","steps":["trace[2127467905] 'agreement among raft nodes before linearized reading' (duration: 916.698273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.775756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:21.858658Z","time spent":"917.090743ms","remote":"127.0.0.1:47540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":920,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"info","ts":"2026-05-19T05:07:22.836473Z","caller":"traceutil/trace.go:171","msg":"trace[290362758] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"203.466574ms","start":"2026-05-19T05:07:22.632979Z","end":"2026-05-19T05:07:22.836445Z","steps":["trace[290362758] 'process raft request' (duration: 203.30956ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:22.854492Z","caller":"traceutil/trace.go:171","msg":"trace[979701140] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"123.703162ms","start":"2026-05-19T05:07:22.730766Z","end":"2026-05-19T05:07:22.85447Z","steps":["trace[979701140] 'process raft request' (duration: 123.223878ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.854509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.027362ms","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":"warn","ts":"2026-05-19T05:07:22.854582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.427134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-19T05:07:22.854655Z","caller":"traceutil/trace.go:171","msg":"trace[2004035760] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4834; }","duration":"276.509156ms","start":"2026-05-19T05:07:22.578125Z","end":"2026-05-19T05:07:22.854635Z","steps":["trace[2004035760] 'agreement among raft nodes before linearized reading' (duration: 276.28107ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:22.854664Z","caller":"traceutil/trace.go:171","msg":"trace[986970111] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:4834; }","duration":"696.245028ms","start":"2026-05-19T05:07:22.158384Z","end":"2026-05-19T05:07:22.854629Z","steps":["trace[986970111] 'agreement among raft nodes before linearized reading' (duration: 695.904699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.854751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:22.158284Z","time spent":"696.448314ms","remote":"127.0.0.1:59454","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-05-19T05:07:22.85438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.141941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b3e0b56e-30eb-489f-ac76-e5dafb2b2e90\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-19T05:07:22.855078Z","caller":"traceutil/trace.go:171","msg":"trace[26812741] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"106.923957ms","start":"2026-05-19T05:07:22.748104Z","end":"2026-05-19T05:07:22.855028Z","steps":["trace[26812741] 'process raft request' (duration: 106.003351ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:22.855155Z","caller":"traceutil/trace.go:171","msg":"trace[1693255684] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b3e0b56e-30eb-489f-ac76-e5dafb2b2e90; range_end:; response_count:1; response_revision:4834; }","duration":"256.970385ms","start":"2026-05-19T05:07:22.598146Z","end":"2026-05-19T05:07:22.855117Z","steps":["trace[1693255684] 'agreement among raft nodes before linearized reading' (duration: 256.07395ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.855064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.062789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T05:07:22.855406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.998606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-19T05:07:22.855487Z","caller":"traceutil/trace.go:171","msg":"trace[161786617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4834; }","duration":"103.494391ms","start":"2026-05-19T05:07:22.75195Z","end":"2026-05-19T05:07:22.855444Z","steps":["trace[161786617] 'agreement among raft nodes before linearized reading' (duration: 103.08366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.855586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.817443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206169"} {"level":"info","ts":"2026-05-19T05:07:22.855677Z","caller":"traceutil/trace.go:171","msg":"trace[691935362] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4834; }","duration":"974.931427ms","start":"2026-05-19T05:07:21.880729Z","end":"2026-05-19T05:07:22.855661Z","steps":["trace[691935362] 'agreement among raft nodes before linearized reading' (duration: 973.860687ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.855719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:21.880725Z","time spent":"974.983659ms","remote":"127.0.0.1:47444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206192,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-05-19T05:07:22.855898Z","caller":"traceutil/trace.go:171","msg":"trace[1537052816] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4834; }","duration":"359.546601ms","start":"2026-05-19T05:07:22.496329Z","end":"2026-05-19T05:07:22.855876Z","steps":["trace[1537052816] 'agreement among raft nodes before linearized reading' (duration: 358.114971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:22.856217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:22.496306Z","time spent":"359.892141ms","remote":"127.0.0.1:47512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12998,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-05-19T05:07:22.856427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.558552ms","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-05-19T05:07:22.856545Z","caller":"traceutil/trace.go:171","msg":"trace[622864949] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4834; }","duration":"104.716456ms","start":"2026-05-19T05:07:22.751814Z","end":"2026-05-19T05:07:22.85653Z","steps":["trace[622864949] 'agreement among raft nodes before linearized reading' (duration: 102.38839ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:23.503744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.723146ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T05:07:23.503873Z","caller":"traceutil/trace.go:171","msg":"trace[1718159259] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"266.573278ms","start":"2026-05-19T05:07:23.237289Z","end":"2026-05-19T05:07:23.503862Z","steps":["trace[1718159259] 'process raft request' (duration: 266.529497ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:23.504121Z","caller":"traceutil/trace.go:171","msg":"trace[1099063118] transaction","detail":"{read_only:false; response_revision:4846; number_of_response:1; }","duration":"451.392482ms","start":"2026-05-19T05:07:23.052715Z","end":"2026-05-19T05:07:23.504108Z","steps":["trace[1099063118] 'process raft request' (duration: 121.240793ms)","trace[1099063118] 'compare' (duration: 329.562382ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:07:23.504188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:23.052683Z","time spent":"451.471753ms","remote":"127.0.0.1:47512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16389,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T05:07:23.504318Z","caller":"traceutil/trace.go:171","msg":"trace[972597656] linearizableReadLoop","detail":"{readStateIndex:5031; appliedIndex:5030; }","duration":"446.06876ms","start":"2026-05-19T05:07:23.05824Z","end":"2026-05-19T05:07:23.504309Z","steps":["trace[972597656] 'read index received' (duration: 115.634114ms)","trace[972597656] 'applied index is now lower than readState.Index' (duration: 330.433456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:07:23.504681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.443781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1346"} {"level":"info","ts":"2026-05-19T05:07:23.504711Z","caller":"traceutil/trace.go:171","msg":"trace[1907930013] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4847; }","duration":"446.504083ms","start":"2026-05-19T05:07:23.058198Z","end":"2026-05-19T05:07:23.504702Z","steps":["trace[1907930013] 'agreement among raft nodes before linearized reading' (duration: 446.386669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:23.504741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:23.058185Z","time spent":"446.549115ms","remote":"127.0.0.1:47434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":1,"response size":1369,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" "} {"level":"warn","ts":"2026-05-19T05:07:23.504794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.768696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:07:23.504898Z","caller":"traceutil/trace.go:171","msg":"trace[243801735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4847; }","duration":"318.950231ms","start":"2026-05-19T05:07:23.18592Z","end":"2026-05-19T05:07:23.50487Z","steps":["trace[243801735] 'agreement among raft nodes before linearized reading' (duration: 318.771496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:23.50495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:23.185892Z","time spent":"319.048644ms","remote":"127.0.0.1:47332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T05:07:23.742525Z","caller":"traceutil/trace.go:171","msg":"trace[1475840922] linearizableReadLoop","detail":"{readStateIndex:5038; appliedIndex:5037; }","duration":"124.872405ms","start":"2026-05-19T05:07:23.617624Z","end":"2026-05-19T05:07:23.742496Z","steps":["trace[1475840922] 'read index received' (duration: 124.67547ms)","trace[1475840922] 'applied index is now lower than readState.Index' (duration: 190.645µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:07:23.742564Z","caller":"traceutil/trace.go:171","msg":"trace[1938979863] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"128.479458ms","start":"2026-05-19T05:07:23.614056Z","end":"2026-05-19T05:07:23.742536Z","steps":["trace[1938979863] 'process raft request' (duration: 128.249941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:23.742953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.200475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"warn","ts":"2026-05-19T05:07:23.742969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.300047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18b0df2e08f0dbaa\" ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-05-19T05:07:23.742993Z","caller":"traceutil/trace.go:171","msg":"trace[1214827706] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4853; }","duration":"125.409031ms","start":"2026-05-19T05:07:23.617572Z","end":"2026-05-19T05:07:23.742981Z","steps":["trace[1214827706] 'agreement among raft nodes before linearized reading' (duration: 125.101923ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:23.743007Z","caller":"traceutil/trace.go:171","msg":"trace[189954407] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18b0df2e08f0dbaa; range_end:; response_count:1; response_revision:4853; }","duration":"125.35621ms","start":"2026-05-19T05:07:23.617639Z","end":"2026-05-19T05:07:23.742995Z","steps":["trace[189954407] 'agreement among raft nodes before linearized reading' (duration: 125.140884ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:23.743307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.745352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1453"} {"level":"info","ts":"2026-05-19T05:07:23.74334Z","caller":"traceutil/trace.go:171","msg":"trace[1798054063] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4853; }","duration":"124.791133ms","start":"2026-05-19T05:07:23.618539Z","end":"2026-05-19T05:07:23.74333Z","steps":["trace[1798054063] 'agreement among raft nodes before linearized reading' (duration: 124.69272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:23.744998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.847865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-k2zdv.18b0df2c1eb5ebf6\" ","response":"range_response_count:1 size:906"} {"level":"info","ts":"2026-05-19T05:07:23.745104Z","caller":"traceutil/trace.go:171","msg":"trace[2048787134] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-k2zdv.18b0df2c1eb5ebf6; range_end:; response_count:1; response_revision:4853; }","duration":"113.00102ms","start":"2026-05-19T05:07:23.632073Z","end":"2026-05-19T05:07:23.745074Z","steps":["trace[2048787134] 'agreement among raft nodes before linearized reading' (duration: 111.118856ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:25.525401Z","caller":"traceutil/trace.go:171","msg":"trace[367780867] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"132.539963ms","start":"2026-05-19T05:07:25.392838Z","end":"2026-05-19T05:07:25.525378Z","steps":["trace[367780867] 'process raft request' (duration: 129.221969ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:27.228308Z","caller":"traceutil/trace.go:171","msg":"trace[238586046] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"131.533565ms","start":"2026-05-19T05:07:27.096751Z","end":"2026-05-19T05:07:27.228284Z","steps":["trace[238586046] 'process raft request' (duration: 130.978439ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:27.228655Z","caller":"traceutil/trace.go:171","msg":"trace[1800638842] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"131.831303ms","start":"2026-05-19T05:07:27.096785Z","end":"2026-05-19T05:07:27.228617Z","steps":["trace[1800638842] 'process raft request' (duration: 131.422802ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:27.720579Z","caller":"traceutil/trace.go:171","msg":"trace[127667575] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"101.845386ms","start":"2026-05-19T05:07:27.618707Z","end":"2026-05-19T05:07:27.720553Z","steps":["trace[127667575] 'process raft request' (duration: 101.609779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:31.060428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.840896ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-19T05:07:31.06063Z","caller":"traceutil/trace.go:171","msg":"trace[1092217370] linearizableReadLoop","detail":"{readStateIndex:5159; appliedIndex:5158; }","duration":"219.210889ms","start":"2026-05-19T05:07:30.841401Z","end":"2026-05-19T05:07:31.060612Z","steps":["trace[1092217370] 'read index received' (duration: 34.199107ms)","trace[1092217370] 'applied index is now lower than readState.Index' (duration: 185.010292ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T05:07:31.061084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.685172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-05-19T05:07:31.061102Z","caller":"traceutil/trace.go:171","msg":"trace[1538419992] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"194.29231ms","start":"2026-05-19T05:07:30.866783Z","end":"2026-05-19T05:07:31.061076Z","steps":["trace[1538419992] 'process raft request' (duration: 193.738254ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:31.061131Z","caller":"traceutil/trace.go:171","msg":"trace[1848160998] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4969; }","duration":"219.787005ms","start":"2026-05-19T05:07:30.84133Z","end":"2026-05-19T05:07:31.061117Z","steps":["trace[1848160998] 'agreement among raft nodes before linearized reading' (duration: 219.515257ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:31.06373Z","caller":"traceutil/trace.go:171","msg":"trace[142774830] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"182.427617ms","start":"2026-05-19T05:07:30.881275Z","end":"2026-05-19T05:07:31.063703Z","steps":["trace[142774830] 'process raft request' (duration: 180.636435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:31.063787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.544843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-19T05:07:31.063816Z","caller":"traceutil/trace.go:171","msg":"trace[1989136895] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4972; }","duration":"119.635326ms","start":"2026-05-19T05:07:30.944173Z","end":"2026-05-19T05:07:31.063808Z","steps":["trace[1989136895] 'agreement among raft nodes before linearized reading' (duration: 119.530883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:31.063791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.284677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T05:07:31.063866Z","caller":"traceutil/trace.go:171","msg":"trace[340712698] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"176.670262ms","start":"2026-05-19T05:07:30.887188Z","end":"2026-05-19T05:07:31.063858Z","steps":["trace[340712698] 'process raft request' (duration: 176.227279ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:31.063893Z","caller":"traceutil/trace.go:171","msg":"trace[282113511] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:4972; }","duration":"144.470203ms","start":"2026-05-19T05:07:30.9194Z","end":"2026-05-19T05:07:31.06387Z","steps":["trace[282113511] 'agreement among raft nodes before linearized reading' (duration: 144.082782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:31.064284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.43651ms","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-05-19T05:07:31.064321Z","caller":"traceutil/trace.go:171","msg":"trace[747829333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4972; }","duration":"111.501392ms","start":"2026-05-19T05:07:30.952811Z","end":"2026-05-19T05:07:31.064313Z","steps":["trace[747829333] 'agreement among raft nodes before linearized reading' (duration: 110.863653ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:07:36.152905Z","caller":"traceutil/trace.go:171","msg":"trace[1886870484] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"351.939203ms","start":"2026-05-19T05:07:35.800926Z","end":"2026-05-19T05:07:36.152865Z","steps":["trace[1886870484] 'process raft request' (duration: 351.524971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:36.153112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:35.800902Z","time spent":"352.101407ms","remote":"127.0.0.1:47616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T05:07:36.719143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.484446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:07:36.71922Z","caller":"traceutil/trace.go:171","msg":"trace[718390957] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5015; }","duration":"532.609319ms","start":"2026-05-19T05:07:36.186592Z","end":"2026-05-19T05:07:36.719202Z","steps":["trace[718390957] 'range keys from in-memory index tree' (duration: 532.412904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:36.719258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:36.186579Z","time spent":"532.670081ms","remote":"127.0.0.1:47330","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-05-19T05:07:36.719224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.116727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:07:36.719329Z","caller":"traceutil/trace.go:171","msg":"trace[2039897820] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5015; }","duration":"459.266211ms","start":"2026-05-19T05:07:36.260046Z","end":"2026-05-19T05:07:36.719312Z","steps":["trace[2039897820] 'range keys from in-memory index tree' (duration: 459.027724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:36.719394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T05:07:36.260022Z","time spent":"459.359404ms","remote":"127.0.0.1:47776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-05-19T05:07:36.719502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.947959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-19T05:07:36.719647Z","caller":"traceutil/trace.go:171","msg":"trace[544396495] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5015; }","duration":"252.123314ms","start":"2026-05-19T05:07:36.467475Z","end":"2026-05-19T05:07:36.719598Z","steps":["trace[544396495] 'range keys from in-memory index tree' (duration: 251.404324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:07:36.719502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.325816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T05:07:36.71987Z","caller":"traceutil/trace.go:171","msg":"trace[1515422770] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:5015; }","duration":"217.674955ms","start":"2026-05-19T05:07:36.50212Z","end":"2026-05-19T05:07:36.719795Z","steps":["trace[1515422770] 'count revisions from in-memory index tree' (duration: 217.254343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T05:08:00.876537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.509996ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-19T05:08:52.243971Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2933} {"level":"info","ts":"2026-05-19T05:08:52.339964Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2933,"took":"94.024456ms","hash":3642035474,"current-db-size-bytes":53510144,"current-db-size":"54 MB","current-db-size-in-use-bytes":29134848,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-19T05:08:52.340025Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3642035474,"revision":2933,"compact-revision":-1} {"level":"info","ts":"2026-05-19T05:09:10.039304Z","caller":"traceutil/trace.go:171","msg":"trace[667639272] transaction","detail":"{read_only:false; response_revision:5774; number_of_response:1; }","duration":"146.321833ms","start":"2026-05-19T05:09:09.892951Z","end":"2026-05-19T05:09:10.039273Z","steps":["trace[667639272] 'process raft request' (duration: 146.23149ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:09:10.039316Z","caller":"traceutil/trace.go:171","msg":"trace[597766440] transaction","detail":"{read_only:false; response_revision:5773; number_of_response:1; }","duration":"146.360135ms","start":"2026-05-19T05:09:09.892899Z","end":"2026-05-19T05:09:10.039259Z","steps":["trace[597766440] 'process raft request' (duration: 146.23602ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:09:10.039342Z","caller":"traceutil/trace.go:171","msg":"trace[699458055] transaction","detail":"{read_only:false; response_revision:5772; number_of_response:1; }","duration":"147.436291ms","start":"2026-05-19T05:09:09.891873Z","end":"2026-05-19T05:09:10.039309Z","steps":["trace[699458055] 'process raft request' (duration: 99.799691ms)","trace[699458055] 'compare' (duration: 47.280748ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T05:11:20.528209Z","caller":"traceutil/trace.go:171","msg":"trace[1245831675] transaction","detail":"{read_only:false; response_revision:6634; number_of_response:1; }","duration":"111.700058ms","start":"2026-05-19T05:11:20.416414Z","end":"2026-05-19T05:11:20.528114Z","steps":["trace[1245831675] 'process raft request' (duration: 111.357466ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T05:13:52.25288Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5637} {"level":"info","ts":"2026-05-19T05:13:52.328558Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5637,"took":"74.169847ms","hash":1323229725,"current-db-size-bytes":53510144,"current-db-size":"54 MB","current-db-size-in-use-bytes":18558976,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-05-19T05:13:52.328643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1323229725,"revision":5637,"compact-revision":2933}