{"level":"warn","ts":"2026-07-02T00:24:34.040189Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T00:24:34.04032Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-07-02T00:24:34.040406Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-02T00:24:34.040416Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-07-02T00:24:34.040444Z","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-07-02T00:24:34.041249Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-07-02T00:24:34.041475Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-07-02T00:24:34.044062Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.315984ms"} {"level":"info","ts":"2026-07-02T00:24:34.049343Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-07-02T00:24:34.049454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-07-02T00:24:34.049482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-07-02T00:24:34.049501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-02T00:24:34.049524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-07-02T00:24:34.049586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-07-02T00:24:34.05956Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-02T00:24:34.060969Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-02T00:24:34.062221Z","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-07-02T00:24:34.064396Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-02T00:24:34.064595Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-02T00:24:34.064758Z","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-07-02T00:24:34.064921Z","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-07-02T00:24:34.064941Z","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-07-02T00:24:34.066712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-07-02T00:24:34.067448Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-07-02T00:24:34.069619Z","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-07-02T00:24:34.069792Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-07-02T00:24:34.069846Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-07-02T00:24:34.070004Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-02T00:24:34.070069Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-02T00:24:34.150358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-07-02T00:24:34.150409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-07-02T00:24:34.150446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-07-02T00:24:34.150468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-07-02T00:24:34.150481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-07-02T00:24:34.150497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-07-02T00:24:34.150517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-07-02T00:24:34.152824Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:24:34.153931Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T00:24:34.153941Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-07-02T00:24:34.154014Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-02T00:24:34.154298Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-02T00:24:34.154382Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-02T00:24:34.154532Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:24:34.154636Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:24:34.154663Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-02T00:24:34.157297Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-07-02T00:24:34.157579Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-02T00:24:39.353457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.128235ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-02T00:24:39.353637Z","caller":"traceutil/trace.go:171","msg":"trace[34730767] linearizableReadLoop","detail":"{readStateIndex:244; appliedIndex:243; }","duration":"441.138827ms","start":"2026-07-02T00:24:38.912474Z","end":"2026-07-02T00:24:39.353613Z","steps":["trace[34730767] 'read index received' (duration: 189.042435ms)","trace[34730767] 'applied index is now lower than readState.Index' (duration: 252.094652ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:24:39.353656Z","caller":"traceutil/trace.go:171","msg":"trace[749280255] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"487.042649ms","start":"2026-07-02T00:24:38.86659Z","end":"2026-07-02T00:24:39.353632Z","steps":["trace[749280255] 'process raft request' (duration: 234.913606ms)","trace[749280255] 'compare' (duration: 250.893569ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:24:39.353747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:38.86656Z","time spent":"487.149822ms","remote":"127.0.0.1:56066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":373,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T00:24:39.353826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.343124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:39.35388Z","caller":"traceutil/trace.go:171","msg":"trace[1059928344] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:238; }","duration":"441.440876ms","start":"2026-07-02T00:24:38.912424Z","end":"2026-07-02T00:24:39.353865Z","steps":["trace[1059928344] 'agreement among raft nodes before linearized reading' (duration: 441.302372ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.353923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:38.912401Z","time spent":"441.510918ms","remote":"127.0.0.1:55912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"info","ts":"2026-07-02T00:24:39.380065Z","caller":"traceutil/trace.go:171","msg":"trace[356796084] transaction","detail":"{read_only:false; number_of_response:0; response_revision:239; }","duration":"342.576788ms","start":"2026-07-02T00:24:39.037459Z","end":"2026-07-02T00:24:39.380036Z","steps":["trace[356796084] 'process raft request' (duration: 342.459325ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.381025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:39.03743Z","time spent":"342.728422ms","remote":"127.0.0.1:55900","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T00:24:39.380107Z","caller":"traceutil/trace.go:171","msg":"trace[376146135] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"432.286033ms","start":"2026-07-02T00:24:38.947776Z","end":"2026-07-02T00:24:39.380062Z","steps":["trace[376146135] 'process raft request' (duration: 432.023886ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:39.380185Z","caller":"traceutil/trace.go:171","msg":"trace[1714354675] transaction","detail":"{read_only:false; response_revision:241; number_of_response:1; }","duration":"323.427468ms","start":"2026-07-02T00:24:39.056712Z","end":"2026-07-02T00:24:39.38014Z","steps":["trace[1714354675] 'process raft request' (duration: 323.333525ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.381155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:38.947753Z","time spent":"433.352222ms","remote":"127.0.0.1:55840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T00:24:39.380165Z","caller":"traceutil/trace.go:171","msg":"trace[1101361263] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"324.054204ms","start":"2026-07-02T00:24:39.056068Z","end":"2026-07-02T00:24:39.380123Z","steps":["trace[1101361263] 'process raft request' (duration: 323.8944ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.381293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:39.056707Z","time spent":"324.479017ms","remote":"127.0.0.1:55904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T00:24:39.381377Z","caller":"traceutil/trace.go:171","msg":"trace[1851369324] transaction","detail":"{read_only:false; number_of_response:0; response_revision:242; }","duration":"323.838609ms","start":"2026-07-02T00:24:39.057444Z","end":"2026-07-02T00:24:39.381283Z","steps":["trace[1851369324] 'process raft request' (duration: 322.677246ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.381523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:39.056043Z","time spent":"325.32002ms","remote":"127.0.0.1:55904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T00:24:39.381703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:39.057432Z","time spent":"324.045155ms","remote":"127.0.0.1:55904","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T00:24:39.381786Z","caller":"traceutil/trace.go:171","msg":"trace[1629884515] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"323.15563ms","start":"2026-07-02T00:24:39.057051Z","end":"2026-07-02T00:24:39.380207Z","steps":["trace[1629884515] 'process raft request' (duration: 323.036906ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.381882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:39.05701Z","time spent":"324.828026ms","remote":"127.0.0.1:55904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-02T00:24:39.382102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.804703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:24:39.382161Z","caller":"traceutil/trace.go:171","msg":"trace[1585544581] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:243; }","duration":"434.874304ms","start":"2026-07-02T00:24:38.947262Z","end":"2026-07-02T00:24:39.382136Z","steps":["trace[1585544581] 'agreement among raft nodes before linearized reading' (duration: 432.952671ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.382213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:38.947256Z","time spent":"434.948126ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-07-02T00:24:39.382739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.563763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-02T00:24:39.382761Z","caller":"traceutil/trace.go:171","msg":"trace[507468738] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"322.639896ms","start":"2026-07-02T00:24:39.057574Z","end":"2026-07-02T00:24:39.380214Z","steps":["trace[507468738] 'process raft request' (duration: 322.574324ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:39.382831Z","caller":"traceutil/trace.go:171","msg":"trace[1607984329] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:243; }","duration":"435.667876ms","start":"2026-07-02T00:24:38.947116Z","end":"2026-07-02T00:24:39.382783Z","steps":["trace[1607984329] 'agreement among raft nodes before linearized reading' (duration: 433.104525ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.382881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:38.947075Z","time spent":"435.794449ms","remote":"127.0.0.1:56118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":686,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-07-02T00:24:39.382887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:24:39.057566Z","time spent":"325.248038ms","remote":"127.0.0.1:55904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-02T00:24:39.503972Z","caller":"traceutil/trace.go:171","msg":"trace[828873422] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"146.247989ms","start":"2026-07-02T00:24:39.357692Z","end":"2026-07-02T00:24:39.50394Z","steps":["trace[828873422] 'process raft request' (duration: 135.80576ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:39.503958Z","caller":"traceutil/trace.go:171","msg":"trace[878501557] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"117.637097ms","start":"2026-07-02T00:24:39.386298Z","end":"2026-07-02T00:24:39.503935Z","steps":["trace[878501557] 'process raft request' (duration: 117.583426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.5041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.99207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-02T00:24:39.504131Z","caller":"traceutil/trace.go:171","msg":"trace[934923189] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:245; }","duration":"147.064282ms","start":"2026-07-02T00:24:39.357058Z","end":"2026-07-02T00:24:39.504123Z","steps":["trace[934923189] 'agreement among raft nodes before linearized reading' (duration: 146.962839ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:39.503972Z","caller":"traceutil/trace.go:171","msg":"trace[851609920] linearizableReadLoop","detail":"{readStateIndex:252; appliedIndex:251; }","duration":"123.742366ms","start":"2026-07-02T00:24:39.380203Z","end":"2026-07-02T00:24:39.503945Z","steps":["trace[851609920] 'read index received' (duration: 113.467921ms)","trace[851609920] 'applied index is now lower than readState.Index' (duration: 10.270395ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:24:39.504318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.763971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-02T00:24:39.504348Z","caller":"traceutil/trace.go:171","msg":"trace[412602813] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:245; }","duration":"117.813693ms","start":"2026-07-02T00:24:39.386528Z","end":"2026-07-02T00:24:39.504342Z","steps":["trace[412602813] 'agreement among raft nodes before linearized reading' (duration: 117.764821ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:24:39.504377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.521357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"warn","ts":"2026-07-02T00:24:39.50437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.149132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4021"} {"level":"warn","ts":"2026-07-02T00:24:39.504391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.129992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4021"} {"level":"info","ts":"2026-07-02T00:24:39.50444Z","caller":"traceutil/trace.go:171","msg":"trace[1129728380] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:245; }","duration":"120.62217ms","start":"2026-07-02T00:24:39.383798Z","end":"2026-07-02T00:24:39.50442Z","steps":["trace[1129728380] 'agreement among raft nodes before linearized reading' (duration: 120.482216ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:39.504447Z","caller":"traceutil/trace.go:171","msg":"trace[626425507] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:245; }","duration":"122.265385ms","start":"2026-07-02T00:24:39.38216Z","end":"2026-07-02T00:24:39.504425Z","steps":["trace[626425507] 'agreement among raft nodes before linearized reading' (duration: 122.061469ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:24:39.504459Z","caller":"traceutil/trace.go:171","msg":"trace[1436322634] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:245; }","duration":"118.244314ms","start":"2026-07-02T00:24:39.386194Z","end":"2026-07-02T00:24:39.504438Z","steps":["trace[1436322634] 'agreement among raft nodes before linearized reading' (duration: 118.048799ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:14.580048Z","caller":"traceutil/trace.go:171","msg":"trace[298793119] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"142.676952ms","start":"2026-07-02T00:25:14.437334Z","end":"2026-07-02T00:25:14.580011Z","steps":["trace[298793119] 'process raft request' (duration: 142.457476ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:14.765064Z","caller":"traceutil/trace.go:171","msg":"trace[987945415] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"287.788684ms","start":"2026-07-02T00:25:14.477245Z","end":"2026-07-02T00:25:14.765033Z","steps":["trace[987945415] 'process raft request' (duration: 287.051453ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:19.257199Z","caller":"traceutil/trace.go:171","msg":"trace[1817430102] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"108.084015ms","start":"2026-07-02T00:25:19.149075Z","end":"2026-07-02T00:25:19.257159Z","steps":["trace[1817430102] 'process raft request' (duration: 107.822777ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:25:19.257151Z","caller":"traceutil/trace.go:171","msg":"trace[446519602] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"106.947783ms","start":"2026-07-02T00:25:19.150171Z","end":"2026-07-02T00:25:19.257119Z","steps":["trace[446519602] 'process raft request' (duration: 106.898871ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:27.588987Z","caller":"traceutil/trace.go:171","msg":"trace[1178493042] transaction","detail":"{read_only:false; response_revision:1427; number_of_response:1; }","duration":"126.939547ms","start":"2026-07-02T00:26:27.462018Z","end":"2026-07-02T00:26:27.588957Z","steps":["trace[1178493042] 'process raft request' (duration: 126.773722ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:26:51.049028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.102173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f8a16c25-7287-407f-b725-1bd5a2286171\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-02T00:26:51.04918Z","caller":"traceutil/trace.go:171","msg":"trace[1781922872] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f8a16c25-7287-407f-b725-1bd5a2286171; range_end:; response_count:1; response_revision:1836; }","duration":"176.301739ms","start":"2026-07-02T00:26:50.872861Z","end":"2026-07-02T00:26:51.049163Z","steps":["trace[1781922872] 'range keys from in-memory index tree' (duration: 175.919288ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:26:51.459598Z","caller":"traceutil/trace.go:171","msg":"trace[110578104] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"167.844789ms","start":"2026-07-02T00:26:51.291719Z","end":"2026-07-02T00:26:51.459564Z","steps":["trace[110578104] 'process raft request' (duration: 167.54265ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:07.11708Z","caller":"traceutil/trace.go:171","msg":"trace[623425956] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"125.597468ms","start":"2026-07-02T00:27:06.991461Z","end":"2026-07-02T00:27:07.117058Z","steps":["trace[623425956] 'process raft request' (duration: 125.494275ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:42.594692Z","caller":"traceutil/trace.go:171","msg":"trace[1276534766] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"160.661459ms","start":"2026-07-02T00:27:42.434001Z","end":"2026-07-02T00:27:42.594662Z","steps":["trace[1276534766] 'read index received' (duration: 160.34154ms)","trace[1276534766] 'applied index is now lower than readState.Index' (duration: 318.709µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:27:42.594918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.896086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:27:42.594964Z","caller":"traceutil/trace.go:171","msg":"trace[1517879811] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:2166; }","duration":"161.002449ms","start":"2026-07-02T00:27:42.43395Z","end":"2026-07-02T00:27:42.594952Z","steps":["trace[1517879811] 'agreement among raft nodes before linearized reading' (duration: 160.814474ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:42.594965Z","caller":"traceutil/trace.go:171","msg":"trace[2118042887] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"181.64919ms","start":"2026-07-02T00:27:42.413278Z","end":"2026-07-02T00:27:42.594927Z","steps":["trace[2118042887] 'process raft request' (duration: 181.172226ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:43.101742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.835935ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-07-02T00:27:43.102044Z","caller":"traceutil/trace.go:171","msg":"trace[425005419] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2247; }","duration":"260.845217ms","start":"2026-07-02T00:27:42.84118Z","end":"2026-07-02T00:27:43.102025Z","steps":["trace[425005419] 'read index received' (duration: 57.724613ms)","trace[425005419] 'applied index is now lower than readState.Index' (duration: 203.119594ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:27:43.102381Z","caller":"traceutil/trace.go:171","msg":"trace[1295265878] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"288.185156ms","start":"2026-07-02T00:27:42.814163Z","end":"2026-07-02T00:27:43.102348Z","steps":["trace[1295265878] 'process raft request' (duration: 287.715533ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:27:43.102441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.698992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-02T00:27:43.10244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.260169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-02T00:27:43.102437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.21564ms","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-07-02T00:27:43.102493Z","caller":"traceutil/trace.go:171","msg":"trace[990458857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2167; }","duration":"261.354152ms","start":"2026-07-02T00:27:42.841124Z","end":"2026-07-02T00:27:43.102478Z","steps":["trace[990458857] 'agreement among raft nodes before linearized reading' (duration: 261.190047ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:43.102527Z","caller":"traceutil/trace.go:171","msg":"trace[1148039752] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2167; }","duration":"244.345334ms","start":"2026-07-02T00:27:42.858161Z","end":"2026-07-02T00:27:43.102506Z","steps":["trace[1148039752] 'agreement among raft nodes before linearized reading' (duration: 244.117827ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:43.102479Z","caller":"traceutil/trace.go:171","msg":"trace[2058310084] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2167; }","duration":"127.784545ms","start":"2026-07-02T00:27:42.974683Z","end":"2026-07-02T00:27:43.102468Z","steps":["trace[2058310084] 'agreement among raft nodes before linearized reading' (duration: 127.673731ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:43.241794Z","caller":"traceutil/trace.go:171","msg":"trace[1815689489] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"134.992987ms","start":"2026-07-02T00:27:43.106777Z","end":"2026-07-02T00:27:43.24177Z","steps":["trace[1815689489] 'process raft request' (duration: 130.231203ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:43.242149Z","caller":"traceutil/trace.go:171","msg":"trace[1857203918] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"134.759691ms","start":"2026-07-02T00:27:43.107359Z","end":"2026-07-02T00:27:43.242118Z","steps":["trace[1857203918] 'process raft request' (duration: 134.3701ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:27:43.242181Z","caller":"traceutil/trace.go:171","msg":"trace[1796256747] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"133.99795ms","start":"2026-07-02T00:27:43.108148Z","end":"2026-07-02T00:27:43.242146Z","steps":["trace[1796256747] 'process raft request' (duration: 133.862876ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:28:37.326317Z","caller":"traceutil/trace.go:171","msg":"trace[52279128] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"149.619844ms","start":"2026-07-02T00:28:37.176667Z","end":"2026-07-02T00:28:37.326287Z","steps":["trace[52279128] 'process raft request' (duration: 149.364176ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:33:02.539376Z","caller":"traceutil/trace.go:171","msg":"trace[1363643519] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"117.90466ms","start":"2026-07-02T00:33:02.421452Z","end":"2026-07-02T00:33:02.539356Z","steps":["trace[1363643519] 'process raft request' (duration: 117.770336ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:33:14.471864Z","caller":"traceutil/trace.go:171","msg":"trace[1167247871] transaction","detail":"{read_only:false; response_revision:5250; number_of_response:1; }","duration":"106.741729ms","start":"2026-07-02T00:33:14.365098Z","end":"2026-07-02T00:33:14.47184Z","steps":["trace[1167247871] 'process raft request' (duration: 29.305058ms)","trace[1167247871] 'compare' (duration: 77.304647ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:33:17.086537Z","caller":"traceutil/trace.go:171","msg":"trace[1641617731] linearizableReadLoop","detail":"{readStateIndex:5487; appliedIndex:5485; }","duration":"102.47302ms","start":"2026-07-02T00:33:16.984022Z","end":"2026-07-02T00:33:17.086495Z","steps":["trace[1641617731] 'read index received' (duration: 97.225604ms)","trace[1641617731] 'applied index is now lower than readState.Index' (duration: 5.246056ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:33:17.086633Z","caller":"traceutil/trace.go:171","msg":"trace[904399073] transaction","detail":"{read_only:false; response_revision:5291; number_of_response:1; }","duration":"106.599055ms","start":"2026-07-02T00:33:16.980026Z","end":"2026-07-02T00:33:17.086625Z","steps":["trace[904399073] 'process raft request' (duration: 106.377508ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:33:17.086797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.422861ms","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-07-02T00:33:17.086838Z","caller":"traceutil/trace.go:171","msg":"trace[124060196] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5291; }","duration":"101.494582ms","start":"2026-07-02T00:33:16.985334Z","end":"2026-07-02T00:33:17.086828Z","steps":["trace[124060196] 'agreement among raft nodes before linearized reading' (duration: 101.362749ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:33:17.086859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.816759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-02T00:33:17.086937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.893586ms","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-07-02T00:33:17.086564Z","caller":"traceutil/trace.go:171","msg":"trace[1645327813] transaction","detail":"{read_only:false; response_revision:5290; number_of_response:1; }","duration":"108.56498ms","start":"2026-07-02T00:33:16.977969Z","end":"2026-07-02T00:33:17.086534Z","steps":["trace[1645327813] 'process raft request' (duration: 103.257112ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:33:17.086965Z","caller":"traceutil/trace.go:171","msg":"trace[870608785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5291; }","duration":"100.944437ms","start":"2026-07-02T00:33:16.986015Z","end":"2026-07-02T00:33:17.086959Z","steps":["trace[870608785] 'agreement among raft nodes before linearized reading' (duration: 100.880055ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:33:17.086927Z","caller":"traceutil/trace.go:171","msg":"trace[2139895388] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5291; }","duration":"102.944683ms","start":"2026-07-02T00:33:16.983967Z","end":"2026-07-02T00:33:17.086912Z","steps":["trace[2139895388] 'agreement among raft nodes before linearized reading' (duration: 102.720786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:33:17.087151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.781611ms","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-07-02T00:33:17.087182Z","caller":"traceutil/trace.go:171","msg":"trace[466797639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5291; }","duration":"101.870633ms","start":"2026-07-02T00:33:16.985299Z","end":"2026-07-02T00:33:17.087174Z","steps":["trace[466797639] 'agreement among raft nodes before linearized reading' (duration: 101.699188ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:33:23.526051Z","caller":"traceutil/trace.go:171","msg":"trace[1229602677] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"341.752488ms","start":"2026-07-02T00:33:23.184273Z","end":"2026-07-02T00:33:23.526026Z","steps":["trace[1229602677] 'process raft request' (duration: 341.506141ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:33:23.526031Z","caller":"traceutil/trace.go:171","msg":"trace[1481088891] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"341.576072ms","start":"2026-07-02T00:33:23.184431Z","end":"2026-07-02T00:33:23.526007Z","steps":["trace[1481088891] 'process raft request' (duration: 341.49931ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:33:23.526239Z","caller":"traceutil/trace.go:171","msg":"trace[1079143083] linearizableReadLoop","detail":"{readStateIndex:5636; appliedIndex:5633; }","duration":"234.433653ms","start":"2026-07-02T00:33:23.291795Z","end":"2026-07-02T00:33:23.526229Z","steps":["trace[1079143083] 'read index received' (duration: 234.093343ms)","trace[1079143083] 'applied index is now lower than readState.Index' (duration: 339.26µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:33:23.526342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:33:23.184243Z","time spent":"341.878572ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:33:23.52648Z","caller":"traceutil/trace.go:171","msg":"trace[387353543] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"341.225953ms","start":"2026-07-02T00:33:23.185232Z","end":"2026-07-02T00:33:23.526458Z","steps":["trace[387353543] 'process raft request' (duration: 340.737219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:33:23.526514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:33:23.184407Z","time spent":"341.730097ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:33:23.526599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:33:23.185221Z","time spent":"341.318775ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T00:33:23.526957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.41736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-07-02T00:33:23.527168Z","caller":"traceutil/trace.go:171","msg":"trace[341936682] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5435; }","duration":"192.617076ms","start":"2026-07-02T00:33:23.334483Z","end":"2026-07-02T00:33:23.5271Z","steps":["trace[341936682] 'agreement among raft nodes before linearized reading' (duration: 191.951067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:33:23.526976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.621878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:33:23.527679Z","caller":"traceutil/trace.go:171","msg":"trace[71335112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5435; }","duration":"235.837361ms","start":"2026-07-02T00:33:23.29175Z","end":"2026-07-02T00:33:23.527588Z","steps":["trace[71335112] 'agreement among raft nodes before linearized reading' (duration: 234.602027ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:34:34.424427Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2967} {"level":"info","ts":"2026-07-02T00:34:34.487791Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2967,"took":"61.836943ms","hash":4004941302,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":34082816,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-02T00:34:34.487877Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4004941302,"revision":2967,"compact-revision":-1} {"level":"info","ts":"2026-07-02T00:39:27.039748Z","caller":"traceutil/trace.go:171","msg":"trace[1692522878] linearizableReadLoop","detail":"{readStateIndex:8529; appliedIndex:8528; }","duration":"147.97144ms","start":"2026-07-02T00:39:26.89175Z","end":"2026-07-02T00:39:27.039722Z","steps":["trace[1692522878] 'read index received' (duration: 147.742144ms)","trace[1692522878] 'applied index is now lower than readState.Index' (duration: 228.036µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:39:27.039897Z","caller":"traceutil/trace.go:171","msg":"trace[1129978773] transaction","detail":"{read_only:false; response_revision:8241; number_of_response:1; }","duration":"163.338966ms","start":"2026-07-02T00:39:26.876547Z","end":"2026-07-02T00:39:27.039886Z","steps":["trace[1129978773] 'process raft request' (duration: 162.964725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:39:27.040365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.608807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-56d9b657bf-vrdtn.18be5215fdbf041d\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-07-02T00:39:27.040459Z","caller":"traceutil/trace.go:171","msg":"trace[683821900] range","detail":"{range_begin:/registry/events/openstack/barbican-api-56d9b657bf-vrdtn.18be5215fdbf041d; range_end:; response_count:1; response_revision:8241; }","duration":"148.753832ms","start":"2026-07-02T00:39:26.891685Z","end":"2026-07-02T00:39:27.040439Z","steps":["trace[683821900] 'agreement among raft nodes before linearized reading' (duration: 148.555496ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:39:27.240421Z","caller":"traceutil/trace.go:171","msg":"trace[537266720] transaction","detail":"{read_only:false; response_revision:8243; number_of_response:1; }","duration":"195.696374ms","start":"2026-07-02T00:39:27.044692Z","end":"2026-07-02T00:39:27.240388Z","steps":["trace[537266720] 'process raft request' (duration: 195.588931ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:39:27.241532Z","caller":"traceutil/trace.go:171","msg":"trace[2036237769] transaction","detail":"{read_only:false; response_revision:8242; number_of_response:1; }","duration":"198.786279ms","start":"2026-07-02T00:39:27.042697Z","end":"2026-07-02T00:39:27.241483Z","steps":["trace[2036237769] 'process raft request' (duration: 140.37064ms)","trace[2036237769] 'compare' (duration: 55.410996ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:39:34.430142Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6090} {"level":"info","ts":"2026-07-02T00:39:34.532667Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6090,"took":"100.365542ms","hash":1720947573,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":23396352,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-07-02T00:39:34.532738Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1720947573,"revision":6090,"compact-revision":2967} {"level":"info","ts":"2026-07-02T00:39:38.596215Z","caller":"traceutil/trace.go:171","msg":"trace[1714992536] transaction","detail":"{read_only:false; response_revision:8304; number_of_response:1; }","duration":"146.471049ms","start":"2026-07-02T00:39:38.44972Z","end":"2026-07-02T00:39:38.596191Z","steps":["trace[1714992536] 'process raft request' (duration: 146.311945ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:39:38.768192Z","caller":"traceutil/trace.go:171","msg":"trace[1469956547] linearizableReadLoop","detail":"{readStateIndex:8598; appliedIndex:8596; }","duration":"190.991803ms","start":"2026-07-02T00:39:38.577177Z","end":"2026-07-02T00:39:38.768169Z","steps":["trace[1469956547] 'read index received' (duration: 18.850013ms)","trace[1469956547] 'applied index is now lower than readState.Index' (duration: 172.14035ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:39:38.768284Z","caller":"traceutil/trace.go:171","msg":"trace[407213356] transaction","detail":"{read_only:false; response_revision:8305; number_of_response:1; }","duration":"261.177398ms","start":"2026-07-02T00:39:38.507085Z","end":"2026-07-02T00:39:38.768262Z","steps":["trace[407213356] 'process raft request' (duration: 260.938551ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:39:38.768323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.131687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:39:38.768354Z","caller":"traceutil/trace.go:171","msg":"trace[35924814] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:8305; }","duration":"191.222979ms","start":"2026-07-02T00:39:38.577122Z","end":"2026-07-02T00:39:38.768345Z","steps":["trace[35924814] 'agreement among raft nodes before linearized reading' (duration: 191.140177ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:39:39.539313Z","caller":"traceutil/trace.go:171","msg":"trace[80328805] linearizableReadLoop","detail":"{readStateIndex:8601; appliedIndex:8600; }","duration":"193.480803ms","start":"2026-07-02T00:39:39.34581Z","end":"2026-07-02T00:39:39.539291Z","steps":["trace[80328805] 'read index received' (duration: 193.406211ms)","trace[80328805] 'applied index is now lower than readState.Index' (duration: 73.762µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:39:39.539453Z","caller":"traceutil/trace.go:171","msg":"trace[1352872462] transaction","detail":"{read_only:false; response_revision:8308; number_of_response:1; }","duration":"238.293164ms","start":"2026-07-02T00:39:39.301121Z","end":"2026-07-02T00:39:39.539414Z","steps":["trace[1352872462] 'process raft request' (duration: 237.967565ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:39:39.539554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.732959ms","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-07-02T00:39:39.539596Z","caller":"traceutil/trace.go:171","msg":"trace[90681098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8308; }","duration":"193.814472ms","start":"2026-07-02T00:39:39.345768Z","end":"2026-07-02T00:39:39.539582Z","steps":["trace[90681098] 'agreement among raft nodes before linearized reading' (duration: 193.643147ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:39:39.574434Z","caller":"traceutil/trace.go:171","msg":"trace[694246122] transaction","detail":"{read_only:false; response_revision:8309; number_of_response:1; }","duration":"182.756205ms","start":"2026-07-02T00:39:39.391655Z","end":"2026-07-02T00:39:39.574411Z","steps":["trace[694246122] 'process raft request' (duration: 182.617381ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:39:39.574574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.503561ms","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-07-02T00:39:39.574623Z","caller":"traceutil/trace.go:171","msg":"trace[1042430367] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8309; }","duration":"220.599263ms","start":"2026-07-02T00:39:39.354012Z","end":"2026-07-02T00:39:39.574611Z","steps":["trace[1042430367] 'agreement among raft nodes before linearized reading' (duration: 220.395338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:39:39.57462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.989116ms","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-07-02T00:39:39.57466Z","caller":"traceutil/trace.go:171","msg":"trace[1305277202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8309; }","duration":"216.055378ms","start":"2026-07-02T00:39:39.358594Z","end":"2026-07-02T00:39:39.574649Z","steps":["trace[1305277202] 'agreement among raft nodes before linearized reading' (duration: 215.903144ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:39:39.661889Z","caller":"traceutil/trace.go:171","msg":"trace[1253134935] transaction","detail":"{read_only:false; response_revision:8310; number_of_response:1; }","duration":"117.417025ms","start":"2026-07-02T00:39:39.544448Z","end":"2026-07-02T00:39:39.661865Z","steps":["trace[1253134935] 'process raft request' (duration: 117.23788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:40:07.040477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.475134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-56d9b657bf-vrdtn.18be5215fdbf041d\" ","response":"range_response_count:1 size:1135"} {"level":"info","ts":"2026-07-02T00:40:07.040546Z","caller":"traceutil/trace.go:171","msg":"trace[650714240] range","detail":"{range_begin:/registry/events/openstack/barbican-api-56d9b657bf-vrdtn.18be5215fdbf041d; range_end:; response_count:1; response_revision:8506; }","duration":"148.588776ms","start":"2026-07-02T00:40:06.891942Z","end":"2026-07-02T00:40:07.04053Z","steps":["trace[650714240] 'range keys from in-memory index tree' (duration: 148.317129ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:40:07.230402Z","caller":"traceutil/trace.go:171","msg":"trace[788852932] transaction","detail":"{read_only:false; response_revision:8507; number_of_response:1; }","duration":"291.65494ms","start":"2026-07-02T00:40:06.938731Z","end":"2026-07-02T00:40:07.230386Z","steps":["trace[788852932] 'process raft request' (duration: 291.556097ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:40:07.244827Z","caller":"traceutil/trace.go:171","msg":"trace[208218308] transaction","detail":"{read_only:false; response_revision:8508; number_of_response:1; }","duration":"201.703378ms","start":"2026-07-02T00:40:07.04311Z","end":"2026-07-02T00:40:07.244813Z","steps":["trace[208218308] 'process raft request' (duration: 200.177815ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:40:07.245191Z","caller":"traceutil/trace.go:171","msg":"trace[942011763] transaction","detail":"{read_only:false; response_revision:8509; number_of_response:1; }","duration":"179.714999ms","start":"2026-07-02T00:40:07.065469Z","end":"2026-07-02T00:40:07.245184Z","steps":["trace[942011763] 'process raft request' (duration: 178.940857ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:40:10.606546Z","caller":"traceutil/trace.go:171","msg":"trace[892435933] transaction","detail":"{read_only:false; response_revision:8530; number_of_response:1; }","duration":"105.996017ms","start":"2026-07-02T00:40:10.500516Z","end":"2026-07-02T00:40:10.606512Z","steps":["trace[892435933] 'process raft request' (duration: 105.799731ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:40:20.141165Z","caller":"traceutil/trace.go:171","msg":"trace[178888894] transaction","detail":"{read_only:false; response_revision:8624; number_of_response:1; }","duration":"222.35217ms","start":"2026-07-02T00:40:19.918782Z","end":"2026-07-02T00:40:20.141135Z","steps":["trace[178888894] 'process raft request' (duration: 152.119915ms)","trace[178888894] 'compare' (duration: 70.03519ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:40:20.141168Z","caller":"traceutil/trace.go:171","msg":"trace[1175217231] linearizableReadLoop","detail":"{readStateIndex:8929; appliedIndex:8928; }","duration":"181.102917ms","start":"2026-07-02T00:40:19.96003Z","end":"2026-07-02T00:40:20.141133Z","steps":["trace[1175217231] 'read index received' (duration: 110.844611ms)","trace[1175217231] 'applied index is now lower than readState.Index' (duration: 70.256026ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:40:20.141335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.289182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-02T00:40:20.14141Z","caller":"traceutil/trace.go:171","msg":"trace[1562072809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8624; }","duration":"181.425676ms","start":"2026-07-02T00:40:19.959965Z","end":"2026-07-02T00:40:20.141391Z","steps":["trace[1562072809] 'agreement among raft nodes before linearized reading' (duration: 181.263652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:40:20.14155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.427376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-02T00:40:20.14163Z","caller":"traceutil/trace.go:171","msg":"trace[950315809] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:8624; }","duration":"142.567139ms","start":"2026-07-02T00:40:19.999044Z","end":"2026-07-02T00:40:20.141611Z","steps":["trace[950315809] 'agreement among raft nodes before linearized reading' (duration: 142.316392ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:40:20.916715Z","caller":"traceutil/trace.go:171","msg":"trace[165590642] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"135.72637ms","start":"2026-07-02T00:40:20.780969Z","end":"2026-07-02T00:40:20.916696Z","steps":["trace[165590642] 'process raft request' (duration: 135.613407ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:40:37.370314Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023ae.wal"} {"level":"info","ts":"2026-07-02T00:41:35.697384Z","caller":"traceutil/trace.go:171","msg":"trace[505334235] transaction","detail":"{read_only:false; response_revision:9366; number_of_response:1; }","duration":"132.87113ms","start":"2026-07-02T00:41:35.564478Z","end":"2026-07-02T00:41:35.697349Z","steps":["trace[505334235] 'process raft request' (duration: 113.229656ms)","trace[505334235] 'compare' (duration: 19.49053ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:42:15.323325Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-02T00:42:15.331432Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-02T00:42:15.331554Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-02T00:44:34.436922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8281} {"level":"info","ts":"2026-07-02T00:44:34.517447Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8281,"took":"78.094481ms","hash":306696572,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":26222592,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-07-02T00:44:34.517515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":306696572,"revision":8281,"compact-revision":6090} {"level":"info","ts":"2026-07-02T00:44:58.035994Z","caller":"traceutil/trace.go:171","msg":"trace[1438552750] transaction","detail":"{read_only:false; response_revision:11099; number_of_response:1; }","duration":"166.025734ms","start":"2026-07-02T00:44:57.869946Z","end":"2026-07-02T00:44:58.035972Z","steps":["trace[1438552750] 'process raft request' (duration: 165.88406ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:49:34.443592Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10775} {"level":"info","ts":"2026-07-02T00:49:34.521276Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10775,"took":"75.165802ms","hash":3714604228,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":27996160,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-02T00:49:34.521352Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3714604228,"revision":10775,"compact-revision":8281} {"level":"info","ts":"2026-07-02T00:51:11.507845Z","caller":"traceutil/trace.go:171","msg":"trace[1840301307] transaction","detail":"{read_only:false; response_revision:13628; number_of_response:1; }","duration":"123.793608ms","start":"2026-07-02T00:51:11.38402Z","end":"2026-07-02T00:51:11.507814Z","steps":["trace[1840301307] 'process raft request' (duration: 123.628713ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:51:49.264875Z","caller":"traceutil/trace.go:171","msg":"trace[1613926681] linearizableReadLoop","detail":"{readStateIndex:14308; appliedIndex:14307; }","duration":"137.906932ms","start":"2026-07-02T00:51:49.126937Z","end":"2026-07-02T00:51:49.264844Z","steps":["trace[1613926681] 'read index received' (duration: 124.62624ms)","trace[1613926681] 'applied index is now lower than readState.Index' (duration: 13.279662ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:51:49.26494Z","caller":"traceutil/trace.go:171","msg":"trace[79151705] transaction","detail":"{read_only:false; response_revision:13834; number_of_response:1; }","duration":"138.409917ms","start":"2026-07-02T00:51:49.126467Z","end":"2026-07-02T00:51:49.264877Z","steps":["trace[79151705] 'process raft request' (duration: 125.076654ms)","trace[79151705] 'compare' (duration: 13.157388ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:51:49.265175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.219512ms","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-07-02T00:51:49.265221Z","caller":"traceutil/trace.go:171","msg":"trace[1305755695] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13834; }","duration":"138.321975ms","start":"2026-07-02T00:51:49.126887Z","end":"2026-07-02T00:51:49.265209Z","steps":["trace[1305755695] 'agreement among raft nodes before linearized reading' (duration: 138.128229ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:51:50.114684Z","caller":"traceutil/trace.go:171","msg":"trace[571756359] transaction","detail":"{read_only:false; response_revision:13841; number_of_response:1; }","duration":"218.83889ms","start":"2026-07-02T00:51:49.895819Z","end":"2026-07-02T00:51:50.114658Z","steps":["trace[571756359] 'process raft request' (duration: 218.644125ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:51:59.24216Z","caller":"traceutil/trace.go:171","msg":"trace[2139959506] transaction","detail":"{read_only:false; response_revision:14003; number_of_response:1; }","duration":"187.113591ms","start":"2026-07-02T00:51:59.055009Z","end":"2026-07-02T00:51:59.242123Z","steps":["trace[2139959506] 'process raft request' (duration: 186.811942ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:53:28.238198Z","caller":"traceutil/trace.go:171","msg":"trace[1636911877] transaction","detail":"{read_only:false; response_revision:15034; number_of_response:1; }","duration":"182.715387ms","start":"2026-07-02T00:53:28.055448Z","end":"2026-07-02T00:53:28.238163Z","steps":["trace[1636911877] 'process raft request' (duration: 111.341198ms)","trace[1636911877] 'compare' (duration: 71.114202ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T00:54:34.450935Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12952} {"level":"info","ts":"2026-07-02T00:54:34.530229Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12952,"took":"76.544754ms","hash":1700474382,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":31051776,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-02T00:54:34.530273Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1700474382,"revision":12952,"compact-revision":10775} {"level":"warn","ts":"2026-07-02T00:59:14.98825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.750823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T00:59:14.988346Z","caller":"traceutil/trace.go:171","msg":"trace[1146891060] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:17661; }","duration":"147.897227ms","start":"2026-07-02T00:59:14.840429Z","end":"2026-07-02T00:59:14.988326Z","steps":["trace[1146891060] 'count revisions from in-memory index tree' (duration: 147.645721ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:59:21.53423Z","caller":"traceutil/trace.go:171","msg":"trace[768361432] linearizableReadLoop","detail":"{readStateIndex:18309; appliedIndex:18308; }","duration":"171.293624ms","start":"2026-07-02T00:59:21.362912Z","end":"2026-07-02T00:59:21.534206Z","steps":["trace[768361432] 'read index received' (duration: 171.117029ms)","trace[768361432] 'applied index is now lower than readState.Index' (duration: 175.695µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:59:21.534509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.567351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-02T00:59:21.534599Z","caller":"traceutil/trace.go:171","msg":"trace[1250981458] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17711; }","duration":"171.687415ms","start":"2026-07-02T00:59:21.362891Z","end":"2026-07-02T00:59:21.534578Z","steps":["trace[1250981458] 'agreement among raft nodes before linearized reading' (duration: 171.425088ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:59:21.534307Z","caller":"traceutil/trace.go:171","msg":"trace[1367016826] transaction","detail":"{read_only:false; response_revision:17711; number_of_response:1; }","duration":"171.600043ms","start":"2026-07-02T00:59:21.362679Z","end":"2026-07-02T00:59:21.534279Z","steps":["trace[1367016826] 'process raft request' (duration: 171.371846ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:59:21.544729Z","caller":"traceutil/trace.go:171","msg":"trace[1626924591] transaction","detail":"{read_only:false; response_revision:17713; number_of_response:1; }","duration":"137.927058ms","start":"2026-07-02T00:59:21.406777Z","end":"2026-07-02T00:59:21.544704Z","steps":["trace[1626924591] 'process raft request' (duration: 137.687941ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:59:21.544945Z","caller":"traceutil/trace.go:171","msg":"trace[921641304] transaction","detail":"{read_only:false; response_revision:17712; number_of_response:1; }","duration":"180.103401ms","start":"2026-07-02T00:59:21.364827Z","end":"2026-07-02T00:59:21.54493Z","steps":["trace[921641304] 'process raft request' (duration: 179.525855ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:59:22.179346Z","caller":"traceutil/trace.go:171","msg":"trace[155459401] linearizableReadLoop","detail":"{readStateIndex:18315; appliedIndex:18314; }","duration":"133.917135ms","start":"2026-07-02T00:59:22.045407Z","end":"2026-07-02T00:59:22.179324Z","steps":["trace[155459401] 'read index received' (duration: 133.606236ms)","trace[155459401] 'applied index is now lower than readState.Index' (duration: 309.969µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T00:59:22.179546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.134342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-lzwqn\" ","response":"range_response_count:1 size:22125"} {"level":"info","ts":"2026-07-02T00:59:22.179545Z","caller":"traceutil/trace.go:171","msg":"trace[696676186] transaction","detail":"{read_only:false; response_revision:17717; number_of_response:1; }","duration":"456.217784ms","start":"2026-07-02T00:59:21.723302Z","end":"2026-07-02T00:59:22.17952Z","steps":["trace[696676186] 'process raft request' (duration: 455.813792ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T00:59:22.179803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T00:59:21.723273Z","time spent":"456.464091ms","remote":"127.0.0.1:55904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20871,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T00:59:22.179662Z","caller":"traceutil/trace.go:171","msg":"trace[1323873822] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-lzwqn; range_end:; response_count:1; response_revision:17717; }","duration":"134.258204ms","start":"2026-07-02T00:59:22.045327Z","end":"2026-07-02T00:59:22.179585Z","steps":["trace[1323873822] 'agreement among raft nodes before linearized reading' (duration: 134.08557ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T00:59:34.460941Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15442} {"level":"info","ts":"2026-07-02T00:59:34.549312Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15442,"took":"85.87482ms","hash":1449635980,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":33570816,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-02T00:59:34.549364Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1449635980,"revision":15442,"compact-revision":12952} {"level":"info","ts":"2026-07-02T01:02:32.588788Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-02T01:02:32.594709Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-02T01:02:32.594813Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-02T01:04:34.4675Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17995} {"level":"info","ts":"2026-07-02T01:04:34.580218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17995,"took":"108.673363ms","hash":2940419724,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":30625792,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-02T01:04:34.580293Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2940419724,"revision":17995,"compact-revision":15442} {"level":"warn","ts":"2026-07-02T01:05:01.606954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.303927ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:05:01.607047Z","caller":"traceutil/trace.go:171","msg":"trace[1831947926] linearizableReadLoop","detail":"{readStateIndex:21050; appliedIndex:21049; }","duration":"252.791007ms","start":"2026-07-02T01:05:01.354244Z","end":"2026-07-02T01:05:01.607035Z","steps":["trace[1831947926] 'read index received' (duration: 122.363546ms)","trace[1831947926] 'applied index is now lower than readState.Index' (duration: 130.426521ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:05:01.607179Z","caller":"traceutil/trace.go:171","msg":"trace[1606228046] transaction","detail":"{read_only:false; response_revision:20363; number_of_response:1; }","duration":"266.559441ms","start":"2026-07-02T01:05:01.340609Z","end":"2026-07-02T01:05:01.607168Z","steps":["trace[1606228046] 'process raft request' (duration: 135.983486ms)","trace[1606228046] 'compare' (duration: 129.932997ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:05:01.607419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.586638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T01:05:01.607443Z","caller":"traceutil/trace.go:171","msg":"trace[1568501136] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20363; }","duration":"273.63913ms","start":"2026-07-02T01:05:01.333797Z","end":"2026-07-02T01:05:01.607436Z","steps":["trace[1568501136] 'agreement among raft nodes before linearized reading' (duration: 273.510516ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:05:01.607508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.361101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-02T01:05:01.60755Z","caller":"traceutil/trace.go:171","msg":"trace[1181644406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20363; }","duration":"278.436513ms","start":"2026-07-02T01:05:01.329104Z","end":"2026-07-02T01:05:01.60754Z","steps":["trace[1181644406] 'agreement among raft nodes before linearized reading' (duration: 278.33279ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:05:01.608089Z","caller":"traceutil/trace.go:171","msg":"trace[2115227109] transaction","detail":"{read_only:false; response_revision:20364; number_of_response:1; }","duration":"249.911106ms","start":"2026-07-02T01:05:01.358151Z","end":"2026-07-02T01:05:01.608062Z","steps":["trace[2115227109] 'process raft request' (duration: 249.719441ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:05:01.60813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.885787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/heat-engine-cleaner-29715905-d4j8h\" ","response":"range_response_count:1 size:6988"} {"level":"info","ts":"2026-07-02T01:05:01.608193Z","caller":"traceutil/trace.go:171","msg":"trace[1143053473] range","detail":"{range_begin:/registry/pods/openstack/heat-engine-cleaner-29715905-d4j8h; range_end:; response_count:1; response_revision:20364; }","duration":"167.98956ms","start":"2026-07-02T01:05:01.440185Z","end":"2026-07-02T01:05:01.608175Z","steps":["trace[1143053473] 'agreement among raft nodes before linearized reading' (duration: 167.802135ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:05:01.80847Z","caller":"traceutil/trace.go:171","msg":"trace[1081487649] transaction","detail":"{read_only:false; response_revision:20366; number_of_response:1; }","duration":"195.082196ms","start":"2026-07-02T01:05:01.613357Z","end":"2026-07-02T01:05:01.808439Z","steps":["trace[1081487649] 'process raft request' (duration: 194.894161ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:05:01.808489Z","caller":"traceutil/trace.go:171","msg":"trace[2123676147] transaction","detail":"{read_only:false; response_revision:20367; number_of_response:1; }","duration":"194.955533ms","start":"2026-07-02T01:05:01.613515Z","end":"2026-07-02T01:05:01.80847Z","steps":["trace[2123676147] 'process raft request' (duration: 194.87304ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:05:01.808632Z","caller":"traceutil/trace.go:171","msg":"trace[826335585] transaction","detail":"{read_only:false; response_revision:20368; number_of_response:1; }","duration":"191.553547ms","start":"2026-07-02T01:05:01.617072Z","end":"2026-07-02T01:05:01.808626Z","steps":["trace[826335585] 'process raft request' (duration: 191.348481ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:05:02.051292Z","caller":"traceutil/trace.go:171","msg":"trace[1789270950] transaction","detail":"{read_only:false; response_revision:20369; number_of_response:1; }","duration":"136.247054ms","start":"2026-07-02T01:05:01.915013Z","end":"2026-07-02T01:05:02.05126Z","steps":["trace[1789270950] 'process raft request' (duration: 135.934095ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:08:48.066241Z","caller":"traceutil/trace.go:171","msg":"trace[217736912] transaction","detail":"{read_only:false; response_revision:22778; number_of_response:1; }","duration":"194.997492ms","start":"2026-07-02T01:08:47.87122Z","end":"2026-07-02T01:08:48.066217Z","steps":["trace[217736912] 'process raft request' (duration: 194.837937ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:08:48.066355Z","caller":"traceutil/trace.go:171","msg":"trace[1751210981] linearizableReadLoop","detail":"{readStateIndex:23536; appliedIndex:23536; }","duration":"184.233691ms","start":"2026-07-02T01:08:47.882097Z","end":"2026-07-02T01:08:48.066331Z","steps":["trace[1751210981] 'read index received' (duration: 184.143718ms)","trace[1751210981] 'applied index is now lower than readState.Index' (duration: 6.611µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:08:48.066507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.370915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:08:48.066631Z","caller":"traceutil/trace.go:171","msg":"trace[2034108645] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:22778; }","duration":"184.53776ms","start":"2026-07-02T01:08:47.882066Z","end":"2026-07-02T01:08:48.066604Z","steps":["trace[2034108645] 'agreement among raft nodes before linearized reading' (duration: 184.329824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:08:48.067528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.260031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-02T01:08:48.067581Z","caller":"traceutil/trace.go:171","msg":"trace[669976134] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22778; }","duration":"152.313011ms","start":"2026-07-02T01:08:47.915256Z","end":"2026-07-02T01:08:48.067569Z","steps":["trace[669976134] 'agreement among raft nodes before linearized reading' (duration: 151.20578ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:09:34.473663Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20197} {"level":"info","ts":"2026-07-02T01:09:34.580493Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20197,"took":"104.228569ms","hash":3772537471,"current-db-size-bytes":58593280,"current-db-size":"59 MB","current-db-size-in-use-bytes":43233280,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-07-02T01:09:34.580552Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3772537471,"revision":20197,"compact-revision":17995} {"level":"warn","ts":"2026-07-02T01:12:04.215372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.310151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:04.21563Z","caller":"traceutil/trace.go:171","msg":"trace[583375880] transaction","detail":"{read_only:false; response_revision:24815; number_of_response:1; }","duration":"266.392995ms","start":"2026-07-02T01:12:03.949195Z","end":"2026-07-02T01:12:04.215588Z","steps":["trace[583375880] 'process raft request' (duration: 70.769795ms)","trace[583375880] 'compare' (duration: 195.196508ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:04.215897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.703918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-02T01:12:04.215943Z","caller":"traceutil/trace.go:171","msg":"trace[1213694226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24815; }","duration":"240.793941ms","start":"2026-07-02T01:12:03.975139Z","end":"2026-07-02T01:12:04.215933Z","steps":["trace[1213694226] 'agreement among raft nodes before linearized reading' (duration: 240.648367ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:04.215744Z","caller":"traceutil/trace.go:171","msg":"trace[1584264173] linearizableReadLoop","detail":"{readStateIndex:25627; appliedIndex:25626; }","duration":"240.348539ms","start":"2026-07-02T01:12:03.975199Z","end":"2026-07-02T01:12:04.215547Z","steps":["trace[1584264173] 'read index received' (duration: 44.810371ms)","trace[1584264173] 'applied index is now lower than readState.Index' (duration: 195.536998ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:04.216178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.709529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:04.216214Z","caller":"traceutil/trace.go:171","msg":"trace[1097772620] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:24815; }","duration":"115.791672ms","start":"2026-07-02T01:12:04.100411Z","end":"2026-07-02T01:12:04.216202Z","steps":["trace[1097772620] 'agreement among raft nodes before linearized reading' (duration: 115.735081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:04.483278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.553956ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:04.483439Z","caller":"traceutil/trace.go:171","msg":"trace[499639818] linearizableReadLoop","detail":"{readStateIndex:25630; appliedIndex:25628; }","duration":"191.292349ms","start":"2026-07-02T01:12:04.292133Z","end":"2026-07-02T01:12:04.483425Z","steps":["trace[499639818] 'read index received' (duration: 75.487707ms)","trace[499639818] 'applied index is now lower than readState.Index' (duration: 115.803522ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:04.483536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.410833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:04.483682Z","caller":"traceutil/trace.go:171","msg":"trace[2086031943] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24818; }","duration":"191.441224ms","start":"2026-07-02T01:12:04.292117Z","end":"2026-07-02T01:12:04.483558Z","steps":["trace[2086031943] 'agreement among raft nodes before linearized reading' (duration: 191.358401ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:04.483681Z","caller":"traceutil/trace.go:171","msg":"trace[548514403] transaction","detail":"{read_only:false; response_revision:24818; number_of_response:1; }","duration":"237.968843ms","start":"2026-07-02T01:12:04.245689Z","end":"2026-07-02T01:12:04.483657Z","steps":["trace[548514403] 'process raft request' (duration: 237.686215ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:04.4837Z","caller":"traceutil/trace.go:171","msg":"trace[1189546978] transaction","detail":"{read_only:false; response_revision:24817; number_of_response:1; }","duration":"239.030582ms","start":"2026-07-02T01:12:04.244612Z","end":"2026-07-02T01:12:04.483643Z","steps":["trace[1189546978] 'process raft request' (duration: 123.034245ms)","trace[1189546978] 'compare' (duration: 115.202945ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:09.091683Z","caller":"traceutil/trace.go:171","msg":"trace[1311050898] transaction","detail":"{read_only:false; response_revision:24850; number_of_response:1; }","duration":"100.968069ms","start":"2026-07-02T01:12:08.990685Z","end":"2026-07-02T01:12:09.091653Z","steps":["trace[1311050898] 'process raft request' (duration: 100.755053ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:09.626207Z","caller":"traceutil/trace.go:171","msg":"trace[47612326] transaction","detail":"{read_only:false; response_revision:24852; number_of_response:1; }","duration":"253.983219ms","start":"2026-07-02T01:12:09.372193Z","end":"2026-07-02T01:12:09.626176Z","steps":["trace[47612326] 'process raft request' (duration: 253.806054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:09.784582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.905026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:09.784756Z","caller":"traceutil/trace.go:171","msg":"trace[1558684508] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"388.140934ms","start":"2026-07-02T01:12:09.396586Z","end":"2026-07-02T01:12:09.784727Z","steps":["trace[1558684508] 'process raft request' (duration: 253.022142ms)","trace[1558684508] 'compare' (duration: 134.651479ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:09.784793Z","caller":"traceutil/trace.go:171","msg":"trace[1929564834] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"175.881759ms","start":"2026-07-02T01:12:09.60888Z","end":"2026-07-02T01:12:09.784762Z","steps":["trace[1929564834] 'process raft request' (duration: 175.777016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:09.784884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:09.396566Z","time spent":"388.252037ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:12:10.072113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.858153ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:10.07246Z","caller":"traceutil/trace.go:171","msg":"trace[1827426631] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"284.150561ms","start":"2026-07-02T01:12:09.788261Z","end":"2026-07-02T01:12:10.072411Z","steps":["trace[1827426631] 'process raft request' (duration: 133.874866ms)","trace[1827426631] 'compare' (duration: 149.655097ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:10.072557Z","caller":"traceutil/trace.go:171","msg":"trace[1405534844] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"166.018304ms","start":"2026-07-02T01:12:09.906512Z","end":"2026-07-02T01:12:10.07253Z","steps":["trace[1405534844] 'process raft request' (duration: 165.89501ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:10.072886Z","caller":"traceutil/trace.go:171","msg":"trace[1691299639] transaction","detail":"{read_only:false; response_revision:24857; number_of_response:1; }","duration":"271.483067ms","start":"2026-07-02T01:12:09.80139Z","end":"2026-07-02T01:12:10.072873Z","steps":["trace[1691299639] 'process raft request' (duration: 270.979413ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:10.072983Z","caller":"traceutil/trace.go:171","msg":"trace[1042313033] transaction","detail":"{read_only:false; response_revision:24856; number_of_response:1; }","duration":"284.321716ms","start":"2026-07-02T01:12:09.788652Z","end":"2026-07-02T01:12:10.072974Z","steps":["trace[1042313033] 'process raft request' (duration: 283.615687ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:10.084322Z","caller":"traceutil/trace.go:171","msg":"trace[1772902811] linearizableReadLoop","detail":"{readStateIndex:25672; appliedIndex:25671; }","duration":"124.481955ms","start":"2026-07-02T01:12:09.959821Z","end":"2026-07-02T01:12:10.084303Z","steps":["trace[1772902811] 'read index received' (duration: 113.347174ms)","trace[1772902811] 'applied index is now lower than readState.Index' (duration: 11.133491ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:10.084411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.577997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:10.084432Z","caller":"traceutil/trace.go:171","msg":"trace[1698829996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24859; }","duration":"124.645479ms","start":"2026-07-02T01:12:09.959779Z","end":"2026-07-02T01:12:10.084424Z","steps":["trace[1698829996] 'agreement among raft nodes before linearized reading' (duration: 124.592168ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:10.084577Z","caller":"traceutil/trace.go:171","msg":"trace[1420126488] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"149.42073ms","start":"2026-07-02T01:12:09.935125Z","end":"2026-07-02T01:12:10.084545Z","steps":["trace[1420126488] 'process raft request' (duration: 149.082291ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:10.237038Z","caller":"traceutil/trace.go:171","msg":"trace[837208567] transaction","detail":"{read_only:false; response_revision:24860; number_of_response:1; }","duration":"102.103739ms","start":"2026-07-02T01:12:10.134887Z","end":"2026-07-02T01:12:10.236991Z","steps":["trace[837208567] 'process raft request' (duration: 91.321398ms)","trace[837208567] 'compare' (duration: 10.528774ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:10.452449Z","caller":"traceutil/trace.go:171","msg":"trace[106586195] linearizableReadLoop","detail":"{readStateIndex:25674; appliedIndex:25673; }","duration":"206.795992ms","start":"2026-07-02T01:12:10.24563Z","end":"2026-07-02T01:12:10.452426Z","steps":["trace[106586195] 'read index received' (duration: 125.41834ms)","trace[106586195] 'applied index is now lower than readState.Index' (duration: 81.376412ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:10.452709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.008604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:10.45274Z","caller":"traceutil/trace.go:171","msg":"trace[32179057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24861; }","duration":"161.089386ms","start":"2026-07-02T01:12:10.291642Z","end":"2026-07-02T01:12:10.452731Z","steps":["trace[32179057] 'agreement among raft nodes before linearized reading' (duration: 161.020744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:10.452803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.157032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-02T01:12:10.45291Z","caller":"traceutil/trace.go:171","msg":"trace[1326321746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24861; }","duration":"207.272395ms","start":"2026-07-02T01:12:10.245612Z","end":"2026-07-02T01:12:10.452884Z","steps":["trace[1326321746] 'agreement among raft nodes before linearized reading' (duration: 206.996178ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:10.453134Z","caller":"traceutil/trace.go:171","msg":"trace[1354681547] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"211.349299ms","start":"2026-07-02T01:12:10.241316Z","end":"2026-07-02T01:12:10.452665Z","steps":["trace[1354681547] 'process raft request' (duration: 129.903706ms)","trace[1354681547] 'compare' (duration: 80.912358ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:10.622082Z","caller":"traceutil/trace.go:171","msg":"trace[1066993887] transaction","detail":"{read_only:false; response_revision:24862; number_of_response:1; }","duration":"164.538492ms","start":"2026-07-02T01:12:10.457508Z","end":"2026-07-02T01:12:10.622047Z","steps":["trace[1066993887] 'process raft request' (duration: 96.081651ms)","trace[1066993887] 'compare' (duration: 68.279336ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:10.714908Z","caller":"traceutil/trace.go:171","msg":"trace[323998375] transaction","detail":"{read_only:false; response_revision:24863; number_of_response:1; }","duration":"215.31275ms","start":"2026-07-02T01:12:10.49957Z","end":"2026-07-02T01:12:10.714882Z","steps":["trace[323998375] 'process raft request' (duration: 215.141975ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:10.715137Z","caller":"traceutil/trace.go:171","msg":"trace[338414824] transaction","detail":"{read_only:false; response_revision:24864; number_of_response:1; }","duration":"213.245432ms","start":"2026-07-02T01:12:10.501836Z","end":"2026-07-02T01:12:10.715082Z","steps":["trace[338414824] 'process raft request' (duration: 213.002415ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:10.868581Z","caller":"traceutil/trace.go:171","msg":"trace[1973912588] transaction","detail":"{read_only:false; response_revision:24865; number_of_response:1; }","duration":"112.894061ms","start":"2026-07-02T01:12:10.755654Z","end":"2026-07-02T01:12:10.868548Z","steps":["trace[1973912588] 'process raft request' (duration: 101.796132ms)","trace[1973912588] 'compare' (duration: 10.954985ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:11.535497Z","caller":"traceutil/trace.go:171","msg":"trace[1542161740] transaction","detail":"{read_only:false; response_revision:24867; number_of_response:1; }","duration":"178.76996ms","start":"2026-07-02T01:12:11.356697Z","end":"2026-07-02T01:12:11.535467Z","steps":["trace[1542161740] 'process raft request' (duration: 178.619176ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:11.863643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.111583ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:11.863864Z","caller":"traceutil/trace.go:171","msg":"trace[920492284] transaction","detail":"{read_only:false; response_revision:24869; number_of_response:1; }","duration":"233.24166ms","start":"2026-07-02T01:12:11.630604Z","end":"2026-07-02T01:12:11.863846Z","steps":["trace[920492284] 'process raft request' (duration: 233.146097ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:11.863873Z","caller":"traceutil/trace.go:171","msg":"trace[1082365001] linearizableReadLoop","detail":"{readStateIndex:25681; appliedIndex:25679; }","duration":"352.293263ms","start":"2026-07-02T01:12:11.511549Z","end":"2026-07-02T01:12:11.863842Z","steps":["trace[1082365001] 'read index received' (duration: 23.750923ms)","trace[1082365001] 'applied index is now lower than readState.Index' (duration: 328.53903ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:11.863993Z","caller":"traceutil/trace.go:171","msg":"trace[557559563] transaction","detail":"{read_only:false; response_revision:24868; number_of_response:1; }","duration":"478.602089ms","start":"2026-07-02T01:12:11.385351Z","end":"2026-07-02T01:12:11.863953Z","steps":["trace[557559563] 'process raft request' (duration: 334.090196ms)","trace[557559563] 'compare' (duration: 143.913746ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:11.864194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:11.385326Z","time spent":"478.752153ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:12:11.864658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.092726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:11.86472Z","caller":"traceutil/trace.go:171","msg":"trace[1943671627] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24869; }","duration":"353.177268ms","start":"2026-07-02T01:12:11.511528Z","end":"2026-07-02T01:12:11.864706Z","steps":["trace[1943671627] 'agreement among raft nodes before linearized reading' (duration: 352.52991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:11.864763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:11.511505Z","time spent":"353.244749ms","remote":"127.0.0.1:34980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"info","ts":"2026-07-02T01:12:11.891797Z","caller":"traceutil/trace.go:171","msg":"trace[1502447501] transaction","detail":"{read_only:false; response_revision:24870; number_of_response:1; }","duration":"101.705909ms","start":"2026-07-02T01:12:11.790072Z","end":"2026-07-02T01:12:11.891778Z","steps":["trace[1502447501] 'process raft request' (duration: 101.601976ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:12.039798Z","caller":"traceutil/trace.go:171","msg":"trace[2019739251] linearizableReadLoop","detail":"{readStateIndex:25684; appliedIndex:25682; }","duration":"175.758815ms","start":"2026-07-02T01:12:11.864015Z","end":"2026-07-02T01:12:12.039774Z","steps":["trace[2019739251] 'read index received' (duration: 27.621381ms)","trace[2019739251] 'applied index is now lower than readState.Index' (duration: 148.136154ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:12.040132Z","caller":"traceutil/trace.go:171","msg":"trace[1053244833] transaction","detail":"{read_only:false; response_revision:24871; number_of_response:1; }","duration":"249.702869ms","start":"2026-07-02T01:12:11.790398Z","end":"2026-07-02T01:12:12.040101Z","steps":["trace[1053244833] 'process raft request' (duration: 236.385538ms)","trace[1053244833] 'compare' (duration: 12.708814ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:12.040192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.51494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T01:12:12.040246Z","caller":"traceutil/trace.go:171","msg":"trace[241714993] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:24871; }","duration":"471.619963ms","start":"2026-07-02T01:12:11.56861Z","end":"2026-07-02T01:12:12.04023Z","steps":["trace[241714993] 'agreement among raft nodes before linearized reading' (duration: 471.440018ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:12.040288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:11.568587Z","time spent":"471.687685ms","remote":"127.0.0.1:55906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":90,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-07-02T01:12:12.040672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.432437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:12.040777Z","caller":"traceutil/trace.go:171","msg":"trace[2014045520] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24871; }","duration":"170.581481ms","start":"2026-07-02T01:12:11.870169Z","end":"2026-07-02T01:12:12.04075Z","steps":["trace[2014045520] 'agreement among raft nodes before linearized reading' (duration: 169.867861ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:12.200189Z","caller":"traceutil/trace.go:171","msg":"trace[1031947387] transaction","detail":"{read_only:false; response_revision:24872; number_of_response:1; }","duration":"122.001405ms","start":"2026-07-02T01:12:12.078155Z","end":"2026-07-02T01:12:12.200157Z","steps":["trace[1031947387] 'process raft request' (duration: 118.989241ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:12.509305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.20132ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:12.509508Z","caller":"traceutil/trace.go:171","msg":"trace[93895178] transaction","detail":"{read_only:false; response_revision:24873; number_of_response:1; }","duration":"429.508918ms","start":"2026-07-02T01:12:12.079979Z","end":"2026-07-02T01:12:12.509488Z","steps":["trace[93895178] 'process raft request' (duration: 272.991159ms)","trace[93895178] 'compare' (duration: 156.068237ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:12.509583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:12.07997Z","time spent":"429.579851ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:12.509696Z","caller":"traceutil/trace.go:171","msg":"trace[2070208329] linearizableReadLoop","detail":"{readStateIndex:25686; appliedIndex:25684; }","duration":"429.601961ms","start":"2026-07-02T01:12:12.080062Z","end":"2026-07-02T01:12:12.509664Z","steps":["trace[2070208329] 'read index received' (duration: 117.388187ms)","trace[2070208329] 'applied index is now lower than readState.Index' (duration: 312.212004ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:12.509764Z","caller":"traceutil/trace.go:171","msg":"trace[2023257757] transaction","detail":"{read_only:false; response_revision:24874; number_of_response:1; }","duration":"421.034012ms","start":"2026-07-02T01:12:12.0887Z","end":"2026-07-02T01:12:12.509734Z","steps":["trace[2023257757] 'process raft request' (duration: 420.702913ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:12.509894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.503759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-02T01:12:12.50993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:12.088675Z","time spent":"421.157746ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:12.509942Z","caller":"traceutil/trace.go:171","msg":"trace[1483792277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24874; }","duration":"218.599401ms","start":"2026-07-02T01:12:12.291328Z","end":"2026-07-02T01:12:12.509927Z","steps":["trace[1483792277] 'agreement among raft nodes before linearized reading' (duration: 218.515149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:12.509938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.866228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-07-02T01:12:12.509937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.309516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T01:12:12.50999Z","caller":"traceutil/trace.go:171","msg":"trace[591070086] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24874; }","duration":"429.957381ms","start":"2026-07-02T01:12:12.080016Z","end":"2026-07-02T01:12:12.509974Z","steps":["trace[591070086] 'agreement among raft nodes before linearized reading' (duration: 429.753225ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:12.509997Z","caller":"traceutil/trace.go:171","msg":"trace[1348673417] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:24874; }","duration":"193.443849ms","start":"2026-07-02T01:12:12.316536Z","end":"2026-07-02T01:12:12.50998Z","steps":["trace[1348673417] 'agreement among raft nodes before linearized reading' (duration: 193.324416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:12.510025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:12.079994Z","time spent":"430.022153ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-02T01:12:12.510109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.32225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T01:12:12.510221Z","caller":"traceutil/trace.go:171","msg":"trace[112643887] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:24874; }","duration":"100.452824ms","start":"2026-07-02T01:12:12.409739Z","end":"2026-07-02T01:12:12.510191Z","steps":["trace[112643887] 'agreement among raft nodes before linearized reading' (duration: 100.115774ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:12.894244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.258085ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-02T01:12:12.89456Z","caller":"traceutil/trace.go:171","msg":"trace[1544303138] linearizableReadLoop","detail":"{readStateIndex:25690; appliedIndex:25689; }","duration":"268.619668ms","start":"2026-07-02T01:12:12.625922Z","end":"2026-07-02T01:12:12.894542Z","steps":["trace[1544303138] 'read index received' (duration: 128.056264ms)","trace[1544303138] 'applied index is now lower than readState.Index' (duration: 140.562254ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:12.894886Z","caller":"traceutil/trace.go:171","msg":"trace[1454917762] transaction","detail":"{read_only:false; response_revision:24877; number_of_response:1; }","duration":"173.957576ms","start":"2026-07-02T01:12:12.720911Z","end":"2026-07-02T01:12:12.894868Z","steps":["trace[1454917762] 'process raft request' (duration: 173.506153ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:12.894877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.914386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-02T01:12:12.894973Z","caller":"traceutil/trace.go:171","msg":"trace[1810005497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24876; }","duration":"269.06645ms","start":"2026-07-02T01:12:12.625883Z","end":"2026-07-02T01:12:12.89495Z","steps":["trace[1810005497] 'agreement among raft nodes before linearized reading' (duration: 268.744851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:13.062785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.819805ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:13.0629Z","caller":"traceutil/trace.go:171","msg":"trace[1858105788] linearizableReadLoop","detail":"{readStateIndex:25692; appliedIndex:25690; }","duration":"168.286078ms","start":"2026-07-02T01:12:12.894595Z","end":"2026-07-02T01:12:13.062881Z","steps":["trace[1858105788] 'read index received' (duration: 53.642µs)","trace[1858105788] 'applied index is now lower than readState.Index' (duration: 168.230716ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:13.062925Z","caller":"traceutil/trace.go:171","msg":"trace[1361117414] transaction","detail":"{read_only:false; response_revision:24878; number_of_response:1; }","duration":"341.839401ms","start":"2026-07-02T01:12:12.72106Z","end":"2026-07-02T01:12:13.0629Z","steps":["trace[1361117414] 'process raft request' (duration: 173.79303ms)","trace[1361117414] 'compare' (duration: 167.539557ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:13.063054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:12.721052Z","time spent":"341.922794ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:12:13.063176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.280643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-07-02T01:12:13.063239Z","caller":"traceutil/trace.go:171","msg":"trace[1636935759] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24878; }","duration":"204.370134ms","start":"2026-07-02T01:12:12.858855Z","end":"2026-07-02T01:12:13.063225Z","steps":["trace[1636935759] 'agreement among raft nodes before linearized reading' (duration: 204.111067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:13.063369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.846221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T01:12:13.063397Z","caller":"traceutil/trace.go:171","msg":"trace[2054706942] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:24878; }","duration":"356.924203ms","start":"2026-07-02T01:12:12.706466Z","end":"2026-07-02T01:12:13.06339Z","steps":["trace[2054706942] 'agreement among raft nodes before linearized reading' (duration: 356.869411ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:13.063417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:12.706427Z","time spent":"356.984864ms","remote":"127.0.0.1:56118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-07-02T01:12:13.243049Z","caller":"traceutil/trace.go:171","msg":"trace[347061550] linearizableReadLoop","detail":"{readStateIndex:25693; appliedIndex:25692; }","duration":"180.088466ms","start":"2026-07-02T01:12:13.062932Z","end":"2026-07-02T01:12:13.24302Z","steps":["trace[347061550] 'read index received' (duration: 155.457919ms)","trace[347061550] 'applied index is now lower than readState.Index' (duration: 24.628507ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:13.243283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.64218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:13.243262Z","caller":"traceutil/trace.go:171","msg":"trace[202200274] transaction","detail":"{read_only:false; response_revision:24879; number_of_response:1; }","duration":"342.943082ms","start":"2026-07-02T01:12:12.900283Z","end":"2026-07-02T01:12:13.243226Z","steps":["trace[202200274] 'process raft request' (duration: 318.12139ms)","trace[202200274] 'compare' (duration: 23.601388ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:13.243327Z","caller":"traceutil/trace.go:171","msg":"trace[1907875087] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:24879; }","duration":"277.729072ms","start":"2026-07-02T01:12:12.965586Z","end":"2026-07-02T01:12:13.243315Z","steps":["trace[1907875087] 'agreement among raft nodes before linearized reading' (duration: 277.633079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:13.24339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.00419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-07-02T01:12:13.243432Z","caller":"traceutil/trace.go:171","msg":"trace[1696146043] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24879; }","duration":"177.081403ms","start":"2026-07-02T01:12:13.06634Z","end":"2026-07-02T01:12:13.243421Z","steps":["trace[1696146043] 'agreement among raft nodes before linearized reading' (duration: 176.921008ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:13.243435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:12.900257Z","time spent":"343.097656ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:13.483653Z","caller":"traceutil/trace.go:171","msg":"trace[2010402651] linearizableReadLoop","detail":"{readStateIndex:25694; appliedIndex:25693; }","duration":"191.011931ms","start":"2026-07-02T01:12:13.292622Z","end":"2026-07-02T01:12:13.483634Z","steps":["trace[2010402651] 'read index received' (duration: 95.144476ms)","trace[2010402651] 'applied index is now lower than readState.Index' (duration: 95.866475ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:13.483893Z","caller":"traceutil/trace.go:171","msg":"trace[867537794] transaction","detail":"{read_only:false; response_revision:24880; number_of_response:1; }","duration":"235.331098ms","start":"2026-07-02T01:12:13.24855Z","end":"2026-07-02T01:12:13.483881Z","steps":["trace[867537794] 'process raft request' (duration: 139.336209ms)","trace[867537794] 'compare' (duration: 95.608529ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:13.484093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.033307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:13.484294Z","caller":"traceutil/trace.go:171","msg":"trace[340707411] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24880; }","duration":"189.255052ms","start":"2026-07-02T01:12:13.295021Z","end":"2026-07-02T01:12:13.484276Z","steps":["trace[340707411] 'agreement among raft nodes before linearized reading' (duration: 189.007485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:13.484342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.68521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:13.484409Z","caller":"traceutil/trace.go:171","msg":"trace[1335580128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24880; }","duration":"191.801784ms","start":"2026-07-02T01:12:13.292588Z","end":"2026-07-02T01:12:13.48439Z","steps":["trace[1335580128] 'agreement among raft nodes before linearized reading' (duration: 191.517126ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:13.845767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.643661ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:13.845948Z","caller":"traceutil/trace.go:171","msg":"trace[491237874] transaction","detail":"{read_only:false; response_revision:24882; number_of_response:1; }","duration":"300.904939ms","start":"2026-07-02T01:12:13.545025Z","end":"2026-07-02T01:12:13.84593Z","steps":["trace[491237874] 'process raft request' (duration: 300.838507ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:13.846018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:13.545011Z","time spent":"300.976541ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:13.84604Z","caller":"traceutil/trace.go:171","msg":"trace[446709946] transaction","detail":"{read_only:false; response_revision:24881; number_of_response:1; }","duration":"302.808772ms","start":"2026-07-02T01:12:13.543185Z","end":"2026-07-02T01:12:13.845994Z","steps":["trace[446709946] 'process raft request' (duration: 106.852502ms)","trace[446709946] 'compare' (duration: 195.133157ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:13.846202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:13.54317Z","time spent":"302.947506ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:14.213593Z","caller":"traceutil/trace.go:171","msg":"trace[38465858] linearizableReadLoop","detail":"{readStateIndex:25698; appliedIndex:25697; }","duration":"216.38548ms","start":"2026-07-02T01:12:13.99719Z","end":"2026-07-02T01:12:14.213575Z","steps":["trace[38465858] 'read index received' (duration: 175.467918ms)","trace[38465858] 'applied index is now lower than readState.Index' (duration: 40.914792ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:14.213661Z","caller":"traceutil/trace.go:171","msg":"trace[1517232331] transaction","detail":"{read_only:false; response_revision:24884; number_of_response:1; }","duration":"317.213564ms","start":"2026-07-02T01:12:13.896418Z","end":"2026-07-02T01:12:14.213631Z","steps":["trace[1517232331] 'process raft request' (duration: 276.251351ms)","trace[1517232331] 'compare' (duration: 40.800779ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:14.213726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.516733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T01:12:14.213749Z","caller":"traceutil/trace.go:171","msg":"trace[1524733251] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:24884; }","duration":"216.583775ms","start":"2026-07-02T01:12:13.997158Z","end":"2026-07-02T01:12:14.213742Z","steps":["trace[1524733251] 'agreement among raft nodes before linearized reading' (duration: 216.495873ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:14.213783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:13.896389Z","time spent":"317.316747ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:14.216396Z","caller":"traceutil/trace.go:171","msg":"trace[979314176] transaction","detail":"{read_only:false; response_revision:24885; number_of_response:1; }","duration":"170.815128ms","start":"2026-07-02T01:12:14.045565Z","end":"2026-07-02T01:12:14.21638Z","steps":["trace[979314176] 'process raft request' (duration: 170.718415ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:14.226397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.081105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:14.226481Z","caller":"traceutil/trace.go:171","msg":"trace[1274320742] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:24886; }","duration":"229.209977ms","start":"2026-07-02T01:12:13.997251Z","end":"2026-07-02T01:12:14.226461Z","steps":["trace[1274320742] 'agreement among raft nodes before linearized reading' (duration: 229.033422ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:14.226822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.600124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0\" ","response":"range_response_count:1 size:1566"} {"level":"info","ts":"2026-07-02T01:12:14.226882Z","caller":"traceutil/trace.go:171","msg":"trace[1445798425] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/data-ovn-ovsdb-nb-0; range_end:; response_count:1; response_revision:24886; }","duration":"174.695716ms","start":"2026-07-02T01:12:14.052169Z","end":"2026-07-02T01:12:14.226865Z","steps":["trace[1445798425] 'agreement among raft nodes before linearized reading' (duration: 174.49561ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:14.697825Z","caller":"traceutil/trace.go:171","msg":"trace[1489193632] transaction","detail":"{read_only:false; response_revision:24887; number_of_response:1; }","duration":"183.696268ms","start":"2026-07-02T01:12:14.51411Z","end":"2026-07-02T01:12:14.697806Z","steps":["trace[1489193632] 'process raft request' (duration: 183.207534ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:14.707895Z","caller":"traceutil/trace.go:171","msg":"trace[1346087044] linearizableReadLoop","detail":"{readStateIndex:25702; appliedIndex:25700; }","duration":"180.106178ms","start":"2026-07-02T01:12:14.527771Z","end":"2026-07-02T01:12:14.707877Z","steps":["trace[1346087044] 'read index received' (duration: 169.593114ms)","trace[1346087044] 'applied index is now lower than readState.Index' (duration: 10.511974ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:14.70812Z","caller":"traceutil/trace.go:171","msg":"trace[829862765] transaction","detail":"{read_only:false; response_revision:24888; number_of_response:1; }","duration":"192.447261ms","start":"2026-07-02T01:12:14.515664Z","end":"2026-07-02T01:12:14.708111Z","steps":["trace[829862765] 'process raft request' (duration: 192.118652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:14.708331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.55189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T01:12:14.708358Z","caller":"traceutil/trace.go:171","msg":"trace[92847643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24888; }","duration":"180.627712ms","start":"2026-07-02T01:12:14.527724Z","end":"2026-07-02T01:12:14.708352Z","steps":["trace[92847643] 'agreement among raft nodes before linearized reading' (duration: 180.524579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:14.708452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.260006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T01:12:14.708497Z","caller":"traceutil/trace.go:171","msg":"trace[906622765] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24888; }","duration":"101.429852ms","start":"2026-07-02T01:12:14.607057Z","end":"2026-07-02T01:12:14.708487Z","steps":["trace[906622765] 'agreement among raft nodes before linearized reading' (duration: 101.295548ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:15.099575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.897738ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:15.099669Z","caller":"traceutil/trace.go:171","msg":"trace[1420362199] transaction","detail":"{read_only:false; response_revision:24889; number_of_response:1; }","duration":"387.138646ms","start":"2026-07-02T01:12:14.712514Z","end":"2026-07-02T01:12:15.099653Z","steps":["trace[1420362199] 'process raft request' (duration: 138.067814ms)","trace[1420362199] 'compare' (duration: 248.464415ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:15.099714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:14.712496Z","time spent":"387.196848ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:15.14411Z","caller":"traceutil/trace.go:171","msg":"trace[201722136] transaction","detail":"{read_only:false; response_revision:24890; number_of_response:1; }","duration":"431.436802ms","start":"2026-07-02T01:12:14.712646Z","end":"2026-07-02T01:12:15.144083Z","steps":["trace[201722136] 'process raft request' (duration: 431.310318ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:15.144274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:14.712547Z","time spent":"431.632867ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:12:15.474308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.798562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:15.474543Z","caller":"traceutil/trace.go:171","msg":"trace[973268349] transaction","detail":"{read_only:false; response_revision:24891; number_of_response:1; }","duration":"574.984219ms","start":"2026-07-02T01:12:14.899524Z","end":"2026-07-02T01:12:15.474508Z","steps":["trace[973268349] 'process raft request' (duration: 386.868798ms)","trace[973268349] 'compare' (duration: 187.645578ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:15.474576Z","caller":"traceutil/trace.go:171","msg":"trace[1137583470] transaction","detail":"{read_only:false; response_revision:24892; number_of_response:1; }","duration":"474.467373ms","start":"2026-07-02T01:12:15.000084Z","end":"2026-07-02T01:12:15.474552Z","steps":["trace[1137583470] 'process raft request' (duration: 474.335129ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:15.474688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:15.000056Z","time spent":"474.585477ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:15.474683Z","caller":"traceutil/trace.go:171","msg":"trace[874113032] linearizableReadLoop","detail":"{readStateIndex:25707; appliedIndex:25704; }","duration":"226.555244ms","start":"2026-07-02T01:12:15.248108Z","end":"2026-07-02T01:12:15.474663Z","steps":["trace[874113032] 'read index received' (duration: 38.242548ms)","trace[874113032] 'applied index is now lower than readState.Index' (duration: 188.311796ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:15.47469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:14.899513Z","time spent":"575.102643ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:15.474782Z","caller":"traceutil/trace.go:171","msg":"trace[2018926914] transaction","detail":"{read_only:false; response_revision:24893; number_of_response:1; }","duration":"406.196158ms","start":"2026-07-02T01:12:15.068579Z","end":"2026-07-02T01:12:15.474776Z","steps":["trace[2018926914] 'process raft request' (duration: 405.932361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:15.474859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:15.06855Z","time spent":"406.249369ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:12:15.474982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.54189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/subnets/\" range_end:\"/registry/openstack.k-orc.cloud/subnets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:15.475018Z","caller":"traceutil/trace.go:171","msg":"trace[1551953002] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/subnets/; range_end:/registry/openstack.k-orc.cloud/subnets0; response_count:0; response_revision:24893; }","duration":"127.594812ms","start":"2026-07-02T01:12:15.347412Z","end":"2026-07-02T01:12:15.475007Z","steps":["trace[1551953002] 'agreement among raft nodes before linearized reading' (duration: 127.54352ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:15.475474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.362176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-02T01:12:15.475666Z","caller":"traceutil/trace.go:171","msg":"trace[2069303577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24893; }","duration":"227.584173ms","start":"2026-07-02T01:12:15.248065Z","end":"2026-07-02T01:12:15.475649Z","steps":["trace[2069303577] 'agreement among raft nodes before linearized reading' (duration: 227.235563ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:15.47549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.02426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:15.475772Z","caller":"traceutil/trace.go:171","msg":"trace[394431702] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:24893; }","duration":"192.337229ms","start":"2026-07-02T01:12:15.283423Z","end":"2026-07-02T01:12:15.47576Z","steps":["trace[394431702] 'agreement among raft nodes before linearized reading' (duration: 191.973439ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:15.476206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.982772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-07-02T01:12:15.476267Z","caller":"traceutil/trace.go:171","msg":"trace[1422388705] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:24893; }","duration":"205.085775ms","start":"2026-07-02T01:12:15.271169Z","end":"2026-07-02T01:12:15.476255Z","steps":["trace[1422388705] 'agreement among raft nodes before linearized reading' (duration: 203.658185ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:15.688843Z","caller":"traceutil/trace.go:171","msg":"trace[680506759] transaction","detail":"{read_only:false; response_revision:24895; number_of_response:1; }","duration":"152.528837ms","start":"2026-07-02T01:12:15.536299Z","end":"2026-07-02T01:12:15.688828Z","steps":["trace[680506759] 'process raft request' (duration: 152.206628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:21.383087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.524989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:21.383346Z","caller":"traceutil/trace.go:171","msg":"trace[1485067709] linearizableReadLoop","detail":"{readStateIndex:25747; appliedIndex:25745; }","duration":"251.837579ms","start":"2026-07-02T01:12:21.131492Z","end":"2026-07-02T01:12:21.38333Z","steps":["trace[1485067709] 'read index received' (duration: 36.241µs)","trace[1485067709] 'applied index is now lower than readState.Index' (duration: 251.800378ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:21.383399Z","caller":"traceutil/trace.go:171","msg":"trace[1926524081] transaction","detail":"{read_only:false; response_revision:24931; number_of_response:1; }","duration":"658.46731ms","start":"2026-07-02T01:12:20.7249Z","end":"2026-07-02T01:12:21.383368Z","steps":["trace[1926524081] 'process raft request' (duration: 257.56927ms)","trace[1926524081] 'compare' (duration: 400.103298ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:21.383422Z","caller":"traceutil/trace.go:171","msg":"trace[1431617247] transaction","detail":"{read_only:false; response_revision:24932; number_of_response:1; }","duration":"504.573623ms","start":"2026-07-02T01:12:20.87882Z","end":"2026-07-02T01:12:21.383393Z","steps":["trace[1431617247] 'process raft request' (duration: 504.417279ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:21.383549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:20.724886Z","time spent":"658.579582ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:12:21.383565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.061526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-02T01:12:21.383583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:20.8788Z","time spent":"504.699007ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:21.38364Z","caller":"traceutil/trace.go:171","msg":"trace[1766594094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24932; }","duration":"252.176419ms","start":"2026-07-02T01:12:21.131444Z","end":"2026-07-02T01:12:21.383621Z","steps":["trace[1766594094] 'agreement among raft nodes before linearized reading' (duration: 251.952473ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:21.38376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.995883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T01:12:21.383864Z","caller":"traceutil/trace.go:171","msg":"trace[1061277862] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24932; }","duration":"219.128106ms","start":"2026-07-02T01:12:21.164707Z","end":"2026-07-02T01:12:21.383835Z","steps":["trace[1061277862] 'agreement among raft nodes before linearized reading' (duration: 218.859378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:21.383905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.076762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:21.384181Z","caller":"traceutil/trace.go:171","msg":"trace[369365426] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:24932; }","duration":"201.423942ms","start":"2026-07-02T01:12:21.18274Z","end":"2026-07-02T01:12:21.384164Z","steps":["trace[369365426] 'agreement among raft nodes before linearized reading' (duration: 201.079862ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:21.812974Z","caller":"traceutil/trace.go:171","msg":"trace[1568297914] transaction","detail":"{read_only:false; response_revision:24933; number_of_response:1; }","duration":"425.132696ms","start":"2026-07-02T01:12:21.387808Z","end":"2026-07-02T01:12:21.812941Z","steps":["trace[1568297914] 'process raft request' (duration: 424.91569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:21.813196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:21.387792Z","time spent":"425.276561ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:21.823656Z","caller":"traceutil/trace.go:171","msg":"trace[185406525] transaction","detail":"{read_only:false; response_revision:24934; number_of_response:1; }","duration":"435.264529ms","start":"2026-07-02T01:12:21.388366Z","end":"2026-07-02T01:12:21.82363Z","steps":["trace[185406525] 'process raft request' (duration: 435.065654ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:21.823913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:21.388349Z","time spent":"435.387322ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:21.82407Z","caller":"traceutil/trace.go:171","msg":"trace[997204440] transaction","detail":"{read_only:false; response_revision:24935; number_of_response:1; }","duration":"328.218101ms","start":"2026-07-02T01:12:21.495832Z","end":"2026-07-02T01:12:21.82405Z","steps":["trace[997204440] 'process raft request' (duration: 327.751098ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:21.824119Z","caller":"traceutil/trace.go:171","msg":"trace[2087384974] linearizableReadLoop","detail":"{readStateIndex:25751; appliedIndex:25747; }","duration":"272.537657ms","start":"2026-07-02T01:12:21.55155Z","end":"2026-07-02T01:12:21.824088Z","steps":["trace[2087384974] 'read index received' (duration: 261.144989ms)","trace[2087384974] 'applied index is now lower than readState.Index' (duration: 11.391318ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:21.824174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:21.495817Z","time spent":"328.305714ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:12:21.824421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.864546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-02T01:12:21.824476Z","caller":"traceutil/trace.go:171","msg":"trace[1051025292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24936; }","duration":"272.934578ms","start":"2026-07-02T01:12:21.551528Z","end":"2026-07-02T01:12:21.824463Z","steps":["trace[1051025292] 'agreement among raft nodes before linearized reading' (duration: 272.778384ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:21.82457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.82126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-02T01:12:21.824596Z","caller":"traceutil/trace.go:171","msg":"trace[43092740] transaction","detail":"{read_only:false; response_revision:24936; number_of_response:1; }","duration":"308.682856ms","start":"2026-07-02T01:12:21.515901Z","end":"2026-07-02T01:12:21.824584Z","steps":["trace[43092740] 'process raft request' (duration: 307.974956ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:21.824632Z","caller":"traceutil/trace.go:171","msg":"trace[1611006164] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24936; }","duration":"102.903792ms","start":"2026-07-02T01:12:21.721699Z","end":"2026-07-02T01:12:21.824603Z","steps":["trace[1611006164] 'agreement among raft nodes before linearized reading' (duration: 102.732187ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:21.824658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:21.515872Z","time spent":"308.748388ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:22.538806Z","caller":"traceutil/trace.go:171","msg":"trace[646983952] transaction","detail":"{read_only:false; response_revision:24939; number_of_response:1; }","duration":"594.236847ms","start":"2026-07-02T01:12:21.944543Z","end":"2026-07-02T01:12:22.53878Z","steps":["trace[646983952] 'process raft request' (duration: 594.085812ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:22.538953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:21.944522Z","time spent":"594.359719ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:22.54077Z","caller":"traceutil/trace.go:171","msg":"trace[113023803] transaction","detail":"{read_only:false; response_revision:24941; number_of_response:1; }","duration":"286.435135ms","start":"2026-07-02T01:12:22.254307Z","end":"2026-07-02T01:12:22.540742Z","steps":["trace[113023803] 'process raft request' (duration: 286.317222ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:22.540929Z","caller":"traceutil/trace.go:171","msg":"trace[816399969] transaction","detail":"{read_only:false; response_revision:24940; number_of_response:1; }","duration":"584.027011ms","start":"2026-07-02T01:12:21.956813Z","end":"2026-07-02T01:12:22.54084Z","steps":["trace[816399969] 'process raft request' (duration: 583.670531ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:22.541117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:21.956788Z","time spent":"584.262978ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:12:22.541248Z","caller":"traceutil/trace.go:171","msg":"trace[75522861] transaction","detail":"{read_only:false; response_revision:24942; number_of_response:1; }","duration":"284.172052ms","start":"2026-07-02T01:12:22.257053Z","end":"2026-07-02T01:12:22.541225Z","steps":["trace[75522861] 'process raft request' (duration: 283.644297ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:22.541759Z","caller":"traceutil/trace.go:171","msg":"trace[1520049161] transaction","detail":"{read_only:false; response_revision:24943; number_of_response:1; }","duration":"283.598155ms","start":"2026-07-02T01:12:22.258151Z","end":"2026-07-02T01:12:22.541749Z","steps":["trace[1520049161] 'process raft request' (duration: 283.001289ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:22.543392Z","caller":"traceutil/trace.go:171","msg":"trace[1329292264] linearizableReadLoop","detail":"{readStateIndex:25755; appliedIndex:25753; }","duration":"479.386971ms","start":"2026-07-02T01:12:22.063995Z","end":"2026-07-02T01:12:22.543382Z","steps":["trace[1329292264] 'read index received' (duration: 474.737731ms)","trace[1329292264] 'applied index is now lower than readState.Index' (duration: 4.64831ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:22.543567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.12865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:22.543599Z","caller":"traceutil/trace.go:171","msg":"trace[110414797] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:24943; }","duration":"251.197202ms","start":"2026-07-02T01:12:22.292393Z","end":"2026-07-02T01:12:22.54359Z","steps":["trace[110414797] 'agreement among raft nodes before linearized reading' (duration: 251.14369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:22.544393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.390799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:22.544428Z","caller":"traceutil/trace.go:171","msg":"trace[1762522857] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24943; }","duration":"480.460681ms","start":"2026-07-02T01:12:22.063959Z","end":"2026-07-02T01:12:22.544419Z","steps":["trace[1762522857] 'agreement among raft nodes before linearized reading' (duration: 479.527295ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:22.544479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:22.063939Z","time spent":"480.531152ms","remote":"127.0.0.1:34980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"info","ts":"2026-07-02T01:12:31.951061Z","caller":"traceutil/trace.go:171","msg":"trace[1717130109] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"160.413677ms","start":"2026-07-02T01:12:31.79062Z","end":"2026-07-02T01:12:31.951034Z","steps":["trace[1717130109] 'process raft request' (duration: 160.241452ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.108652Z","caller":"traceutil/trace.go:171","msg":"trace[432522591] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"253.906647ms","start":"2026-07-02T01:12:31.854717Z","end":"2026-07-02T01:12:32.108624Z","steps":["trace[432522591] 'process raft request' (duration: 244.103773ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.108918Z","caller":"traceutil/trace.go:171","msg":"trace[1928019735] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"254.095603ms","start":"2026-07-02T01:12:31.854783Z","end":"2026-07-02T01:12:32.108878Z","steps":["trace[1928019735] 'process raft request' (duration: 253.784724ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.10896Z","caller":"traceutil/trace.go:171","msg":"trace[928800638] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"153.618738ms","start":"2026-07-02T01:12:31.955318Z","end":"2026-07-02T01:12:32.108937Z","steps":["trace[928800638] 'process raft request' (duration: 153.525645ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.108979Z","caller":"traceutil/trace.go:171","msg":"trace[642495791] linearizableReadLoop","detail":"{readStateIndex:25888; appliedIndex:25886; }","duration":"157.942589ms","start":"2026-07-02T01:12:31.951006Z","end":"2026-07-02T01:12:32.108949Z","steps":["trace[642495791] 'read index received' (duration: 147.807536ms)","trace[642495791] 'applied index is now lower than readState.Index' (duration: 10.131853ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:32.10911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.392798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-07-02T01:12:32.109121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.767652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-02T01:12:32.109146Z","caller":"traceutil/trace.go:171","msg":"trace[2013243816] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25072; }","duration":"236.46019ms","start":"2026-07-02T01:12:31.872676Z","end":"2026-07-02T01:12:32.109136Z","steps":["trace[2013243816] 'agreement among raft nodes before linearized reading' (duration: 236.316986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:32.10914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.807768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-02T01:12:32.109162Z","caller":"traceutil/trace.go:171","msg":"trace[1084721989] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25072; }","duration":"244.847574ms","start":"2026-07-02T01:12:31.864302Z","end":"2026-07-02T01:12:32.10915Z","steps":["trace[1084721989] 'agreement among raft nodes before linearized reading' (duration: 244.738191ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.109207Z","caller":"traceutil/trace.go:171","msg":"trace[407885360] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25072; }","duration":"232.930192ms","start":"2026-07-02T01:12:31.876259Z","end":"2026-07-02T01:12:32.10919Z","steps":["trace[407885360] 'agreement among raft nodes before linearized reading' (duration: 232.718596ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:32.37655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.760377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:32.376976Z","caller":"traceutil/trace.go:171","msg":"trace[960567941] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"262.815565ms","start":"2026-07-02T01:12:32.114139Z","end":"2026-07-02T01:12:32.376954Z","steps":["trace[960567941] 'process raft request' (duration: 262.61094ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.376983Z","caller":"traceutil/trace.go:171","msg":"trace[797258485] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"262.886998ms","start":"2026-07-02T01:12:32.114057Z","end":"2026-07-02T01:12:32.376944Z","steps":["trace[797258485] 'process raft request' (duration: 262.60434ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.376976Z","caller":"traceutil/trace.go:171","msg":"trace[1094967608] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"264.319038ms","start":"2026-07-02T01:12:32.112638Z","end":"2026-07-02T01:12:32.376957Z","steps":["trace[1094967608] 'process raft request' (duration: 122.070957ms)","trace[1094967608] 'compare' (duration: 141.573762ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:32.738037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.032721ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-02T01:12:32.738206Z","caller":"traceutil/trace.go:171","msg":"trace[384338702] linearizableReadLoop","detail":"{readStateIndex:25893; appliedIndex:25892; }","duration":"169.065439ms","start":"2026-07-02T01:12:32.569126Z","end":"2026-07-02T01:12:32.738192Z","steps":["trace[384338702] 'read index received' (duration: 58.921245ms)","trace[384338702] 'applied index is now lower than readState.Index' (duration: 110.142024ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:32.738373Z","caller":"traceutil/trace.go:171","msg":"trace[1211080541] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"161.980462ms","start":"2026-07-02T01:12:32.576372Z","end":"2026-07-02T01:12:32.738352Z","steps":["trace[1211080541] 'process raft request' (duration: 161.748095ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:32.843653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.503052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:32.843739Z","caller":"traceutil/trace.go:171","msg":"trace[1580432098] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25076; }","duration":"274.629565ms","start":"2026-07-02T01:12:32.569086Z","end":"2026-07-02T01:12:32.843715Z","steps":["trace[1580432098] 'agreement among raft nodes before linearized reading' (duration: 169.192122ms)","trace[1580432098] 'range keys from in-memory index tree' (duration: 105.309189ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:32.843868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.460184ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:12:32.844042Z","caller":"traceutil/trace.go:171","msg":"trace[355202435] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"256.806918ms","start":"2026-07-02T01:12:32.587211Z","end":"2026-07-02T01:12:32.844018Z","steps":["trace[355202435] 'process raft request' (duration: 151.130178ms)","trace[355202435] 'compare' (duration: 105.373201ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:32.844147Z","caller":"traceutil/trace.go:171","msg":"trace[2112586857] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"254.420051ms","start":"2026-07-02T01:12:32.589708Z","end":"2026-07-02T01:12:32.844128Z","steps":["trace[2112586857] 'process raft request' (duration: 254.241726ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.844199Z","caller":"traceutil/trace.go:171","msg":"trace[1711702103] linearizableReadLoop","detail":"{readStateIndex:25897; appliedIndex:25893; }","duration":"105.953858ms","start":"2026-07-02T01:12:32.738234Z","end":"2026-07-02T01:12:32.844188Z","steps":["trace[1711702103] 'read index received' (duration: 30.461µs)","trace[1711702103] 'applied index is now lower than readState.Index' (duration: 105.922077ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:32.844299Z","caller":"traceutil/trace.go:171","msg":"trace[2076376109] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"253.67899ms","start":"2026-07-02T01:12:32.590608Z","end":"2026-07-02T01:12:32.844287Z","steps":["trace[2076376109] 'process raft request' (duration: 253.392102ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:32.844297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.371309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-02T01:12:32.844316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.009993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"warn","ts":"2026-07-02T01:12:32.844339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.746747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-02T01:12:32.844343Z","caller":"traceutil/trace.go:171","msg":"trace[1039370326] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:25080; }","duration":"216.448142ms","start":"2026-07-02T01:12:32.627882Z","end":"2026-07-02T01:12:32.844331Z","steps":["trace[1039370326] 'agreement among raft nodes before linearized reading' (duration: 216.37217ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.844355Z","caller":"traceutil/trace.go:171","msg":"trace[65271700] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25080; }","duration":"176.090715ms","start":"2026-07-02T01:12:32.668252Z","end":"2026-07-02T01:12:32.844343Z","steps":["trace[65271700] 'agreement among raft nodes before linearized reading' (duration: 175.963651ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.844368Z","caller":"traceutil/trace.go:171","msg":"trace[1041560305] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25080; }","duration":"251.799198ms","start":"2026-07-02T01:12:32.59256Z","end":"2026-07-02T01:12:32.84436Z","steps":["trace[1041560305] 'agreement among raft nodes before linearized reading' (duration: 251.680255ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:32.844403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.338618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-17ce895a-6f2c-4eac-a01a-bf4bc38b6cea\" ","response":"range_response_count:1 size:3764"} {"level":"info","ts":"2026-07-02T01:12:32.844498Z","caller":"traceutil/trace.go:171","msg":"trace[908113773] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-17ce895a-6f2c-4eac-a01a-bf4bc38b6cea; range_end:; response_count:1; response_revision:25080; }","duration":"154.471912ms","start":"2026-07-02T01:12:32.689999Z","end":"2026-07-02T01:12:32.844471Z","steps":["trace[908113773] 'agreement among raft nodes before linearized reading' (duration: 154.207654ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:32.980827Z","caller":"traceutil/trace.go:171","msg":"trace[1504390062] linearizableReadLoop","detail":"{readStateIndex:25899; appliedIndex:25898; }","duration":"131.699206ms","start":"2026-07-02T01:12:32.849104Z","end":"2026-07-02T01:12:32.980803Z","steps":["trace[1504390062] 'read index received' (duration: 127.779846ms)","trace[1504390062] 'applied index is now lower than readState.Index' (duration: 3.91744ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:32.981093Z","caller":"traceutil/trace.go:171","msg":"trace[142037518] transaction","detail":"{read_only:false; response_revision:25081; number_of_response:1; }","duration":"132.461658ms","start":"2026-07-02T01:12:32.848477Z","end":"2026-07-02T01:12:32.980938Z","steps":["trace[142037518] 'process raft request' (duration: 128.398544ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:32.981134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.971793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:12:32.981204Z","caller":"traceutil/trace.go:171","msg":"trace[1196194033] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25081; }","duration":"132.068496ms","start":"2026-07-02T01:12:32.849115Z","end":"2026-07-02T01:12:32.981184Z","steps":["trace[1196194033] 'agreement among raft nodes before linearized reading' (duration: 131.956373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:32.981524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.394075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"} {"level":"info","ts":"2026-07-02T01:12:32.981613Z","caller":"traceutil/trace.go:171","msg":"trace[501988381] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:25081; }","duration":"132.514229ms","start":"2026-07-02T01:12:32.849073Z","end":"2026-07-02T01:12:32.981587Z","steps":["trace[501988381] 'agreement among raft nodes before linearized reading' (duration: 132.245341ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:33.372483Z","caller":"traceutil/trace.go:171","msg":"trace[301357191] linearizableReadLoop","detail":"{readStateIndex:25900; appliedIndex:25899; }","duration":"381.053036ms","start":"2026-07-02T01:12:32.991401Z","end":"2026-07-02T01:12:33.372454Z","steps":["trace[301357191] 'read index received' (duration: 281.199309ms)","trace[301357191] 'applied index is now lower than readState.Index' (duration: 99.852247ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:33.372503Z","caller":"traceutil/trace.go:171","msg":"trace[251032879] transaction","detail":"{read_only:false; response_revision:25082; number_of_response:1; }","duration":"381.118457ms","start":"2026-07-02T01:12:32.991352Z","end":"2026-07-02T01:12:33.37247Z","steps":["trace[251032879] 'process raft request' (duration: 281.137176ms)","trace[251032879] 'compare' (duration: 99.5621ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:12:33.372658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:32.991335Z","time spent":"381.247701ms","remote":"127.0.0.1:55840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":724,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:12:33.372748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.324283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1446"} {"level":"info","ts":"2026-07-02T01:12:33.372836Z","caller":"traceutil/trace.go:171","msg":"trace[1680052173] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25082; }","duration":"381.453157ms","start":"2026-07-02T01:12:32.991363Z","end":"2026-07-02T01:12:33.372816Z","steps":["trace[1680052173] 'agreement among raft nodes before linearized reading' (duration: 381.182479ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:33.372878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:12:32.991347Z","time spent":"381.523149ms","remote":"127.0.0.1:55906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":1468,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-07-02T01:12:39.208504Z","caller":"traceutil/trace.go:171","msg":"trace[461578241] transaction","detail":"{read_only:false; response_revision:25146; number_of_response:1; }","duration":"142.079935ms","start":"2026-07-02T01:12:39.06639Z","end":"2026-07-02T01:12:39.20847Z","steps":["trace[461578241] 'process raft request' (duration: 141.913621ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:39.56565Z","caller":"traceutil/trace.go:171","msg":"trace[813107531] transaction","detail":"{read_only:false; response_revision:25147; number_of_response:1; }","duration":"132.179869ms","start":"2026-07-02T01:12:39.433445Z","end":"2026-07-02T01:12:39.565625Z","steps":["trace[813107531] 'process raft request' (duration: 49.43372ms)","trace[813107531] 'compare' (duration: 82.651577ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:44.37893Z","caller":"traceutil/trace.go:171","msg":"trace[688538472] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"177.835343ms","start":"2026-07-02T01:12:44.201066Z","end":"2026-07-02T01:12:44.378902Z","steps":["trace[688538472] 'process raft request' (duration: 122.55147ms)","trace[688538472] 'compare' (duration: 55.128609ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:46.551779Z","caller":"traceutil/trace.go:171","msg":"trace[1871774634] transaction","detail":"{read_only:false; response_revision:25205; number_of_response:1; }","duration":"164.78726ms","start":"2026-07-02T01:12:46.386971Z","end":"2026-07-02T01:12:46.551758Z","steps":["trace[1871774634] 'process raft request' (duration: 70.628302ms)","trace[1871774634] 'compare' (duration: 94.008114ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:46.551862Z","caller":"traceutil/trace.go:171","msg":"trace[383710875] linearizableReadLoop","detail":"{readStateIndex:26027; appliedIndex:26025; }","duration":"119.357001ms","start":"2026-07-02T01:12:46.432482Z","end":"2026-07-02T01:12:46.551839Z","steps":["trace[383710875] 'read index received' (duration: 25.129511ms)","trace[383710875] 'applied index is now lower than readState.Index' (duration: 94.2258ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:12:46.551893Z","caller":"traceutil/trace.go:171","msg":"trace[265468074] transaction","detail":"{read_only:false; response_revision:25206; number_of_response:1; }","duration":"140.675646ms","start":"2026-07-02T01:12:46.411192Z","end":"2026-07-02T01:12:46.551868Z","steps":["trace[265468074] 'process raft request' (duration: 140.531622ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:46.552041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.749464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-07-02T01:12:46.552041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.546096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-02T01:12:46.552071Z","caller":"traceutil/trace.go:171","msg":"trace[1317751675] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25206; }","duration":"118.807986ms","start":"2026-07-02T01:12:46.433251Z","end":"2026-07-02T01:12:46.552059Z","steps":["trace[1317751675] 'agreement among raft nodes before linearized reading' (duration: 118.694763ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:12:46.55209Z","caller":"traceutil/trace.go:171","msg":"trace[380027286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25206; }","duration":"119.633889ms","start":"2026-07-02T01:12:46.432443Z","end":"2026-07-02T01:12:46.552077Z","steps":["trace[380027286] 'agreement among raft nodes before linearized reading' (duration: 119.482535ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:12:46.552124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.34248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-07-02T01:12:46.552151Z","caller":"traceutil/trace.go:171","msg":"trace[934503124] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25206; }","duration":"115.415722ms","start":"2026-07-02T01:12:46.436727Z","end":"2026-07-02T01:12:46.552143Z","steps":["trace[934503124] 'agreement among raft nodes before linearized reading' (duration: 115.310929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:02.746068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.915541ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-02T01:13:02.746176Z","caller":"traceutil/trace.go:171","msg":"trace[2085110258] linearizableReadLoop","detail":"{readStateIndex:26161; appliedIndex:26160; }","duration":"129.411142ms","start":"2026-07-02T01:13:02.616747Z","end":"2026-07-02T01:13:02.746158Z","steps":["trace[2085110258] 'read index received' (duration: 41.251µs)","trace[2085110258] 'applied index is now lower than readState.Index' (duration: 129.368581ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:13:02.746381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.634228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T01:13:02.746417Z","caller":"traceutil/trace.go:171","msg":"trace[1488485198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25335; }","duration":"129.7113ms","start":"2026-07-02T01:13:02.616696Z","end":"2026-07-02T01:13:02.746408Z","steps":["trace[1488485198] 'agreement among raft nodes before linearized reading' (duration: 129.560806ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:02.863379Z","caller":"traceutil/trace.go:171","msg":"trace[1521853930] transaction","detail":"{read_only:false; response_revision:25336; number_of_response:1; }","duration":"113.708103ms","start":"2026-07-02T01:13:02.749647Z","end":"2026-07-02T01:13:02.863355Z","steps":["trace[1521853930] 'process raft request' (duration: 113.546909ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:03.149505Z","caller":"traceutil/trace.go:171","msg":"trace[619115756] transaction","detail":"{read_only:false; response_revision:25337; number_of_response:1; }","duration":"399.212203ms","start":"2026-07-02T01:13:02.750276Z","end":"2026-07-02T01:13:03.149488Z","steps":["trace[619115756] 'process raft request' (duration: 317.577124ms)","trace[619115756] 'compare' (duration: 81.414403ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:13:03.149604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:02.750261Z","time spent":"399.292305ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:13:03.149758Z","caller":"traceutil/trace.go:171","msg":"trace[1693043023] transaction","detail":"{read_only:false; response_revision:25338; number_of_response:1; }","duration":"399.430589ms","start":"2026-07-02T01:13:02.750304Z","end":"2026-07-02T01:13:03.149735Z","steps":["trace[1693043023] 'process raft request' (duration: 399.152921ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:03.149772Z","caller":"traceutil/trace.go:171","msg":"trace[1350563901] transaction","detail":"{read_only:false; response_revision:25340; number_of_response:1; }","duration":"317.051839ms","start":"2026-07-02T01:13:02.832699Z","end":"2026-07-02T01:13:03.14975Z","steps":["trace[1350563901] 'process raft request' (duration: 317.011938ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:03.149818Z","caller":"traceutil/trace.go:171","msg":"trace[864712457] transaction","detail":"{read_only:false; response_revision:25339; number_of_response:1; }","duration":"399.442799ms","start":"2026-07-02T01:13:02.750336Z","end":"2026-07-02T01:13:03.149779Z","steps":["trace[864712457] 'process raft request' (duration: 399.290985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:03.149901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:02.832672Z","time spent":"317.150752ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:13:03.149886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:02.750287Z","time spent":"399.527682ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:13:03.150068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:02.750315Z","time spent":"399.657925ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:13:03.213136Z","caller":"traceutil/trace.go:171","msg":"trace[1128316336] transaction","detail":"{read_only:false; response_revision:25341; number_of_response:1; }","duration":"270.791149ms","start":"2026-07-02T01:13:02.942323Z","end":"2026-07-02T01:13:03.213114Z","steps":["trace[1128316336] 'process raft request' (duration: 270.642045ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:03.213452Z","caller":"traceutil/trace.go:171","msg":"trace[1693593888] transaction","detail":"{read_only:false; response_revision:25342; number_of_response:1; }","duration":"271.051516ms","start":"2026-07-02T01:13:02.94236Z","end":"2026-07-02T01:13:03.213411Z","steps":["trace[1693593888] 'process raft request' (duration: 270.724077ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:03.213507Z","caller":"traceutil/trace.go:171","msg":"trace[159602754] transaction","detail":"{read_only:false; response_revision:25343; number_of_response:1; }","duration":"257.690792ms","start":"2026-07-02T01:13:02.955792Z","end":"2026-07-02T01:13:03.213483Z","steps":["trace[159602754] 'process raft request' (duration: 257.502817ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:03.21354Z","caller":"traceutil/trace.go:171","msg":"trace[703733436] linearizableReadLoop","detail":"{readStateIndex:26170; appliedIndex:26162; }","duration":"168.102072ms","start":"2026-07-02T01:13:03.045426Z","end":"2026-07-02T01:13:03.213528Z","steps":["trace[703733436] 'read index received' (duration: 22.443067ms)","trace[703733436] 'applied index is now lower than readState.Index' (duration: 145.658445ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:13:03.213624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.172634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:13:03.213856Z","caller":"traceutil/trace.go:171","msg":"trace[768065264] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25344; }","duration":"168.260287ms","start":"2026-07-02T01:13:03.045391Z","end":"2026-07-02T01:13:03.213651Z","steps":["trace[768065264] 'agreement among raft nodes before linearized reading' (duration: 168.179124ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:03.213873Z","caller":"traceutil/trace.go:171","msg":"trace[1872765411] transaction","detail":"{read_only:false; response_revision:25344; number_of_response:1; }","duration":"257.705052ms","start":"2026-07-02T01:13:02.955901Z","end":"2026-07-02T01:13:03.213606Z","steps":["trace[1872765411] 'process raft request' (duration: 257.533648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:03.461552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.865039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:13:03.46162Z","caller":"traceutil/trace.go:171","msg":"trace[1145746370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25344; }","duration":"170.985002ms","start":"2026-07-02T01:13:03.290615Z","end":"2026-07-02T01:13:03.4616Z","steps":["trace[1145746370] 'range keys from in-memory index tree' (duration: 170.768436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:03.461651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.496643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-02T01:13:03.46173Z","caller":"traceutil/trace.go:171","msg":"trace[946128187] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25344; }","duration":"144.624976ms","start":"2026-07-02T01:13:03.317086Z","end":"2026-07-02T01:13:03.461711Z","steps":["trace[946128187] 'range keys from in-memory index tree' (duration: 144.273347ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:03.703866Z","caller":"traceutil/trace.go:171","msg":"trace[1830004414] linearizableReadLoop","detail":"{readStateIndex:26171; appliedIndex:26170; }","duration":"231.071579ms","start":"2026-07-02T01:13:03.472755Z","end":"2026-07-02T01:13:03.703826Z","steps":["trace[1830004414] 'read index received' (duration: 230.868774ms)","trace[1830004414] 'applied index is now lower than readState.Index' (duration: 201.525µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:03.704023Z","caller":"traceutil/trace.go:171","msg":"trace[468112372] transaction","detail":"{read_only:false; response_revision:25345; number_of_response:1; }","duration":"237.757077ms","start":"2026-07-02T01:13:03.466253Z","end":"2026-07-02T01:13:03.70401Z","steps":["trace[468112372] 'process raft request' (duration: 237.414907ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:03.704433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.651295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3308"} {"level":"info","ts":"2026-07-02T01:13:03.704525Z","caller":"traceutil/trace.go:171","msg":"trace[1627980274] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25345; }","duration":"231.783049ms","start":"2026-07-02T01:13:03.472719Z","end":"2026-07-02T01:13:03.704502Z","steps":["trace[1627980274] 'agreement among raft nodes before linearized reading' (duration: 231.530692ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:04.442306Z","caller":"traceutil/trace.go:171","msg":"trace[580377065] linearizableReadLoop","detail":"{readStateIndex:26174; appliedIndex:26172; }","duration":"150.720177ms","start":"2026-07-02T01:13:04.291565Z","end":"2026-07-02T01:13:04.442285Z","steps":["trace[580377065] 'read index received' (duration: 12.239902ms)","trace[580377065] 'applied index is now lower than readState.Index' (duration: 138.479605ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:04.442464Z","caller":"traceutil/trace.go:171","msg":"trace[805292499] transaction","detail":"{read_only:false; response_revision:25348; number_of_response:1; }","duration":"188.273805ms","start":"2026-07-02T01:13:04.254181Z","end":"2026-07-02T01:13:04.442455Z","steps":["trace[805292499] 'process raft request' (duration: 117.839419ms)","trace[805292499] 'compare' (duration: 70.188019ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:13:04.44283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.257352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:13:04.442906Z","caller":"traceutil/trace.go:171","msg":"trace[995084801] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25348; }","duration":"151.382225ms","start":"2026-07-02T01:13:04.291507Z","end":"2026-07-02T01:13:04.442889Z","steps":["trace[995084801] 'agreement among raft nodes before linearized reading' (duration: 151.028025ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:04.458248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.68193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-07-02T01:13:04.458306Z","caller":"traceutil/trace.go:171","msg":"trace[815937764] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25349; }","duration":"162.781893ms","start":"2026-07-02T01:13:04.29551Z","end":"2026-07-02T01:13:04.458292Z","steps":["trace[815937764] 'agreement among raft nodes before linearized reading' (duration: 162.589358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:04.696331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.779678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-07-02T01:13:04.696437Z","caller":"traceutil/trace.go:171","msg":"trace[802769938] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25349; }","duration":"150.945744ms","start":"2026-07-02T01:13:04.545468Z","end":"2026-07-02T01:13:04.696414Z","steps":["trace[802769938] 'range keys from in-memory index tree' (duration: 150.565573ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:06.587808Z","caller":"traceutil/trace.go:171","msg":"trace[1870640917] transaction","detail":"{read_only:false; response_revision:25363; number_of_response:1; }","duration":"140.008598ms","start":"2026-07-02T01:13:06.447585Z","end":"2026-07-02T01:13:06.587593Z","steps":["trace[1870640917] 'process raft request' (duration: 73.753579ms)","trace[1870640917] 'compare' (duration: 66.029103ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:06.721635Z","caller":"traceutil/trace.go:171","msg":"trace[776453703] transaction","detail":"{read_only:false; response_revision:25364; number_of_response:1; }","duration":"143.409413ms","start":"2026-07-02T01:13:06.57819Z","end":"2026-07-02T01:13:06.721599Z","steps":["trace[776453703] 'process raft request' (duration: 137.270651ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:07.564196Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006652.wal"} {"level":"info","ts":"2026-07-02T01:13:07.564753Z","caller":"traceutil/trace.go:171","msg":"trace[1745650691] linearizableReadLoop","detail":"{readStateIndex:26193; appliedIndex:26192; }","duration":"402.68816ms","start":"2026-07-02T01:13:07.162045Z","end":"2026-07-02T01:13:07.564733Z","steps":["trace[1745650691] 'read index received' (duration: 402.391812ms)","trace[1745650691] 'applied index is now lower than readState.Index' (duration: 294.898µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:07.564837Z","caller":"traceutil/trace.go:171","msg":"trace[796877499] transaction","detail":"{read_only:false; response_revision:25367; number_of_response:1; }","duration":"459.393233ms","start":"2026-07-02T01:13:07.105435Z","end":"2026-07-02T01:13:07.564828Z","steps":["trace[796877499] 'process raft request' (duration: 458.988631ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.564918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.105413Z","time spent":"459.442324ms","remote":"127.0.0.1:52174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418437,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:13:07.565249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.164513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-02T01:13:07.565289Z","caller":"traceutil/trace.go:171","msg":"trace[468743139] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25372; }","duration":"403.224595ms","start":"2026-07-02T01:13:07.16205Z","end":"2026-07-02T01:13:07.565275Z","steps":["trace[468743139] 'agreement among raft nodes before linearized reading' (duration: 403.05593ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.565317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.162037Z","time spent":"403.275826ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-02T01:13:07.565215Z","caller":"traceutil/trace.go:171","msg":"trace[2034962790] transaction","detail":"{read_only:false; response_revision:25372; number_of_response:1; }","duration":"337.959233ms","start":"2026-07-02T01:13:07.227198Z","end":"2026-07-02T01:13:07.565157Z","steps":["trace[2034962790] 'process raft request' (duration: 337.881081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.565379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.02733ms","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-07-02T01:13:07.565424Z","caller":"traceutil/trace.go:171","msg":"trace[527083211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25372; }","duration":"403.090791ms","start":"2026-07-02T01:13:07.162319Z","end":"2026-07-02T01:13:07.56541Z","steps":["trace[527083211] 'agreement among raft nodes before linearized reading' (duration: 402.979128ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.565437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.227191Z","time spent":"338.205619ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:13:07.565462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.16231Z","time spent":"403.144473ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-02T01:13:07.565502Z","caller":"traceutil/trace.go:171","msg":"trace[491913036] transaction","detail":"{read_only:false; response_revision:25368; number_of_response:1; }","duration":"403.366659ms","start":"2026-07-02T01:13:07.162129Z","end":"2026-07-02T01:13:07.565496Z","steps":["trace[491913036] 'process raft request' (duration: 402.805514ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:07.565519Z","caller":"traceutil/trace.go:171","msg":"trace[1615173247] transaction","detail":"{read_only:false; response_revision:25370; number_of_response:1; }","duration":"339.849596ms","start":"2026-07-02T01:13:07.225641Z","end":"2026-07-02T01:13:07.56549Z","steps":["trace[1615173247] 'process raft request' (duration: 339.403174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.565496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.511836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-02T01:13:07.565536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.162102Z","time spent":"403.4133ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:13:07.565546Z","caller":"traceutil/trace.go:171","msg":"trace[1857983991] transaction","detail":"{read_only:false; response_revision:25371; number_of_response:1; }","duration":"338.764725ms","start":"2026-07-02T01:13:07.226769Z","end":"2026-07-02T01:13:07.565533Z","steps":["trace[1857983991] 'process raft request' (duration: 338.295632ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.565572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.225636Z","time spent":"339.909048ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-02T01:13:07.565583Z","caller":"traceutil/trace.go:171","msg":"trace[991511251] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25372; }","duration":"176.653091ms","start":"2026-07-02T01:13:07.388905Z","end":"2026-07-02T01:13:07.565558Z","steps":["trace[991511251] 'agreement among raft nodes before linearized reading' (duration: 176.480676ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:07.565602Z","caller":"traceutil/trace.go:171","msg":"trace[528657262] transaction","detail":"{read_only:false; response_revision:25369; number_of_response:1; }","duration":"340.02101ms","start":"2026-07-02T01:13:07.225576Z","end":"2026-07-02T01:13:07.565597Z","steps":["trace[528657262] 'process raft request' (duration: 339.447034ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.565634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.225562Z","time spent":"340.055022ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:13:07.565622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.748864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"warn","ts":"2026-07-02T01:13:07.56566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.226761Z","time spent":"338.824007ms","remote":"127.0.0.1:55978","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-02T01:13:07.565238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.50411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:13:07.565721Z","caller":"traceutil/trace.go:171","msg":"trace[1560467623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25372; }","duration":"276.027114ms","start":"2026-07-02T01:13:07.289682Z","end":"2026-07-02T01:13:07.565709Z","steps":["trace[1560467623] 'agreement among raft nodes before linearized reading' (duration: 275.469029ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:07.56573Z","caller":"traceutil/trace.go:171","msg":"trace[914791501] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:25372; }","duration":"377.903398ms","start":"2026-07-02T01:13:07.187795Z","end":"2026-07-02T01:13:07.565698Z","steps":["trace[914791501] 'agreement among raft nodes before linearized reading' (duration: 377.485646ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.565842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.187784Z","time spent":"378.042131ms","remote":"127.0.0.1:53844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":166,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-07-02T01:13:07.566329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.269974ms","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-07-02T01:13:07.566366Z","caller":"traceutil/trace.go:171","msg":"trace[581035209] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25372; }","duration":"404.346086ms","start":"2026-07-02T01:13:07.16201Z","end":"2026-07-02T01:13:07.566356Z","steps":["trace[581035209] 'agreement among raft nodes before linearized reading' (duration: 403.102451ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:07.566397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-02T01:13:07.16199Z","time spent":"404.400217ms","remote":"127.0.0.1:55978","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-07-02T01:13:08.488385Z","caller":"traceutil/trace.go:171","msg":"trace[302760555] transaction","detail":"{read_only:false; response_revision:25379; number_of_response:1; }","duration":"103.361585ms","start":"2026-07-02T01:13:08.384994Z","end":"2026-07-02T01:13:08.488356Z","steps":["trace[302760555] 'process raft request' (duration: 103.205241ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:13.764864Z","caller":"traceutil/trace.go:171","msg":"trace[634705742] transaction","detail":"{read_only:false; response_revision:25415; number_of_response:1; }","duration":"181.343271ms","start":"2026-07-02T01:13:13.583498Z","end":"2026-07-02T01:13:13.764841Z","steps":["trace[634705742] 'process raft request' (duration: 181.194837ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:13.764899Z","caller":"traceutil/trace.go:171","msg":"trace[1988557861] transaction","detail":"{read_only:false; response_revision:25414; number_of_response:1; }","duration":"182.274557ms","start":"2026-07-02T01:13:13.582568Z","end":"2026-07-02T01:13:13.764843Z","steps":["trace[1988557861] 'process raft request' (duration: 181.955798ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:13.765141Z","caller":"traceutil/trace.go:171","msg":"trace[159915733] linearizableReadLoop","detail":"{readStateIndex:26245; appliedIndex:26240; }","duration":"171.319202ms","start":"2026-07-02T01:13:13.59368Z","end":"2026-07-02T01:13:13.764999Z","steps":["trace[159915733] 'read index received' (duration: 3.069565ms)","trace[159915733] 'applied index is now lower than readState.Index' (duration: 168.248617ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:13:13.765265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.566368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-02T01:13:13.765318Z","caller":"traceutil/trace.go:171","msg":"trace[1996462599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25417; }","duration":"171.62899ms","start":"2026-07-02T01:13:13.593673Z","end":"2026-07-02T01:13:13.765302Z","steps":["trace[1996462599] 'agreement among raft nodes before linearized reading' (duration: 171.467946ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:13.765367Z","caller":"traceutil/trace.go:171","msg":"trace[1362038338] transaction","detail":"{read_only:false; response_revision:25417; number_of_response:1; }","duration":"177.900936ms","start":"2026-07-02T01:13:13.587142Z","end":"2026-07-02T01:13:13.765043Z","steps":["trace[1362038338] 'process raft request' (duration: 177.761492ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:13.765341Z","caller":"traceutil/trace.go:171","msg":"trace[1789693502] transaction","detail":"{read_only:false; response_revision:25416; number_of_response:1; }","duration":"178.085981ms","start":"2026-07-02T01:13:13.586951Z","end":"2026-07-02T01:13:13.765037Z","steps":["trace[1789693502] 'process raft request' (duration: 177.844614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:13.765577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.791619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T01:13:13.765634Z","caller":"traceutil/trace.go:171","msg":"trace[231062724] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25417; }","duration":"169.887992ms","start":"2026-07-02T01:13:13.595728Z","end":"2026-07-02T01:13:13.765616Z","steps":["trace[231062724] 'agreement among raft nodes before linearized reading' (duration: 169.710707ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:13.765772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.601954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-02T01:13:13.765876Z","caller":"traceutil/trace.go:171","msg":"trace[2067220709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25417; }","duration":"169.739338ms","start":"2026-07-02T01:13:13.596112Z","end":"2026-07-02T01:13:13.765851Z","steps":["trace[2067220709] 'agreement among raft nodes before linearized reading' (duration: 169.396848ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:19.325082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.708055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:186"} {"level":"info","ts":"2026-07-02T01:13:19.325186Z","caller":"traceutil/trace.go:171","msg":"trace[460089980] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:25466; }","duration":"199.858149ms","start":"2026-07-02T01:13:19.125307Z","end":"2026-07-02T01:13:19.325166Z","steps":["trace[460089980] 'range keys from in-memory index tree' (duration: 199.515019ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:19.597141Z","caller":"traceutil/trace.go:171","msg":"trace[1012921472] transaction","detail":"{read_only:false; response_revision:25467; number_of_response:1; }","duration":"128.704813ms","start":"2026-07-02T01:13:19.46841Z","end":"2026-07-02T01:13:19.597115Z","steps":["trace[1012921472] 'process raft request' (duration: 128.520577ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:19.776597Z","caller":"traceutil/trace.go:171","msg":"trace[1692373169] transaction","detail":"{read_only:false; response_revision:25468; number_of_response:1; }","duration":"158.443333ms","start":"2026-07-02T01:13:19.618126Z","end":"2026-07-02T01:13:19.77657Z","steps":["trace[1692373169] 'process raft request' (duration: 88.83256ms)","trace[1692373169] 'compare' (duration: 69.487839ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:19.927865Z","caller":"traceutil/trace.go:171","msg":"trace[1268138411] transaction","detail":"{read_only:false; response_revision:25470; number_of_response:1; }","duration":"143.703661ms","start":"2026-07-02T01:13:19.784134Z","end":"2026-07-02T01:13:19.927838Z","steps":["trace[1268138411] 'process raft request' (duration: 95.839005ms)","trace[1268138411] 'compare' (duration: 47.65701ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:19.928111Z","caller":"traceutil/trace.go:171","msg":"trace[1315230695] transaction","detail":"{read_only:false; response_revision:25471; number_of_response:1; }","duration":"143.699001ms","start":"2026-07-02T01:13:19.784375Z","end":"2026-07-02T01:13:19.928074Z","steps":["trace[1315230695] 'process raft request' (duration: 143.418563ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:19.928156Z","caller":"traceutil/trace.go:171","msg":"trace[1902410746] linearizableReadLoop","detail":"{readStateIndex:26301; appliedIndex:26297; }","duration":"133.26363ms","start":"2026-07-02T01:13:19.794871Z","end":"2026-07-02T01:13:19.928134Z","steps":["trace[1902410746] 'read index received' (duration: 52.777593ms)","trace[1902410746] 'applied index is now lower than readState.Index' (duration: 80.485257ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:19.9282Z","caller":"traceutil/trace.go:171","msg":"trace[810470511] transaction","detail":"{read_only:false; response_revision:25472; number_of_response:1; }","duration":"143.508076ms","start":"2026-07-02T01:13:19.784662Z","end":"2026-07-02T01:13:19.92817Z","steps":["trace[810470511] 'process raft request' (duration: 143.30738ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:19.92819Z","caller":"traceutil/trace.go:171","msg":"trace[712225977] transaction","detail":"{read_only:false; response_revision:25473; number_of_response:1; }","duration":"131.601863ms","start":"2026-07-02T01:13:19.79657Z","end":"2026-07-02T01:13:19.928172Z","steps":["trace[712225977] 'process raft request' (duration: 131.51184ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:19.928393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.736244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-02T01:13:19.928396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.227365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-02T01:13:19.928416Z","caller":"traceutil/trace.go:171","msg":"trace[2059137606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25473; }","duration":"132.791777ms","start":"2026-07-02T01:13:19.795617Z","end":"2026-07-02T01:13:19.928409Z","steps":["trace[2059137606] 'agreement among raft nodes before linearized reading' (duration: 132.684724ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:19.928423Z","caller":"traceutil/trace.go:171","msg":"trace[1311599329] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25473; }","duration":"130.299757ms","start":"2026-07-02T01:13:19.798113Z","end":"2026-07-02T01:13:19.928413Z","steps":["trace[1311599329] 'agreement among raft nodes before linearized reading' (duration: 130.185493ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:19.928411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.517697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-07-02T01:13:19.928429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.94361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-02T01:13:19.92847Z","caller":"traceutil/trace.go:171","msg":"trace[976959298] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25473; }","duration":"133.589379ms","start":"2026-07-02T01:13:19.794865Z","end":"2026-07-02T01:13:19.928454Z","steps":["trace[976959298] 'agreement among raft nodes before linearized reading' (duration: 133.393933ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:19.928492Z","caller":"traceutil/trace.go:171","msg":"trace[1682823921] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25473; }","duration":"133.047303ms","start":"2026-07-02T01:13:19.795427Z","end":"2026-07-02T01:13:19.928474Z","steps":["trace[1682823921] 'agreement among raft nodes before linearized reading' (duration: 132.862158ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:20.154074Z","caller":"traceutil/trace.go:171","msg":"trace[984457545] linearizableReadLoop","detail":"{readStateIndex:26304; appliedIndex:26302; }","duration":"219.807094ms","start":"2026-07-02T01:13:19.93424Z","end":"2026-07-02T01:13:20.154047Z","steps":["trace[984457545] 'read index received' (duration: 78.888151ms)","trace[984457545] 'applied index is now lower than readState.Index' (duration: 140.917573ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:13:20.154432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.165785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-07-02T01:13:20.154407Z","caller":"traceutil/trace.go:171","msg":"trace[2130701444] transaction","detail":"{read_only:false; response_revision:25475; number_of_response:1; }","duration":"220.316429ms","start":"2026-07-02T01:13:19.934056Z","end":"2026-07-02T01:13:20.154372Z","steps":["trace[2130701444] 'process raft request' (duration: 219.555338ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:20.154494Z","caller":"traceutil/trace.go:171","msg":"trace[529106564] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25477; }","duration":"220.260667ms","start":"2026-07-02T01:13:19.934217Z","end":"2026-07-02T01:13:20.154477Z","steps":["trace[529106564] 'agreement among raft nodes before linearized reading' (duration: 219.937398ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:20.154629Z","caller":"traceutil/trace.go:171","msg":"trace[239357147] transaction","detail":"{read_only:false; response_revision:25476; number_of_response:1; }","duration":"220.246336ms","start":"2026-07-02T01:13:19.934323Z","end":"2026-07-02T01:13:20.154569Z","steps":["trace[239357147] 'process raft request' (duration: 219.563917ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:20.15469Z","caller":"traceutil/trace.go:171","msg":"trace[391796278] transaction","detail":"{read_only:false; response_revision:25477; number_of_response:1; }","duration":"219.3263ms","start":"2026-07-02T01:13:19.935352Z","end":"2026-07-02T01:13:20.154678Z","steps":["trace[391796278] 'process raft request' (duration: 218.59869ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:24.305037Z","caller":"traceutil/trace.go:171","msg":"trace[1209185045] transaction","detail":"{read_only:false; response_revision:25504; number_of_response:1; }","duration":"129.788033ms","start":"2026-07-02T01:13:24.17521Z","end":"2026-07-02T01:13:24.304998Z","steps":["trace[1209185045] 'process raft request' (duration: 129.384242ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:24.305055Z","caller":"traceutil/trace.go:171","msg":"trace[1680614110] transaction","detail":"{read_only:false; response_revision:25503; number_of_response:1; }","duration":"130.841572ms","start":"2026-07-02T01:13:24.174188Z","end":"2026-07-02T01:13:24.305029Z","steps":["trace[1680614110] 'process raft request' (duration: 119.66793ms)","trace[1680614110] 'compare' (duration: 10.579185ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:29.956944Z","caller":"traceutil/trace.go:171","msg":"trace[219458944] linearizableReadLoop","detail":"{readStateIndex:26372; appliedIndex:26371; }","duration":"107.212913ms","start":"2026-07-02T01:13:29.849704Z","end":"2026-07-02T01:13:29.956917Z","steps":["trace[219458944] 'read index received' (duration: 107.09595ms)","trace[219458944] 'applied index is now lower than readState.Index' (duration: 115.803µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:13:29.957166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.441779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:13:29.957144Z","caller":"traceutil/trace.go:171","msg":"trace[1827863122] transaction","detail":"{read_only:false; response_revision:25541; number_of_response:1; }","duration":"153.458443ms","start":"2026-07-02T01:13:29.803579Z","end":"2026-07-02T01:13:29.957037Z","steps":["trace[1827863122] 'process raft request' (duration: 153.153435ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:29.95725Z","caller":"traceutil/trace.go:171","msg":"trace[1244969403] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:25541; }","duration":"107.578143ms","start":"2026-07-02T01:13:29.849651Z","end":"2026-07-02T01:13:29.957229Z","steps":["trace[1244969403] 'agreement among raft nodes before linearized reading' (duration: 107.410378ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:30.154413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.802431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:13:30.154721Z","caller":"traceutil/trace.go:171","msg":"trace[685036866] linearizableReadLoop","detail":"{readStateIndex:26373; appliedIndex:26372; }","duration":"189.489569ms","start":"2026-07-02T01:13:29.965211Z","end":"2026-07-02T01:13:30.154701Z","steps":["trace[685036866] 'read index received' (duration: 77.177834ms)","trace[685036866] 'applied index is now lower than readState.Index' (duration: 112.310295ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:13:30.154743Z","caller":"traceutil/trace.go:171","msg":"trace[493475926] transaction","detail":"{read_only:false; response_revision:25542; number_of_response:1; }","duration":"264.40089ms","start":"2026-07-02T01:13:29.890312Z","end":"2026-07-02T01:13:30.154713Z","steps":["trace[493475926] 'process raft request' (duration: 152.163627ms)","trace[493475926] 'compare' (duration: 111.684228ms)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:13:30.154876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.659634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-07-02T01:13:30.15491Z","caller":"traceutil/trace.go:171","msg":"trace[1924919992] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:25542; }","duration":"189.746226ms","start":"2026-07-02T01:13:29.965156Z","end":"2026-07-02T01:13:30.154902Z","steps":["trace[1924919992] 'agreement among raft nodes before linearized reading' (duration: 189.621113ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:30.228412Z","caller":"traceutil/trace.go:171","msg":"trace[717863274] transaction","detail":"{read_only:false; response_revision:25543; number_of_response:1; }","duration":"250.311027ms","start":"2026-07-02T01:13:29.978068Z","end":"2026-07-02T01:13:30.228379Z","steps":["trace[717863274] 'process raft request' (duration: 250.112031ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:30.228533Z","caller":"traceutil/trace.go:171","msg":"trace[104592379] transaction","detail":"{read_only:false; response_revision:25544; number_of_response:1; }","duration":"250.363668ms","start":"2026-07-02T01:13:29.97814Z","end":"2026-07-02T01:13:30.228504Z","steps":["trace[104592379] 'process raft request' (duration: 250.171753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:30.228682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.179814ms","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-07-02T01:13:30.228717Z","caller":"traceutil/trace.go:171","msg":"trace[847311993] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25546; }","duration":"168.266936ms","start":"2026-07-02T01:13:30.060441Z","end":"2026-07-02T01:13:30.228708Z","steps":["trace[847311993] 'agreement among raft nodes before linearized reading' (duration: 168.119042ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:30.228795Z","caller":"traceutil/trace.go:171","msg":"trace[794229332] transaction","detail":"{read_only:false; response_revision:25546; number_of_response:1; }","duration":"245.646796ms","start":"2026-07-02T01:13:29.983142Z","end":"2026-07-02T01:13:30.228788Z","steps":["trace[794229332] 'process raft request' (duration: 245.273316ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:13:30.228783Z","caller":"traceutil/trace.go:171","msg":"trace[169522741] transaction","detail":"{read_only:false; response_revision:25545; number_of_response:1; }","duration":"250.529723ms","start":"2026-07-02T01:13:29.978237Z","end":"2026-07-02T01:13:30.228766Z","steps":["trace[169522741] 'process raft request' (duration: 250.120931ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:13:47.621062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.741746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-07-02T01:13:47.621177Z","caller":"traceutil/trace.go:171","msg":"trace[2095175379] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:25671; }","duration":"136.939702ms","start":"2026-07-02T01:13:47.484213Z","end":"2026-07-02T01:13:47.621152Z","steps":["trace[2095175379] 'range keys from in-memory index tree' (duration: 136.5022ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.566336Z","caller":"traceutil/trace.go:171","msg":"trace[1143807137] transaction","detail":"{read_only:false; response_revision:26145; number_of_response:1; }","duration":"102.774959ms","start":"2026-07-02T01:14:28.463536Z","end":"2026-07-02T01:14:28.566311Z","steps":["trace[1143807137] 'process raft request' (duration: 102.653055ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.700552Z","caller":"traceutil/trace.go:171","msg":"trace[1154483571] transaction","detail":"{read_only:false; response_revision:26146; number_of_response:1; }","duration":"202.629216ms","start":"2026-07-02T01:14:28.497903Z","end":"2026-07-02T01:14:28.700533Z","steps":["trace[1154483571] 'process raft request' (duration: 202.456121ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.700863Z","caller":"traceutil/trace.go:171","msg":"trace[28378457] transaction","detail":"{read_only:false; response_revision:26147; number_of_response:1; }","duration":"196.104553ms","start":"2026-07-02T01:14:28.50475Z","end":"2026-07-02T01:14:28.700854Z","steps":["trace[28378457] 'process raft request' (duration: 195.747263ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.701088Z","caller":"traceutil/trace.go:171","msg":"trace[1478588604] linearizableReadLoop","detail":"{readStateIndex:26993; appliedIndex:26989; }","duration":"144.798361ms","start":"2026-07-02T01:14:28.556279Z","end":"2026-07-02T01:14:28.701078Z","steps":["trace[1478588604] 'read index received' (duration: 9.972608ms)","trace[1478588604] 'applied index is now lower than readState.Index' (duration: 134.824573ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:14:28.701134Z","caller":"traceutil/trace.go:171","msg":"trace[279735440] transaction","detail":"{read_only:false; response_revision:26148; number_of_response:1; }","duration":"188.039658ms","start":"2026-07-02T01:14:28.513071Z","end":"2026-07-02T01:14:28.70111Z","steps":["trace[279735440] 'process raft request' (duration: 187.695049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:14:28.701201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.912824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-02T01:14:28.70123Z","caller":"traceutil/trace.go:171","msg":"trace[774009163] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26148; }","duration":"144.996367ms","start":"2026-07-02T01:14:28.556226Z","end":"2026-07-02T01:14:28.701222Z","steps":["trace[774009163] 'agreement among raft nodes before linearized reading' (duration: 144.927745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:14:28.701349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.581499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-02T01:14:28.701459Z","caller":"traceutil/trace.go:171","msg":"trace[1178478139] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26148; }","duration":"109.723622ms","start":"2026-07-02T01:14:28.59171Z","end":"2026-07-02T01:14:28.701433Z","steps":["trace[1178478139] 'agreement among raft nodes before linearized reading' (duration: 109.477395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:14:28.701491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.693522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-02T01:14:28.701515Z","caller":"traceutil/trace.go:171","msg":"trace[1150353997] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26148; }","duration":"109.742153ms","start":"2026-07-02T01:14:28.591766Z","end":"2026-07-02T01:14:28.701508Z","steps":["trace[1150353997] 'agreement among raft nodes before linearized reading' (duration: 109.645781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:14:28.946791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.162992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-02T01:14:28.946874Z","caller":"traceutil/trace.go:171","msg":"trace[672837830] transaction","detail":"{read_only:false; response_revision:26149; number_of_response:1; }","duration":"242.439557ms","start":"2026-07-02T01:14:28.704421Z","end":"2026-07-02T01:14:28.946861Z","steps":["trace[672837830] 'process raft request' (duration: 102.143501ms)","trace[672837830] 'compare' (duration: 140.023198ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:14:28.999238Z","caller":"traceutil/trace.go:171","msg":"trace[1447120115] transaction","detail":"{read_only:false; response_revision:26151; number_of_response:1; }","duration":"294.193832ms","start":"2026-07-02T01:14:28.705012Z","end":"2026-07-02T01:14:28.999206Z","steps":["trace[1447120115] 'process raft request' (duration: 294.044647ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.999259Z","caller":"traceutil/trace.go:171","msg":"trace[1888930531] transaction","detail":"{read_only:false; response_revision:26150; number_of_response:1; }","duration":"294.251143ms","start":"2026-07-02T01:14:28.704983Z","end":"2026-07-02T01:14:28.999235Z","steps":["trace[1888930531] 'process raft request' (duration: 293.911704ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.999499Z","caller":"traceutil/trace.go:171","msg":"trace[1723175352] transaction","detail":"{read_only:false; response_revision:26153; number_of_response:1; }","duration":"261.974962ms","start":"2026-07-02T01:14:28.737517Z","end":"2026-07-02T01:14:28.999492Z","steps":["trace[1723175352] 'process raft request' (duration: 261.886739ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.999532Z","caller":"traceutil/trace.go:171","msg":"trace[1630523796] transaction","detail":"{read_only:false; response_revision:26152; number_of_response:1; }","duration":"294.293294ms","start":"2026-07-02T01:14:28.705223Z","end":"2026-07-02T01:14:28.999517Z","steps":["trace[1630523796] 'process raft request' (duration: 293.941804ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.999551Z","caller":"traceutil/trace.go:171","msg":"trace[1774734953] linearizableReadLoop","detail":"{readStateIndex:26999; appliedIndex:26994; }","duration":"150.427769ms","start":"2026-07-02T01:14:28.849104Z","end":"2026-07-02T01:14:28.999532Z","steps":["trace[1774734953] 'read index received' (duration: 149.725359ms)","trace[1774734953] 'applied index is now lower than readState.Index' (duration: 701.47µs)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:14:28.999629Z","caller":"traceutil/trace.go:171","msg":"trace[1803086486] transaction","detail":"{read_only:false; response_revision:26154; number_of_response:1; }","duration":"206.984237ms","start":"2026-07-02T01:14:28.79262Z","end":"2026-07-02T01:14:28.999604Z","steps":["trace[1803086486] 'process raft request' (duration: 206.845543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-02T01:14:28.999712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.217389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-02T01:14:28.999705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.589573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:14:28.999745Z","caller":"traceutil/trace.go:171","msg":"trace[840710988] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:26154; }","duration":"123.300301ms","start":"2026-07-02T01:14:28.876435Z","end":"2026-07-02T01:14:28.999736Z","steps":["trace[840710988] 'agreement among raft nodes before linearized reading' (duration: 123.218529ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:28.999751Z","caller":"traceutil/trace.go:171","msg":"trace[1803219974] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:26154; }","duration":"150.689496ms","start":"2026-07-02T01:14:28.849051Z","end":"2026-07-02T01:14:28.99974Z","steps":["trace[1803219974] 'agreement among raft nodes before linearized reading' (duration: 150.581883ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:14:29.143454Z","caller":"traceutil/trace.go:171","msg":"trace[1111106283] transaction","detail":"{read_only:false; response_revision:26155; number_of_response:1; }","duration":"123.893338ms","start":"2026-07-02T01:14:29.019513Z","end":"2026-07-02T01:14:29.143406Z","steps":["trace[1111106283] 'process raft request' (duration: 58.40761ms)","trace[1111106283] 'compare' (duration: 64.941033ms)"],"step_count":2} {"level":"info","ts":"2026-07-02T01:14:34.485379Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23274} {"level":"info","ts":"2026-07-02T01:14:34.677802Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23274,"took":"188.497121ms","hash":3930885521,"current-db-size-bytes":61128704,"current-db-size":"61 MB","current-db-size-in-use-bytes":37015552,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-07-02T01:14:34.677862Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3930885521,"revision":23274,"compact-revision":20197} {"level":"info","ts":"2026-07-02T01:15:20.025764Z","caller":"traceutil/trace.go:171","msg":"trace[1041632221] linearizableReadLoop","detail":"{readStateIndex:27518; appliedIndex:27517; }","duration":"138.675891ms","start":"2026-07-02T01:15:19.88707Z","end":"2026-07-02T01:15:20.025746Z","steps":["trace[1041632221] 'read index received' (duration: 138.527717ms)","trace[1041632221] 'applied index is now lower than readState.Index' (duration: 147.694µs)"],"step_count":2} {"level":"warn","ts":"2026-07-02T01:15:20.025878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.787384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-02T01:15:20.025899Z","caller":"traceutil/trace.go:171","msg":"trace[1134181691] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:26660; }","duration":"138.850286ms","start":"2026-07-02T01:15:19.887042Z","end":"2026-07-02T01:15:20.025892Z","steps":["trace[1134181691] 'agreement among raft nodes before linearized reading' (duration: 138.779344ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:15:20.026087Z","caller":"traceutil/trace.go:171","msg":"trace[1617781865] transaction","detail":"{read_only:false; response_revision:26660; number_of_response:1; }","duration":"163.736981ms","start":"2026-07-02T01:15:19.862321Z","end":"2026-07-02T01:15:20.026058Z","steps":["trace[1617781865] 'process raft request' (duration: 163.320839ms)"],"step_count":1} {"level":"info","ts":"2026-07-02T01:19:34.490808Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26206} {"level":"info","ts":"2026-07-02T01:19:34.633045Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26206,"took":"138.208041ms","hash":1010247230,"current-db-size-bytes":61128704,"current-db-size":"61 MB","current-db-size-in-use-bytes":34828288,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-07-02T01:19:34.633114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1010247230,"revision":26206,"compact-revision":23274} {"level":"info","ts":"2026-07-02T01:20:00.117977Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-02T01:20:00.124819Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-02T01:20:00.124893Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-02T01:24:34.496827Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28886} {"level":"info","ts":"2026-07-02T01:24:34.632344Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28886,"took":"132.162662ms","hash":161216980,"current-db-size-bytes":61128704,"current-db-size":"61 MB","current-db-size-in-use-bytes":31531008,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-02T01:24:34.632396Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":161216980,"revision":28886,"compact-revision":26206} {"level":"info","ts":"2026-07-02T01:29:34.504645Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31107} {"level":"info","ts":"2026-07-02T01:29:34.634059Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31107,"took":"124.719904ms","hash":4034794699,"current-db-size-bytes":61128704,"current-db-size":"61 MB","current-db-size-in-use-bytes":31563776,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-02T01:29:34.634154Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4034794699,"revision":31107,"compact-revision":28886} {"level":"info","ts":"2026-07-02T01:34:34.510723Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33375} {"level":"info","ts":"2026-07-02T01:34:34.653948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33375,"took":"138.961949ms","hash":3346837206,"current-db-size-bytes":61128704,"current-db-size":"61 MB","current-db-size-in-use-bytes":32960512,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-07-02T01:34:34.654041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3346837206,"revision":33375,"compact-revision":31107} {"level":"info","ts":"2026-07-02T01:39:34.516202Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35668} {"level":"info","ts":"2026-07-02T01:39:34.672248Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35668,"took":"151.698994ms","hash":2476069739,"current-db-size-bytes":62451712,"current-db-size":"62 MB","current-db-size-in-use-bytes":31907840,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-02T01:39:34.672308Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2476069739,"revision":35668,"compact-revision":33375} {"level":"info","ts":"2026-07-02T01:41:23.996842Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-02T01:41:24.001517Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-02T01:41:24.001586Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}