{"level":"warn","ts":"2026-06-09T22:23:00.960391Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T22:23:00.96048Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.202: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.19.213.202:2380","--initial-cluster=instance=https://199.19.213.202:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.202:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.202: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-06-09T22:23:00.960549Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-09T22:23:00.960556Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.202:2380"]} {"level":"info","ts":"2026-06-09T22:23:00.960573Z","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-06-09T22:23:00.961275Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"]} {"level":"info","ts":"2026-06-09T22:23:00.961351Z","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.19.213.202:2380"],"listen-peer-urls":["https://199.19.213.202:2380"],"advertise-client-urls":["https://199.19.213.202:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.202: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-06-09T22:23:00.965431Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.810407ms"} {"level":"info","ts":"2026-06-09T22:23:00.97176Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c9b4049ccf4190cf","cluster-id":"2bc66bd50b26302c"} {"level":"info","ts":"2026-06-09T22:23:00.972189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T22:23:00.972392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became follower at term 0"} {"level":"info","ts":"2026-06-09T22:23:00.972511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c9b4049ccf4190cf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T22:23:00.972911Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became follower at term 1"} {"level":"info","ts":"2026-06-09T22:23:00.973094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=(14534246968970023119)"} {"level":"warn","ts":"2026-06-09T22:23:00.978144Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T22:23:00.979735Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T22:23:00.981236Z","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-06-09T22:23:00.983602Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c9b4049ccf4190cf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T22:23:00.983884Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c9b4049ccf4190cf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T22:23:00.983929Z","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-06-09T22:23:00.984043Z","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-06-09T22:23:00.984068Z","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-06-09T22:23:00.985726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf switched to configuration voters=(14534246968970023119)"} {"level":"info","ts":"2026-06-09T22:23:00.985897Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bc66bd50b26302c","local-member-id":"c9b4049ccf4190cf","added-peer-id":"c9b4049ccf4190cf","added-peer-peer-urls":["https://199.19.213.202:2380"]} {"level":"info","ts":"2026-06-09T22:23:00.988758Z","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-06-09T22:23:00.989014Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.202:2380"} {"level":"info","ts":"2026-06-09T22:23:00.989048Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c9b4049ccf4190cf","initial-advertise-peer-urls":["https://199.19.213.202:2380"],"listen-peer-urls":["https://199.19.213.202:2380"],"advertise-client-urls":["https://199.19.213.202:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.202:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T22:23:00.98914Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T22:23:00.989092Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.202:2380"} {"level":"info","ts":"2026-06-09T22:23:01.373933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T22:23:01.373985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T22:23:01.374007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf received MsgPreVoteResp from c9b4049ccf4190cf at term 1"} {"level":"info","ts":"2026-06-09T22:23:01.374018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became candidate at term 2"} {"level":"info","ts":"2026-06-09T22:23:01.374023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf received MsgVoteResp from c9b4049ccf4190cf at term 2"} {"level":"info","ts":"2026-06-09T22:23:01.374031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9b4049ccf4190cf became leader at term 2"} {"level":"info","ts":"2026-06-09T22:23:01.374038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9b4049ccf4190cf elected leader c9b4049ccf4190cf at term 2"} {"level":"info","ts":"2026-06-09T22:23:01.374949Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:23:01.375587Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c9b4049ccf4190cf","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.202:2379]}","request-path":"/0/members/c9b4049ccf4190cf/attributes","cluster-id":"2bc66bd50b26302c","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T22:23:01.375588Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:23:01.375749Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:23:01.375952Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T22:23:01.376022Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T22:23:01.377326Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bc66bd50b26302c","local-member-id":"c9b4049ccf4190cf","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:23:01.377433Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:23:01.377485Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:23:01.377848Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T22:23:01.37837Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.202:2379"} {"level":"info","ts":"2026-06-09T22:23:04.604535Z","caller":"traceutil/trace.go:171","msg":"trace[1210504489] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"211.93982ms","start":"2026-06-09T22:23:04.392563Z","end":"2026-06-09T22:23:04.604503Z","steps":["trace[1210504489] 'process raft request' (duration: 143.180459ms)","trace[1210504489] 'compare' (duration: 68.612826ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:23:12.052459Z","caller":"traceutil/trace.go:171","msg":"trace[175997776] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"219.594423ms","start":"2026-06-09T22:23:11.832226Z","end":"2026-06-09T22:23:12.051821Z","steps":["trace[175997776] 'process raft request' (duration: 219.367366ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:12.052094Z","caller":"traceutil/trace.go:171","msg":"trace[829968251] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:373; }","duration":"206.594639ms","start":"2026-06-09T22:23:11.845164Z","end":"2026-06-09T22:23:12.051759Z","steps":["trace[829968251] 'read index received' (duration: 206.376603ms)","trace[829968251] 'applied index is now lower than readState.Index' (duration: 216.926µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:23:12.053896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.076825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-06-09T22:23:12.054226Z","caller":"traceutil/trace.go:171","msg":"trace[360401519] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:362; }","duration":"158.295261ms","start":"2026-06-09T22:23:11.895686Z","end":"2026-06-09T22:23:12.053981Z","steps":["trace[360401519] 'agreement among raft nodes before linearized reading' (duration: 158.046824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:12.054941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.864288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-09T22:23:12.055014Z","caller":"traceutil/trace.go:171","msg":"trace[1001687491] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:362; }","duration":"109.960301ms","start":"2026-06-09T22:23:11.945022Z","end":"2026-06-09T22:23:12.054982Z","steps":["trace[1001687491] 'agreement among raft nodes before linearized reading' (duration: 109.839498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:12.05581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.619222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-09T22:23:12.055999Z","caller":"traceutil/trace.go:171","msg":"trace[1373369628] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:362; }","duration":"210.782567ms","start":"2026-06-09T22:23:11.845122Z","end":"2026-06-09T22:23:12.055904Z","steps":["trace[1373369628] 'agreement among raft nodes before linearized reading' (duration: 207.289769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:12.284821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.211016ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:23:12.285009Z","caller":"traceutil/trace.go:171","msg":"trace[1933921809] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"218.520183ms","start":"2026-06-09T22:23:12.066456Z","end":"2026-06-09T22:23:12.284976Z","steps":["trace[1933921809] 'process raft request' (duration: 72.581187ms)","trace[1933921809] 'compare' (duration: 145.070542ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:23:12.471778Z","caller":"traceutil/trace.go:171","msg":"trace[1780622825] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"405.233597ms","start":"2026-06-09T22:23:12.066485Z","end":"2026-06-09T22:23:12.471718Z","steps":["trace[1780622825] 'process raft request' (duration: 350.244392ms)","trace[1780622825] 'compare' (duration: 54.786379ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:23:12.471822Z","caller":"traceutil/trace.go:171","msg":"trace[1372570512] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"403.287063ms","start":"2026-06-09T22:23:12.068492Z","end":"2026-06-09T22:23:12.471779Z","steps":["trace[1372570512] 'process raft request' (duration: 403.236371ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:12.471949Z","caller":"traceutil/trace.go:171","msg":"trace[23184695] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"405.051842ms","start":"2026-06-09T22:23:12.066876Z","end":"2026-06-09T22:23:12.471928Z","steps":["trace[23184695] 'process raft request' (duration: 404.774574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:12.472016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:12.068481Z","time spent":"403.445297ms","remote":"127.0.0.1:43282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:23:12.472096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:12.066804Z","time spent":"405.211756ms","remote":"127.0.0.1:43480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:23:12.47244Z","caller":"traceutil/trace.go:171","msg":"trace[1308709895] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"405.091973ms","start":"2026-06-09T22:23:12.067331Z","end":"2026-06-09T22:23:12.472423Z","steps":["trace[1308709895] 'process raft request' (duration: 404.365532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:12.472033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:12.066452Z","time spent":"405.462524ms","remote":"127.0.0.1:43394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:23:12.472549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:12.067321Z","time spent":"405.173535ms","remote":"127.0.0.1:43682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:23:12.621267Z","caller":"traceutil/trace.go:171","msg":"trace[1404667176] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:379; }","duration":"143.624651ms","start":"2026-06-09T22:23:12.477613Z","end":"2026-06-09T22:23:12.621237Z","steps":["trace[1404667176] 'read index received' (duration: 137.564531ms)","trace[1404667176] 'applied index is now lower than readState.Index' (duration: 6.05887ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:23:12.621365Z","caller":"traceutil/trace.go:171","msg":"trace[188560108] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"330.462029ms","start":"2026-06-09T22:23:12.290867Z","end":"2026-06-09T22:23:12.621329Z","steps":["trace[188560108] 'process raft request' (duration: 324.299797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:12.621462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.805486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-09T22:23:12.621501Z","caller":"traceutil/trace.go:171","msg":"trace[1968935809] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:368; }","duration":"143.904599ms","start":"2026-06-09T22:23:12.477584Z","end":"2026-06-09T22:23:12.621488Z","steps":["trace[1968935809] 'agreement among raft nodes before linearized reading' (duration: 143.768915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:12.62151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:12.290837Z","time spent":"330.607213ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:23:12.621715Z","caller":"traceutil/trace.go:171","msg":"trace[1685646946] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"143.314123ms","start":"2026-06-09T22:23:12.478378Z","end":"2026-06-09T22:23:12.621692Z","steps":["trace[1685646946] 'process raft request' (duration: 143.250761ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:12.6219Z","caller":"traceutil/trace.go:171","msg":"trace[1735740483] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"144.196727ms","start":"2026-06-09T22:23:12.477691Z","end":"2026-06-09T22:23:12.621888Z","steps":["trace[1735740483] 'process raft request' (duration: 143.832057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:45.364723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.024883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T22:23:45.364831Z","caller":"traceutil/trace.go:171","msg":"trace[56063799] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"336.186577ms","start":"2026-06-09T22:23:45.02862Z","end":"2026-06-09T22:23:45.364807Z","steps":["trace[56063799] 'range keys from in-memory index tree' (duration: 335.804516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:45.364879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:45.028594Z","time spent":"336.27538ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T22:23:45.364737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.881161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:23:45.364977Z","caller":"traceutil/trace.go:171","msg":"trace[1749830063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"201.134619ms","start":"2026-06-09T22:23:45.163803Z","end":"2026-06-09T22:23:45.364938Z","steps":["trace[1749830063] 'range keys from in-memory index tree' (duration: 200.794118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:45.364809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.837197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T22:23:45.365288Z","caller":"traceutil/trace.go:171","msg":"trace[334465579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"335.409554ms","start":"2026-06-09T22:23:45.029864Z","end":"2026-06-09T22:23:45.365274Z","steps":["trace[334465579] 'range keys from in-memory index tree' (duration: 334.379573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:45.36534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:45.02984Z","time spent":"335.478086ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-09T22:23:45.635938Z","caller":"traceutil/trace.go:171","msg":"trace[1035086757] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"265.153298ms","start":"2026-06-09T22:23:45.37075Z","end":"2026-06-09T22:23:45.635903Z","steps":["trace[1035086757] 'process raft request' (duration: 264.719885ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:45.637015Z","caller":"traceutil/trace.go:171","msg":"trace[2042928594] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"159.38717ms","start":"2026-06-09T22:23:45.477604Z","end":"2026-06-09T22:23:45.636991Z","steps":["trace[2042928594] 'read index received' (duration: 157.76067ms)","trace[2042928594] 'applied index is now lower than readState.Index' (duration: 1.62529ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:23:45.63714Z","caller":"traceutil/trace.go:171","msg":"trace[1415800845] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"254.264566ms","start":"2026-06-09T22:23:45.382843Z","end":"2026-06-09T22:23:45.637108Z","steps":["trace[1415800845] 'process raft request' (duration: 253.271296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:45.637253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.631547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-09T22:23:45.637254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.81902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T22:23:45.637295Z","caller":"traceutil/trace.go:171","msg":"trace[1132280796] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"159.733691ms","start":"2026-06-09T22:23:45.477551Z","end":"2026-06-09T22:23:45.637284Z","steps":["trace[1132280796] 'agreement among raft nodes before linearized reading' (duration: 159.562605ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:45.637308Z","caller":"traceutil/trace.go:171","msg":"trace[317573942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"154.921613ms","start":"2026-06-09T22:23:45.482372Z","end":"2026-06-09T22:23:45.637294Z","steps":["trace[317573942] 'agreement among raft nodes before linearized reading' (duration: 154.758618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:46.79343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"916.97618ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:23:46.793778Z","caller":"traceutil/trace.go:171","msg":"trace[2022478529] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:663; }","duration":"630.691799ms","start":"2026-06-09T22:23:46.163065Z","end":"2026-06-09T22:23:46.793757Z","steps":["trace[2022478529] 'read index received' (duration: 54.782µs)","trace[2022478529] 'applied index is now lower than readState.Index' (duration: 630.634467ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:23:46.793778Z","caller":"traceutil/trace.go:171","msg":"trace[173563114] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"983.232686ms","start":"2026-06-09T22:23:45.810483Z","end":"2026-06-09T22:23:46.793716Z","steps":["trace[173563114] 'process raft request' (duration: 65.702779ms)","trace[173563114] 'compare' (duration: 916.815215ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:23:46.793838Z","caller":"traceutil/trace.go:171","msg":"trace[600475786] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"981.851903ms","start":"2026-06-09T22:23:45.811934Z","end":"2026-06-09T22:23:46.793785Z","steps":["trace[600475786] 'process raft request' (duration: 981.718899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:46.793922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.847174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:23:46.793966Z","caller":"traceutil/trace.go:171","msg":"trace[1655157682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"630.936536ms","start":"2026-06-09T22:23:46.163016Z","end":"2026-06-09T22:23:46.793953Z","steps":["trace[1655157682] 'agreement among raft nodes before linearized reading' (duration: 630.841673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:46.794007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:46.162988Z","time spent":"631.011779ms","remote":"127.0.0.1:43206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T22:23:46.794063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:45.810453Z","time spent":"983.488154ms","remote":"127.0.0.1:43282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T22:23:46.794084Z","caller":"traceutil/trace.go:171","msg":"trace[764581323] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"983.295528ms","start":"2026-06-09T22:23:45.810544Z","end":"2026-06-09T22:23:46.793839Z","steps":["trace[764581323] 'process raft request' (duration: 983.04823ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:46.794157Z","caller":"traceutil/trace.go:171","msg":"trace[943514556] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"980.830713ms","start":"2026-06-09T22:23:45.813261Z","end":"2026-06-09T22:23:46.794092Z","steps":["trace[943514556] 'process raft request' (duration: 980.447601ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:23:46.794383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:45.810513Z","time spent":"983.757572ms","remote":"127.0.0.1:43282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:23:46.794713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:45.811918Z","time spent":"982.023129ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:23:46.794874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:23:45.81324Z","time spent":"981.201464ms","remote":"127.0.0.1:43450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:23:48.103187Z","caller":"traceutil/trace.go:171","msg":"trace[548947348] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"103.52774ms","start":"2026-06-09T22:23:47.999626Z","end":"2026-06-09T22:23:48.103153Z","steps":["trace[548947348] 'process raft request' (duration: 103.305153ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:24:30.626917Z","caller":"traceutil/trace.go:171","msg":"trace[155831295] linearizableReadLoop","detail":"{readStateIndex:1228; appliedIndex:1227; }","duration":"165.87857ms","start":"2026-06-09T22:24:30.461004Z","end":"2026-06-09T22:24:30.626883Z","steps":["trace[155831295] 'read index received' (duration: 165.579492ms)","trace[155831295] 'applied index is now lower than readState.Index' (duration: 297.978µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:24:30.627033Z","caller":"traceutil/trace.go:171","msg":"trace[1308707605] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"235.699698ms","start":"2026-06-09T22:24:30.391276Z","end":"2026-06-09T22:24:30.626976Z","steps":["trace[1308707605] 'process raft request' (duration: 235.382999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:24:30.627353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.115287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:24:30.627516Z","caller":"traceutil/trace.go:171","msg":"trace[879169948] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1194; }","duration":"166.544739ms","start":"2026-06-09T22:24:30.460939Z","end":"2026-06-09T22:24:30.627483Z","steps":["trace[879169948] 'agreement among raft nodes before linearized reading' (duration: 166.086476ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:18.045257Z","caller":"traceutil/trace.go:171","msg":"trace[2012488144] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"119.453308ms","start":"2026-06-09T22:25:17.925751Z","end":"2026-06-09T22:25:18.045204Z","steps":["trace[2012488144] 'process raft request' (duration: 119.16517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:18.536367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.444652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-31a7dcb3-54cf-4863-9d89-37bedd92616d\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-09T22:25:18.536456Z","caller":"traceutil/trace.go:171","msg":"trace[1835900733] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-31a7dcb3-54cf-4863-9d89-37bedd92616d; range_end:; response_count:1; response_revision:1864; }","duration":"172.594006ms","start":"2026-06-09T22:25:18.363842Z","end":"2026-06-09T22:25:18.536436Z","steps":["trace[1835900733] 'range keys from in-memory index tree' (duration: 172.211495ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:18.536928Z","caller":"traceutil/trace.go:171","msg":"trace[135126574] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"160.565113ms","start":"2026-06-09T22:25:18.376246Z","end":"2026-06-09T22:25:18.536812Z","steps":["trace[135126574] 'process raft request' (duration: 159.032451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:26:03.489745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.851414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:26:03.490008Z","caller":"traceutil/trace.go:171","msg":"trace[319784556] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:2156; }","duration":"255.214544ms","start":"2026-06-09T22:26:03.234761Z","end":"2026-06-09T22:26:03.489976Z","steps":["trace[319784556] 'count revisions from in-memory index tree' (duration: 254.734871ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:26:03.490046Z","caller":"traceutil/trace.go:171","msg":"trace[1685398705] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"229.178747ms","start":"2026-06-09T22:26:03.26079Z","end":"2026-06-09T22:26:03.489968Z","steps":["trace[1685398705] 'process raft request' (duration: 139.360795ms)","trace[1685398705] 'compare' (duration: 89.221736ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:26:08.861371Z","caller":"traceutil/trace.go:171","msg":"trace[2125024502] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2268; }","duration":"112.121205ms","start":"2026-06-09T22:26:08.74921Z","end":"2026-06-09T22:26:08.861331Z","steps":["trace[2125024502] 'read index received' (duration: 111.829017ms)","trace[2125024502] 'applied index is now lower than readState.Index' (duration: 290.208µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:26:08.861426Z","caller":"traceutil/trace.go:171","msg":"trace[744684121] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"118.501701ms","start":"2026-06-09T22:26:08.742895Z","end":"2026-06-09T22:26:08.861396Z","steps":["trace[744684121] 'process raft request' (duration: 118.186642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:26:08.861607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.349292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:26:08.86166Z","caller":"traceutil/trace.go:171","msg":"trace[1642032345] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2187; }","duration":"112.519257ms","start":"2026-06-09T22:26:08.749126Z","end":"2026-06-09T22:26:08.861646Z","steps":["trace[1642032345] 'agreement among raft nodes before linearized reading' (duration: 112.349042ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:27:30.883376Z","caller":"traceutil/trace.go:171","msg":"trace[1475136088] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"127.956695ms","start":"2026-06-09T22:27:30.755389Z","end":"2026-06-09T22:27:30.883345Z","steps":["trace[1475136088] 'process raft request' (duration: 127.712988ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:30:07.837028Z","caller":"traceutil/trace.go:171","msg":"trace[301863628] transaction","detail":"{read_only:false; response_revision:3850; number_of_response:1; }","duration":"101.263573ms","start":"2026-06-09T22:30:07.735717Z","end":"2026-06-09T22:30:07.83698Z","steps":["trace[301863628] 'process raft request' (duration: 100.959934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:31:43.827326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.291826ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:31:43.827468Z","caller":"traceutil/trace.go:171","msg":"trace[1968779210] linearizableReadLoop","detail":"{readStateIndex:5310; appliedIndex:5309; }","duration":"257.801322ms","start":"2026-06-09T22:31:43.569649Z","end":"2026-06-09T22:31:43.82745Z","steps":["trace[1968779210] 'read index received' (duration: 7.205448ms)","trace[1968779210] 'applied index is now lower than readState.Index' (duration: 250.594204ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:31:43.827559Z","caller":"traceutil/trace.go:171","msg":"trace[1375618182] transaction","detail":"{read_only:false; response_revision:5113; number_of_response:1; }","duration":"325.857005ms","start":"2026-06-09T22:31:43.50162Z","end":"2026-06-09T22:31:43.827477Z","steps":["trace[1375618182] 'process raft request' (duration: 75.322813ms)","trace[1375618182] 'compare' (duration: 250.084279ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:31:43.827685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.040179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-dkr56-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-06-09T22:31:43.827718Z","caller":"traceutil/trace.go:171","msg":"trace[1870080055] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-dkr56-tls; range_end:; response_count:1; response_revision:5113; }","duration":"258.114751ms","start":"2026-06-09T22:31:43.569592Z","end":"2026-06-09T22:31:43.827707Z","steps":["trace[1870080055] 'agreement among raft nodes before linearized reading' (duration: 257.958747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:31:43.827776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:31:43.501581Z","time spent":"326.078311ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3706,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:31:43.827947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.289274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-993ebbac-b19e-41e0-ad6d-67fb7a9459ef\" ","response":"range_response_count:1 size:3721"} {"level":"info","ts":"2026-06-09T22:31:43.82799Z","caller":"traceutil/trace.go:171","msg":"trace[817442221] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-993ebbac-b19e-41e0-ad6d-67fb7a9459ef; range_end:; response_count:1; response_revision:5113; }","duration":"186.361847ms","start":"2026-06-09T22:31:43.641615Z","end":"2026-06-09T22:31:43.827977Z","steps":["trace[817442221] 'agreement among raft nodes before linearized reading' (duration: 186.279694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:31:43.828041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.404353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"warn","ts":"2026-06-09T22:31:43.8281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.456735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:786884"} {"level":"info","ts":"2026-06-09T22:31:43.828135Z","caller":"traceutil/trace.go:171","msg":"trace[470680723] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5113; }","duration":"180.537426ms","start":"2026-06-09T22:31:43.647578Z","end":"2026-06-09T22:31:43.828115Z","steps":["trace[470680723] 'agreement among raft nodes before linearized reading' (duration: 180.28908ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:31:43.828181Z","caller":"traceutil/trace.go:171","msg":"trace[463134468] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5113; }","duration":"220.584509ms","start":"2026-06-09T22:31:43.607574Z","end":"2026-06-09T22:31:43.828159Z","steps":["trace[463134468] 'agreement among raft nodes before linearized reading' (duration: 220.016573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:31:45.711524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.796853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/goldpinger-clusterrole\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:31:45.711625Z","caller":"traceutil/trace.go:171","msg":"trace[1427490570] range","detail":"{range_begin:/registry/clusterroles/goldpinger-clusterrole; range_end:; response_count:0; response_revision:5135; }","duration":"120.930207ms","start":"2026-06-09T22:31:45.590669Z","end":"2026-06-09T22:31:45.711599Z","steps":["trace[1427490570] 'range keys from in-memory index tree' (duration: 120.726241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:31:56.709285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.468097ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:31:56.70943Z","caller":"traceutil/trace.go:171","msg":"trace[1455120212] linearizableReadLoop","detail":"{readStateIndex:5557; appliedIndex:5556; }","duration":"235.823077ms","start":"2026-06-09T22:31:56.473587Z","end":"2026-06-09T22:31:56.70941Z","steps":["trace[1455120212] 'read index received' (duration: 61.642µs)","trace[1455120212] 'applied index is now lower than readState.Index' (duration: 235.759365ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:31:56.709576Z","caller":"traceutil/trace.go:171","msg":"trace[1054930480] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"299.317423ms","start":"2026-06-09T22:31:56.410209Z","end":"2026-06-09T22:31:56.709526Z","steps":["trace[1054930480] 'process raft request' (duration: 23.507427ms)","trace[1054930480] 'compare' (duration: 275.198939ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:31:56.709724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.135945ms","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-06-09T22:31:56.70977Z","caller":"traceutil/trace.go:171","msg":"trace[237574185] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5353; }","duration":"236.207047ms","start":"2026-06-09T22:31:56.473549Z","end":"2026-06-09T22:31:56.709756Z","steps":["trace[237574185] 'agreement among raft nodes before linearized reading' (duration: 235.976131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:31:56.709905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.014069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:31:56.709994Z","caller":"traceutil/trace.go:171","msg":"trace[2047500741] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5353; }","duration":"177.145952ms","start":"2026-06-09T22:31:56.532813Z","end":"2026-06-09T22:31:56.709959Z","steps":["trace[2047500741] 'agreement among raft nodes before linearized reading' (duration: 177.010108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:31:56.710048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.398603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"warn","ts":"2026-06-09T22:31:56.710114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.763117ms","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-06-09T22:31:56.710151Z","caller":"traceutil/trace.go:171","msg":"trace[55956082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5353; }","duration":"226.87226ms","start":"2026-06-09T22:31:56.483269Z","end":"2026-06-09T22:31:56.710141Z","steps":["trace[55956082] 'agreement among raft nodes before linearized reading' (duration: 226.742536ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:31:56.710157Z","caller":"traceutil/trace.go:171","msg":"trace[566684878] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5353; }","duration":"131.553369ms","start":"2026-06-09T22:31:56.578582Z","end":"2026-06-09T22:31:56.710135Z","steps":["trace[566684878] 'agreement among raft nodes before linearized reading' (duration: 131.282221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:31:56.71047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.192658ms","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-06-09T22:31:56.710579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.719555ms","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-06-09T22:31:56.71058Z","caller":"traceutil/trace.go:171","msg":"trace[2024463930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5353; }","duration":"227.360433ms","start":"2026-06-09T22:31:56.483196Z","end":"2026-06-09T22:31:56.710556Z","steps":["trace[2024463930] 'agreement among raft nodes before linearized reading' (duration: 226.440658ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:31:56.710648Z","caller":"traceutil/trace.go:171","msg":"trace[237461710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5353; }","duration":"226.840449ms","start":"2026-06-09T22:31:56.483791Z","end":"2026-06-09T22:31:56.710632Z","steps":["trace[237461710] 'agreement among raft nodes before linearized reading' (duration: 226.13285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:04.849561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.762044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-0\" ","response":"range_response_count:1 size:5835"} {"level":"info","ts":"2026-06-09T22:32:04.849685Z","caller":"traceutil/trace.go:171","msg":"trace[1905554632] range","detail":"{range_begin:/registry/pods/monitoring/loki-0; range_end:; response_count:1; response_revision:5529; }","duration":"147.940839ms","start":"2026-06-09T22:32:04.701721Z","end":"2026-06-09T22:32:04.849662Z","steps":["trace[1905554632] 'range keys from in-memory index tree' (duration: 147.527778ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:04.957402Z","caller":"traceutil/trace.go:171","msg":"trace[47601957] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"103.939999ms","start":"2026-06-09T22:32:04.853433Z","end":"2026-06-09T22:32:04.957373Z","steps":["trace[47601957] 'process raft request' (duration: 103.731263ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:05.121882Z","caller":"traceutil/trace.go:171","msg":"trace[1819015840] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"265.893994ms","start":"2026-06-09T22:32:04.85595Z","end":"2026-06-09T22:32:05.121844Z","steps":["trace[1819015840] 'process raft request' (duration: 224.949078ms)","trace[1819015840] 'compare' (duration: 40.664248ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:32:05.122077Z","caller":"traceutil/trace.go:171","msg":"trace[1665015880] transaction","detail":"{read_only:false; response_revision:5532; number_of_response:1; }","duration":"263.513018ms","start":"2026-06-09T22:32:04.858535Z","end":"2026-06-09T22:32:05.122048Z","steps":["trace[1665015880] 'process raft request' (duration: 263.22396ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:05.122158Z","caller":"traceutil/trace.go:171","msg":"trace[2081086067] linearizableReadLoop","detail":"{readStateIndex:5739; appliedIndex:5736; }","duration":"251.356254ms","start":"2026-06-09T22:32:04.870782Z","end":"2026-06-09T22:32:05.122139Z","steps":["trace[2081086067] 'read index received' (duration: 86.379046ms)","trace[2081086067] 'applied index is now lower than readState.Index' (duration: 164.975528ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:32:05.122193Z","caller":"traceutil/trace.go:171","msg":"trace[717244017] transaction","detail":"{read_only:false; response_revision:5533; number_of_response:1; }","duration":"250.951283ms","start":"2026-06-09T22:32:04.871197Z","end":"2026-06-09T22:32:05.122149Z","steps":["trace[717244017] 'process raft request' (duration: 250.686216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:05.122457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.893683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-09T22:32:05.122462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.900689ms","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-06-09T22:32:05.122522Z","caller":"traceutil/trace.go:171","msg":"trace[400908935] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5534; }","duration":"141.988356ms","start":"2026-06-09T22:32:04.980515Z","end":"2026-06-09T22:32:05.122504Z","steps":["trace[400908935] 'agreement among raft nodes before linearized reading' (duration: 141.836802ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:05.122533Z","caller":"traceutil/trace.go:171","msg":"trace[855062408] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5534; }","duration":"244.037182ms","start":"2026-06-09T22:32:04.878479Z","end":"2026-06-09T22:32:05.122516Z","steps":["trace[855062408] 'agreement among raft nodes before linearized reading' (duration: 243.836307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:05.12256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.621186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.202\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-09T22:32:05.122609Z","caller":"traceutil/trace.go:171","msg":"trace[1382950120] range","detail":"{range_begin:/registry/masterleases/199.19.213.202; range_end:; response_count:1; response_revision:5534; }","duration":"189.710048ms","start":"2026-06-09T22:32:04.932881Z","end":"2026-06-09T22:32:05.122591Z","steps":["trace[1382950120] 'agreement among raft nodes before linearized reading' (duration: 189.491042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:05.12271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.920959ms","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-06-09T22:32:05.12281Z","caller":"traceutil/trace.go:171","msg":"trace[1588269543] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5534; }","duration":"252.047273ms","start":"2026-06-09T22:32:04.870747Z","end":"2026-06-09T22:32:05.122794Z","steps":["trace[1588269543] 'agreement among raft nodes before linearized reading' (duration: 251.525579ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:05.354631Z","caller":"traceutil/trace.go:171","msg":"trace[1563397334] linearizableReadLoop","detail":"{readStateIndex:5752; appliedIndex:5751; }","duration":"146.947042ms","start":"2026-06-09T22:32:05.207652Z","end":"2026-06-09T22:32:05.354599Z","steps":["trace[1563397334] 'read index received' (duration: 71.783785ms)","trace[1563397334] 'applied index is now lower than readState.Index' (duration: 75.161857ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:32:05.354968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.54759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-09T22:32:05.35502Z","caller":"traceutil/trace.go:171","msg":"trace[1505762543] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5544; }","duration":"146.654314ms","start":"2026-06-09T22:32:05.208352Z","end":"2026-06-09T22:32:05.355006Z","steps":["trace[1505762543] 'agreement among raft nodes before linearized reading' (duration: 146.466659ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:05.355079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.474504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-09T22:32:05.35515Z","caller":"traceutil/trace.go:171","msg":"trace[308143050] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5544; }","duration":"140.607448ms","start":"2026-06-09T22:32:05.214531Z","end":"2026-06-09T22:32:05.355139Z","steps":["trace[308143050] 'agreement among raft nodes before linearized reading' (duration: 140.348851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:32:05.355039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.338332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-09T22:32:05.355288Z","caller":"traceutil/trace.go:171","msg":"trace[1257535175] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:5544; }","duration":"147.62748ms","start":"2026-06-09T22:32:05.207629Z","end":"2026-06-09T22:32:05.355256Z","steps":["trace[1257535175] 'agreement among raft nodes before linearized reading' (duration: 147.086525ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:32:05.354668Z","caller":"traceutil/trace.go:171","msg":"trace[1789170652] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"148.30722ms","start":"2026-06-09T22:32:05.206318Z","end":"2026-06-09T22:32:05.354625Z","steps":["trace[1789170652] 'process raft request' (duration: 73.262926ms)","trace[1789170652] 'compare' (duration: 74.859479ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:33:01.493347Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2993} {"level":"info","ts":"2026-06-09T22:33:01.561898Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2993,"took":"66.80236ms","hash":2298040939,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":34013184,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-09T22:33:01.562149Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2298040939,"revision":2993,"compact-revision":-1} {"level":"info","ts":"2026-06-09T22:38:01.500758Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6084} {"level":"info","ts":"2026-06-09T22:38:01.591885Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6084,"took":"89.233247ms","hash":2513653974,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":23908352,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-09T22:38:01.59196Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2513653974,"revision":6084,"compact-revision":2993} {"level":"info","ts":"2026-06-09T22:38:09.578763Z","caller":"traceutil/trace.go:171","msg":"trace[1766325947] transaction","detail":"{read_only:false; response_revision:8351; number_of_response:1; }","duration":"186.062902ms","start":"2026-06-09T22:38:09.392674Z","end":"2026-06-09T22:38:09.578737Z","steps":["trace[1766325947] 'process raft request' (duration: 185.851617ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:09.583291Z","caller":"traceutil/trace.go:171","msg":"trace[147367102] transaction","detail":"{read_only:false; response_revision:8352; number_of_response:1; }","duration":"188.278093ms","start":"2026-06-09T22:38:09.394988Z","end":"2026-06-09T22:38:09.583266Z","steps":["trace[147367102] 'process raft request' (duration: 188.145449ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:37.820071Z","caller":"traceutil/trace.go:171","msg":"trace[676224283] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"109.32629ms","start":"2026-06-09T22:38:37.710721Z","end":"2026-06-09T22:38:37.820047Z","steps":["trace[676224283] 'process raft request' (duration: 109.070003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:38:38.169231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.501165ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:38:38.169305Z","caller":"traceutil/trace.go:171","msg":"trace[2036917641] transaction","detail":"{read_only:false; response_revision:8556; number_of_response:1; }","duration":"345.536293ms","start":"2026-06-09T22:38:37.823757Z","end":"2026-06-09T22:38:38.169293Z","steps":["trace[2036917641] 'process raft request' (duration: 142.909214ms)","trace[2036917641] 'compare' (duration: 202.168406ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:38:38.16938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:38:37.823733Z","time spent":"345.624345ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:38:38.173303Z","caller":"traceutil/trace.go:171","msg":"trace[1872806282] linearizableReadLoop","detail":"{readStateIndex:8862; appliedIndex:8860; }","duration":"311.013513ms","start":"2026-06-09T22:38:37.862273Z","end":"2026-06-09T22:38:38.173286Z","steps":["trace[1872806282] 'read index received' (duration: 104.370694ms)","trace[1872806282] 'applied index is now lower than readState.Index' (duration: 206.642069ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:38:38.175387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.1003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:38:38.175416Z","caller":"traceutil/trace.go:171","msg":"trace[1119108065] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:8558; }","duration":"313.140191ms","start":"2026-06-09T22:38:37.862266Z","end":"2026-06-09T22:38:38.175406Z","steps":["trace[1119108065] 'agreement among raft nodes before linearized reading' (duration: 313.085289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:38:38.175435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:38:37.862233Z","time spent":"313.197493ms","remote":"127.0.0.1:34570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"info","ts":"2026-06-09T22:38:38.175596Z","caller":"traceutil/trace.go:171","msg":"trace[1053765936] transaction","detail":"{read_only:false; response_revision:8558; number_of_response:1; }","duration":"284.002279ms","start":"2026-06-09T22:38:37.891538Z","end":"2026-06-09T22:38:38.175541Z","steps":["trace[1053765936] 'process raft request' (duration: 281.718056ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:38.175705Z","caller":"traceutil/trace.go:171","msg":"trace[486182494] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"350.997903ms","start":"2026-06-09T22:38:37.824701Z","end":"2026-06-09T22:38:38.175699Z","steps":["trace[486182494] 'process raft request' (duration: 348.250237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:38:38.175757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:38:37.824681Z","time spent":"351.042004ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:38:38.183469Z","caller":"traceutil/trace.go:171","msg":"trace[240145254] transaction","detail":"{read_only:false; response_revision:8559; number_of_response:1; }","duration":"214.979298ms","start":"2026-06-09T22:38:37.96846Z","end":"2026-06-09T22:38:38.183439Z","steps":["trace[240145254] 'process raft request' (duration: 214.510195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:38:39.441856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.244822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:38:39.442074Z","caller":"traceutil/trace.go:171","msg":"trace[143553798] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8565; }","duration":"107.604152ms","start":"2026-06-09T22:38:39.334442Z","end":"2026-06-09T22:38:39.442047Z","steps":["trace[143553798] 'count revisions from in-memory index tree' (duration: 107.124129ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:50.714874Z","caller":"traceutil/trace.go:171","msg":"trace[834561603] transaction","detail":"{read_only:false; response_revision:8663; number_of_response:1; }","duration":"123.922412ms","start":"2026-06-09T22:38:50.590925Z","end":"2026-06-09T22:38:50.714848Z","steps":["trace[834561603] 'process raft request' (duration: 123.756067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:38:51.500443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.203865ms","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-06-09T22:38:51.500465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.251055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T22:38:51.500484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.77566ms","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-06-09T22:38:51.500534Z","caller":"traceutil/trace.go:171","msg":"trace[754077155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8668; }","duration":"134.334088ms","start":"2026-06-09T22:38:51.366178Z","end":"2026-06-09T22:38:51.500512Z","steps":["trace[754077155] 'range keys from in-memory index tree' (duration: 133.989319ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:51.50056Z","caller":"traceutil/trace.go:171","msg":"trace[24191366] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:8668; }","duration":"126.41075ms","start":"2026-06-09T22:38:51.37413Z","end":"2026-06-09T22:38:51.500541Z","steps":["trace[24191366] 'count revisions from in-memory index tree' (duration: 126.171303ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:51.500576Z","caller":"traceutil/trace.go:171","msg":"trace[298732995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8668; }","duration":"134.926925ms","start":"2026-06-09T22:38:51.365627Z","end":"2026-06-09T22:38:51.500553Z","steps":["trace[298732995] 'range keys from in-memory index tree' (duration: 134.575885ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:51.634054Z","caller":"traceutil/trace.go:171","msg":"trace[363229545] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"128.563769ms","start":"2026-06-09T22:38:51.505461Z","end":"2026-06-09T22:38:51.634025Z","steps":["trace[363229545] 'process raft request' (duration: 128.403905ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:51.74491Z","caller":"traceutil/trace.go:171","msg":"trace[842260873] transaction","detail":"{read_only:false; response_revision:8670; number_of_response:1; }","duration":"239.35655ms","start":"2026-06-09T22:38:51.505528Z","end":"2026-06-09T22:38:51.744885Z","steps":["trace[842260873] 'process raft request' (duration: 202.585267ms)","trace[842260873] 'compare' (duration: 36.586297ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:38:51.745176Z","caller":"traceutil/trace.go:171","msg":"trace[771360392] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"177.479706ms","start":"2026-06-09T22:38:51.567656Z","end":"2026-06-09T22:38:51.745135Z","steps":["trace[771360392] 'process raft request' (duration: 177.176278ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:38:51.745442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.72209ms","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-06-09T22:38:51.745527Z","caller":"traceutil/trace.go:171","msg":"trace[1740603542] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8671; }","duration":"239.860934ms","start":"2026-06-09T22:38:51.505648Z","end":"2026-06-09T22:38:51.745509Z","steps":["trace[1740603542] 'agreement among raft nodes before linearized reading' (duration: 239.574486ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:38:51.745943Z","caller":"traceutil/trace.go:171","msg":"trace[89159810] linearizableReadLoop","detail":"{readStateIndex:8981; appliedIndex:8979; }","duration":"239.390771ms","start":"2026-06-09T22:38:51.505687Z","end":"2026-06-09T22:38:51.745077Z","steps":["trace[89159810] 'read index received' (duration: 128.167919ms)","trace[89159810] 'applied index is now lower than readState.Index' (duration: 111.220162ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:38:51.746382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.70077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sdl9j\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-09T22:38:51.74644Z","caller":"traceutil/trace.go:171","msg":"trace[521690959] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sdl9j; range_end:; response_count:1; response_revision:8671; }","duration":"178.811583ms","start":"2026-06-09T22:38:51.567615Z","end":"2026-06-09T22:38:51.746427Z","steps":["trace[521690959] 'agreement among raft nodes before linearized reading' (duration: 178.621128ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:39:13.365104Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242c.wal"} {"level":"info","ts":"2026-06-09T22:40:38.932074Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c9b4049ccf4190cf","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T22:40:38.937405Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-09T22:40:38.937563Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-09T22:43:01.509004Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8310} {"level":"info","ts":"2026-06-09T22:43:01.590186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8310,"took":"78.639804ms","hash":690972564,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":26300416,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-09T22:43:01.590284Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":690972564,"revision":8310,"compact-revision":6084} {"level":"info","ts":"2026-06-09T22:43:29.160106Z","caller":"traceutil/trace.go:171","msg":"trace[1021296488] transaction","detail":"{read_only:false; response_revision:11140; number_of_response:1; }","duration":"108.876585ms","start":"2026-06-09T22:43:29.051165Z","end":"2026-06-09T22:43:29.160041Z","steps":["trace[1021296488] 'process raft request' (duration: 60.188795ms)","trace[1021296488] 'compare' (duration: 48.517375ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:48:01.522771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10792} {"level":"info","ts":"2026-06-09T22:48:01.596506Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10792,"took":"70.971485ms","hash":2125067826,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":28221440,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-09T22:48:01.596631Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2125067826,"revision":10792,"compact-revision":8310} {"level":"info","ts":"2026-06-09T22:50:09.444297Z","caller":"traceutil/trace.go:171","msg":"trace[1868308650] transaction","detail":"{read_only:false; response_revision:13824; number_of_response:1; }","duration":"249.669908ms","start":"2026-06-09T22:50:09.194602Z","end":"2026-06-09T22:50:09.444271Z","steps":["trace[1868308650] 'process raft request' (duration: 249.04494ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:50:09.456639Z","caller":"traceutil/trace.go:171","msg":"trace[1653850483] linearizableReadLoop","detail":"{readStateIndex:14301; appliedIndex:14299; }","duration":"180.196654ms","start":"2026-06-09T22:50:09.276402Z","end":"2026-06-09T22:50:09.456599Z","steps":["trace[1653850483] 'read index received' (duration: 167.516825ms)","trace[1653850483] 'applied index is now lower than readState.Index' (duration: 12.678279ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:50:09.456769Z","caller":"traceutil/trace.go:171","msg":"trace[74521959] transaction","detail":"{read_only:false; response_revision:13825; number_of_response:1; }","duration":"260.250789ms","start":"2026-06-09T22:50:09.196465Z","end":"2026-06-09T22:50:09.456716Z","steps":["trace[74521959] 'process raft request' (duration: 259.932761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:50:09.456915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.43641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:50:09.457005Z","caller":"traceutil/trace.go:171","msg":"trace[1497364484] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:13825; }","duration":"180.647306ms","start":"2026-06-09T22:50:09.276342Z","end":"2026-06-09T22:50:09.456989Z","steps":["trace[1497364484] 'agreement among raft nodes before linearized reading' (duration: 180.399139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:50:09.832851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.232585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:50:09.832941Z","caller":"traceutil/trace.go:171","msg":"trace[1391253478] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:13825; }","duration":"139.432291ms","start":"2026-06-09T22:50:09.693488Z","end":"2026-06-09T22:50:09.832921Z","steps":["trace[1391253478] 'count revisions from in-memory index tree' (duration: 139.113072ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:50:09.833018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.016727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-09T22:50:09.833149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.336078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:50:09.833277Z","caller":"traceutil/trace.go:171","msg":"trace[349171425] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13825; }","duration":"103.421939ms","start":"2026-06-09T22:50:09.729793Z","end":"2026-06-09T22:50:09.833215Z","steps":["trace[349171425] 'range keys from in-memory index tree' (duration: 102.824543ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:50:09.833284Z","caller":"traceutil/trace.go:171","msg":"trace[1252792079] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:13825; }","duration":"200.523764ms","start":"2026-06-09T22:50:09.63274Z","end":"2026-06-09T22:50:09.833264Z","steps":["trace[1252792079] 'count revisions from in-memory index tree' (duration: 200.219285ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:50:26.951004Z","caller":"traceutil/trace.go:171","msg":"trace[620241048] linearizableReadLoop","detail":"{readStateIndex:14589; appliedIndex:14588; }","duration":"110.727678ms","start":"2026-06-09T22:50:26.840251Z","end":"2026-06-09T22:50:26.950978Z","steps":["trace[620241048] 'read index received' (duration: 84.543965ms)","trace[620241048] 'applied index is now lower than readState.Index' (duration: 26.182753ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:50:26.951107Z","caller":"traceutil/trace.go:171","msg":"trace[691352039] transaction","detail":"{read_only:false; response_revision:14100; number_of_response:1; }","duration":"111.029717ms","start":"2026-06-09T22:50:26.839995Z","end":"2026-06-09T22:50:26.951024Z","steps":["trace[691352039] 'process raft request' (duration: 84.786662ms)","trace[691352039] 'compare' (duration: 25.918616ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:50:26.951251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.982665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sdl9j\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-09T22:50:26.951295Z","caller":"traceutil/trace.go:171","msg":"trace[623128684] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sdl9j; range_end:; response_count:1; response_revision:14100; }","duration":"111.068578ms","start":"2026-06-09T22:50:26.840216Z","end":"2026-06-09T22:50:26.951284Z","steps":["trace[623128684] 'agreement among raft nodes before linearized reading' (duration: 110.897613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:50:26.955457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.675829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:50:26.955551Z","caller":"traceutil/trace.go:171","msg":"trace[1353927741] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:14101; }","duration":"113.792143ms","start":"2026-06-09T22:50:26.841737Z","end":"2026-06-09T22:50:26.95553Z","steps":["trace[1353927741] 'agreement among raft nodes before linearized reading' (duration: 113.627649ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:51:20.439012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.996474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T22:51:20.439063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.054865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:51:20.439133Z","caller":"traceutil/trace.go:171","msg":"trace[1780680388] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:14739; }","duration":"116.156839ms","start":"2026-06-09T22:51:20.322951Z","end":"2026-06-09T22:51:20.439108Z","steps":["trace[1780680388] 'range keys from in-memory index tree' (duration: 115.927642ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:51:20.439149Z","caller":"traceutil/trace.go:171","msg":"trace[1769680875] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14739; }","duration":"116.156508ms","start":"2026-06-09T22:51:20.322971Z","end":"2026-06-09T22:51:20.439127Z","steps":["trace[1769680875] 'range keys from in-memory index tree' (duration: 115.962613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:51:20.439455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.736774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:51:20.439761Z","caller":"traceutil/trace.go:171","msg":"trace[982560536] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:14739; }","duration":"117.086934ms","start":"2026-06-09T22:51:20.322647Z","end":"2026-06-09T22:51:20.439734Z","steps":["trace[982560536] 'range keys from in-memory index tree' (duration: 116.525008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:51:20.439176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.750313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-06-09T22:51:20.440023Z","caller":"traceutil/trace.go:171","msg":"trace[266124319] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14739; }","duration":"101.589746ms","start":"2026-06-09T22:51:20.338408Z","end":"2026-06-09T22:51:20.439998Z","steps":["trace[266124319] 'range keys from in-memory index tree' (duration: 100.579457ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:51:57.913952Z","caller":"traceutil/trace.go:171","msg":"trace[991083413] linearizableReadLoop","detail":"{readStateIndex:15449; appliedIndex:15448; }","duration":"108.750614ms","start":"2026-06-09T22:51:57.805173Z","end":"2026-06-09T22:51:57.913924Z","steps":["trace[991083413] 'read index received' (duration: 108.689942ms)","trace[991083413] 'applied index is now lower than readState.Index' (duration: 59.522µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:51:57.914074Z","caller":"traceutil/trace.go:171","msg":"trace[858167161] transaction","detail":"{read_only:false; response_revision:14937; number_of_response:1; }","duration":"109.884516ms","start":"2026-06-09T22:51:57.80414Z","end":"2026-06-09T22:51:57.914024Z","steps":["trace[858167161] 'process raft request' (duration: 109.602128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:51:57.914814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.621857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:76 size:737439"} {"level":"info","ts":"2026-06-09T22:51:57.914903Z","caller":"traceutil/trace.go:171","msg":"trace[622923546] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:76; response_revision:14937; }","duration":"109.762021ms","start":"2026-06-09T22:51:57.805121Z","end":"2026-06-09T22:51:57.914883Z","steps":["trace[622923546] 'agreement among raft nodes before linearized reading' (duration: 108.918058ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:51:57.946948Z","caller":"traceutil/trace.go:171","msg":"trace[949814819] transaction","detail":"{read_only:false; response_revision:14938; number_of_response:1; }","duration":"141.041596ms","start":"2026-06-09T22:51:57.805877Z","end":"2026-06-09T22:51:57.946919Z","steps":["trace[949814819] 'process raft request' (duration: 140.687577ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:53:01.529067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12953} {"level":"info","ts":"2026-06-09T22:53:01.605212Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12953,"took":"73.512761ms","hash":984541895,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":30781440,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-09T22:53:01.605286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":984541895,"revision":12953,"compact-revision":10792} {"level":"info","ts":"2026-06-09T22:57:06.749389Z","caller":"traceutil/trace.go:171","msg":"trace[457793698] transaction","detail":"{read_only:false; response_revision:17312; number_of_response:1; }","duration":"110.697296ms","start":"2026-06-09T22:57:06.638663Z","end":"2026-06-09T22:57:06.74936Z","steps":["trace[457793698] 'process raft request' (duration: 110.508181ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:57:16.395702Z","caller":"traceutil/trace.go:171","msg":"trace[2063849426] linearizableReadLoop","detail":"{readStateIndex:17966; appliedIndex:17965; }","duration":"155.722739ms","start":"2026-06-09T22:57:16.23994Z","end":"2026-06-09T22:57:16.395662Z","steps":["trace[2063849426] 'read index received' (duration: 155.356258ms)","trace[2063849426] 'applied index is now lower than readState.Index' (duration: 364.58µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:57:16.3958Z","caller":"traceutil/trace.go:171","msg":"trace[733185297] transaction","detail":"{read_only:false; response_revision:17374; number_of_response:1; }","duration":"200.536036ms","start":"2026-06-09T22:57:16.195207Z","end":"2026-06-09T22:57:16.395743Z","steps":["trace[733185297] 'process raft request' (duration: 200.218187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:57:16.398015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.033322ms","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-06-09T22:57:16.39809Z","caller":"traceutil/trace.go:171","msg":"trace[552207382] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:17374; }","duration":"158.159046ms","start":"2026-06-09T22:57:16.239915Z","end":"2026-06-09T22:57:16.398074Z","steps":["trace[552207382] 'agreement among raft nodes before linearized reading' (duration: 155.908354ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:57:17.100164Z","caller":"traceutil/trace.go:171","msg":"trace[1114171332] transaction","detail":"{read_only:false; response_revision:17376; number_of_response:1; }","duration":"444.15384ms","start":"2026-06-09T22:57:16.655989Z","end":"2026-06-09T22:57:17.100142Z","steps":["trace[1114171332] 'process raft request' (duration: 443.995616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:57:17.100341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:57:16.655955Z","time spent":"444.275154ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20988,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:57:17.100969Z","caller":"traceutil/trace.go:171","msg":"trace[251786712] linearizableReadLoop","detail":"{readStateIndex:17968; appliedIndex:17968; }","duration":"405.335259ms","start":"2026-06-09T22:57:16.695621Z","end":"2026-06-09T22:57:17.100956Z","steps":["trace[251786712] 'read index received' (duration: 405.330558ms)","trace[251786712] 'applied index is now lower than readState.Index' (duration: 3.961µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:57:17.101194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.577345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-09T22:57:17.101231Z","caller":"traceutil/trace.go:171","msg":"trace[843846387] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:17376; }","duration":"405.677668ms","start":"2026-06-09T22:57:16.695545Z","end":"2026-06-09T22:57:17.101222Z","steps":["trace[843846387] 'agreement among raft nodes before linearized reading' (duration: 405.483683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:57:17.101262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:57:16.695514Z","time spent":"405.74036ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":179,"response size":32,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-06-09T22:57:17.129492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.106472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-nr4kg\" ","response":"range_response_count:1 size:22133"} {"level":"info","ts":"2026-06-09T22:57:17.129591Z","caller":"traceutil/trace.go:171","msg":"trace[547949194] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-nr4kg; range_end:; response_count:1; response_revision:17377; }","duration":"397.312258ms","start":"2026-06-09T22:57:16.732258Z","end":"2026-06-09T22:57:17.12957Z","steps":["trace[547949194] 'agreement among raft nodes before linearized reading' (duration: 397.090092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:57:17.129625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:57:16.732236Z","time spent":"397.38274ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":22156,"request content":"key:\"/registry/pods/openstack/nova-compute-default-nr4kg\" "} {"level":"warn","ts":"2026-06-09T22:57:17.130008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.085627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T22:57:17.130044Z","caller":"traceutil/trace.go:171","msg":"trace[1511178802] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:17377; }","duration":"232.175779ms","start":"2026-06-09T22:57:16.897857Z","end":"2026-06-09T22:57:17.130033Z","steps":["trace[1511178802] 'agreement among raft nodes before linearized reading' (duration: 231.911222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:57:17.130216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.829178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-09T22:57:17.130246Z","caller":"traceutil/trace.go:171","msg":"trace[1347778688] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17377; }","duration":"336.90932ms","start":"2026-06-09T22:57:16.793329Z","end":"2026-06-09T22:57:17.130238Z","steps":["trace[1347778688] 'agreement among raft nodes before linearized reading' (duration: 336.832688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:57:17.130264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:57:16.793303Z","time spent":"336.956981ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-09T22:58:01.535103Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15361} {"level":"info","ts":"2026-06-09T22:58:01.63455Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15361,"took":"96.125984ms","hash":3383035997,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":33488896,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-09T22:58:01.634628Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3383035997,"revision":15361,"compact-revision":12953} {"level":"info","ts":"2026-06-09T23:00:58.277504Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c9b4049ccf4190cf","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T23:00:58.284438Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-09T23:00:58.284553Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-09T23:02:38.953553Z","caller":"traceutil/trace.go:171","msg":"trace[1053777028] transaction","detail":"{read_only:false; response_revision:19988; number_of_response:1; }","duration":"121.485668ms","start":"2026-06-09T23:02:38.832025Z","end":"2026-06-09T23:02:38.953511Z","steps":["trace[1053777028] 'process raft request' (duration: 115.783571ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:02:38.953903Z","caller":"traceutil/trace.go:171","msg":"trace[563050564] transaction","detail":"{read_only:false; response_revision:19989; number_of_response:1; }","duration":"121.603971ms","start":"2026-06-09T23:02:38.832273Z","end":"2026-06-09T23:02:38.953877Z","steps":["trace[563050564] 'process raft request' (duration: 121.136408ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:02:39.127347Z","caller":"traceutil/trace.go:171","msg":"trace[1544745438] transaction","detail":"{read_only:false; response_revision:19990; number_of_response:1; }","duration":"167.9568ms","start":"2026-06-09T23:02:38.959343Z","end":"2026-06-09T23:02:39.1273Z","steps":["trace[1544745438] 'process raft request' (duration: 153.265405ms)","trace[1544745438] 'compare' (duration: 14.529151ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:02:39.846801Z","caller":"traceutil/trace.go:171","msg":"trace[523080278] linearizableReadLoop","detail":"{readStateIndex:20666; appliedIndex:20665; }","duration":"162.249833ms","start":"2026-06-09T23:02:39.684525Z","end":"2026-06-09T23:02:39.846775Z","steps":["trace[523080278] 'read index received' (duration: 162.211852ms)","trace[523080278] 'applied index is now lower than readState.Index' (duration: 36.481µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:02:39.846867Z","caller":"traceutil/trace.go:171","msg":"trace[677245389] transaction","detail":"{read_only:false; response_revision:19991; number_of_response:1; }","duration":"222.158244ms","start":"2026-06-09T23:02:39.624656Z","end":"2026-06-09T23:02:39.846815Z","steps":["trace[677245389] 'process raft request' (duration: 221.952449ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:02:39.847145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.523211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-09T23:02:39.847285Z","caller":"traceutil/trace.go:171","msg":"trace[946844827] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:19991; }","duration":"162.774268ms","start":"2026-06-09T23:02:39.684487Z","end":"2026-06-09T23:02:39.847261Z","steps":["trace[946844827] 'agreement among raft nodes before linearized reading' (duration: 162.400207ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:02:39.941521Z","caller":"traceutil/trace.go:171","msg":"trace[1448994485] transaction","detail":"{read_only:false; response_revision:19992; number_of_response:1; }","duration":"236.319194ms","start":"2026-06-09T23:02:39.705174Z","end":"2026-06-09T23:02:39.941493Z","steps":["trace[1448994485] 'process raft request' (duration: 235.498782ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:02:40.242767Z","caller":"traceutil/trace.go:171","msg":"trace[617772775] transaction","detail":"{read_only:false; response_revision:19994; number_of_response:1; }","duration":"129.576082ms","start":"2026-06-09T23:02:40.113158Z","end":"2026-06-09T23:02:40.242734Z","steps":["trace[617772775] 'process raft request' (duration: 129.414387ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:02:45.009242Z","caller":"traceutil/trace.go:171","msg":"trace[794000111] linearizableReadLoop","detail":"{readStateIndex:20693; appliedIndex:20692; }","duration":"196.101766ms","start":"2026-06-09T23:02:44.81312Z","end":"2026-06-09T23:02:45.009222Z","steps":["trace[794000111] 'read index received' (duration: 195.963852ms)","trace[794000111] 'applied index is now lower than readState.Index' (duration: 137.104µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:02:45.009359Z","caller":"traceutil/trace.go:171","msg":"trace[560929156] transaction","detail":"{read_only:false; response_revision:20017; number_of_response:1; }","duration":"216.904839ms","start":"2026-06-09T23:02:44.792429Z","end":"2026-06-09T23:02:45.009334Z","steps":["trace[560929156] 'process raft request' (duration: 216.672533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:02:45.009501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.365393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-09T23:02:45.009632Z","caller":"traceutil/trace.go:171","msg":"trace[1319260183] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20017; }","duration":"196.507357ms","start":"2026-06-09T23:02:44.813113Z","end":"2026-06-09T23:02:45.009621Z","steps":["trace[1319260183] 'agreement among raft nodes before linearized reading' (duration: 196.217499ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:03:01.547739Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17946} {"level":"info","ts":"2026-06-09T23:03:01.664023Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17946,"took":"112.020409ms","hash":3792904451,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":30048256,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-09T23:03:01.664092Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3792904451,"revision":17946,"compact-revision":15361} {"level":"warn","ts":"2026-06-09T23:06:17.544398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.475834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:06:17.544524Z","caller":"traceutil/trace.go:171","msg":"trace[167288155] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:22369; }","duration":"201.637548ms","start":"2026-06-09T23:06:17.342861Z","end":"2026-06-09T23:06:17.544498Z","steps":["trace[167288155] 'range keys from in-memory index tree' (duration: 201.228796ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:06:17.720174Z","caller":"traceutil/trace.go:171","msg":"trace[1760362086] transaction","detail":"{read_only:false; response_revision:22370; number_of_response:1; }","duration":"170.961072ms","start":"2026-06-09T23:06:17.549182Z","end":"2026-06-09T23:06:17.720143Z","steps":["trace[1760362086] 'process raft request' (duration: 170.785717ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:08:01.554278Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20106} {"level":"info","ts":"2026-06-09T23:08:01.661075Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20106,"took":"103.41108ms","hash":1279943522,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":42049536,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-06-09T23:08:01.661152Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1279943522,"revision":20106,"compact-revision":17946} {"level":"warn","ts":"2026-06-09T23:09:45.198032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.423808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-09T23:09:45.198121Z","caller":"traceutil/trace.go:171","msg":"trace[421446230] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24455; }","duration":"174.551801ms","start":"2026-06-09T23:09:45.023552Z","end":"2026-06-09T23:09:45.198103Z","steps":["trace[421446230] 'range keys from in-memory index tree' (duration: 174.253293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:45.19816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.640075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-09T23:09:45.198203Z","caller":"traceutil/trace.go:171","msg":"trace[68212919] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24455; }","duration":"104.713946ms","start":"2026-06-09T23:09:45.09348Z","end":"2026-06-09T23:09:45.198194Z","steps":["trace[68212919] 'range keys from in-memory index tree' (duration: 104.532482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:45.198192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.196324ms","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-06-09T23:09:45.198254Z","caller":"traceutil/trace.go:171","msg":"trace[2011425314] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24455; }","duration":"136.295657ms","start":"2026-06-09T23:09:45.061945Z","end":"2026-06-09T23:09:45.19824Z","steps":["trace[2011425314] 'range keys from in-memory index tree' (duration: 136.05385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:45.198382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.765318ms","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-06-09T23:09:45.198414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.953117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.202\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-09T23:09:45.198429Z","caller":"traceutil/trace.go:171","msg":"trace[321901749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24455; }","duration":"104.817689ms","start":"2026-06-09T23:09:45.093598Z","end":"2026-06-09T23:09:45.198416Z","steps":["trace[321901749] 'range keys from in-memory index tree' (duration: 104.688645ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:45.198435Z","caller":"traceutil/trace.go:171","msg":"trace[1132953850] range","detail":"{range_begin:/registry/masterleases/199.19.213.202; range_end:; response_count:1; response_revision:24455; }","duration":"131.994098ms","start":"2026-06-09T23:09:45.066434Z","end":"2026-06-09T23:09:45.198428Z","steps":["trace[1132953850] 'range keys from in-memory index tree' (duration: 131.828583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:45.198429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.210654ms","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-06-09T23:09:45.198512Z","caller":"traceutil/trace.go:171","msg":"trace[468923913] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24455; }","duration":"120.334437ms","start":"2026-06-09T23:09:45.07816Z","end":"2026-06-09T23:09:45.198495Z","steps":["trace[468923913] 'range keys from in-memory index tree' (duration: 120.050019ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:45.36139Z","caller":"traceutil/trace.go:171","msg":"trace[1574168325] transaction","detail":"{read_only:false; response_revision:24457; number_of_response:1; }","duration":"156.579946ms","start":"2026-06-09T23:09:45.204786Z","end":"2026-06-09T23:09:45.361366Z","steps":["trace[1574168325] 'process raft request' (duration: 156.499824ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:45.361555Z","caller":"traceutil/trace.go:171","msg":"trace[108293473] transaction","detail":"{read_only:false; response_revision:24456; number_of_response:1; }","duration":"156.904525ms","start":"2026-06-09T23:09:45.20464Z","end":"2026-06-09T23:09:45.361545Z","steps":["trace[108293473] 'process raft request' (duration: 156.486443ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:45.36171Z","caller":"traceutil/trace.go:171","msg":"trace[1235612675] transaction","detail":"{read_only:false; response_revision:24458; number_of_response:1; }","duration":"155.968578ms","start":"2026-06-09T23:09:45.205705Z","end":"2026-06-09T23:09:45.361674Z","steps":["trace[1235612675] 'process raft request' (duration: 155.628149ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:45.362807Z","caller":"traceutil/trace.go:171","msg":"trace[1815305691] linearizableReadLoop","detail":"{readStateIndex:25263; appliedIndex:25258; }","duration":"151.346281ms","start":"2026-06-09T23:09:45.211441Z","end":"2026-06-09T23:09:45.362787Z","steps":["trace[1815305691] 'read index received' (duration: 75.037458ms)","trace[1815305691] 'applied index is now lower than readState.Index' (duration: 76.308093ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:09:45.362889Z","caller":"traceutil/trace.go:171","msg":"trace[1441564210] transaction","detail":"{read_only:false; response_revision:24459; number_of_response:1; }","duration":"156.839303ms","start":"2026-06-09T23:09:45.206041Z","end":"2026-06-09T23:09:45.362881Z","steps":["trace[1441564210] 'process raft request' (duration: 155.597338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:45.363191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.735882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"} {"level":"info","ts":"2026-06-09T23:09:45.363226Z","caller":"traceutil/trace.go:171","msg":"trace[392340372] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:24460; }","duration":"151.789364ms","start":"2026-06-09T23:09:45.211425Z","end":"2026-06-09T23:09:45.363215Z","steps":["trace[392340372] 'agreement among raft nodes before linearized reading' (duration: 151.437164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:49.660874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.92004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:09:49.661215Z","caller":"traceutil/trace.go:171","msg":"trace[1546391199] transaction","detail":"{read_only:false; response_revision:24487; number_of_response:1; }","duration":"280.897272ms","start":"2026-06-09T23:09:49.380132Z","end":"2026-06-09T23:09:49.661029Z","steps":["trace[1546391199] 'process raft request' (duration: 162.524669ms)","trace[1546391199] 'compare' (duration: 117.462748ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:09:49.668043Z","caller":"traceutil/trace.go:171","msg":"trace[480596159] transaction","detail":"{read_only:false; response_revision:24488; number_of_response:1; }","duration":"287.549946ms","start":"2026-06-09T23:09:49.38047Z","end":"2026-06-09T23:09:49.66802Z","steps":["trace[480596159] 'process raft request' (duration: 287.376121ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:49.668539Z","caller":"traceutil/trace.go:171","msg":"trace[1256602359] transaction","detail":"{read_only:false; response_revision:24489; number_of_response:1; }","duration":"287.105274ms","start":"2026-06-09T23:09:49.381421Z","end":"2026-06-09T23:09:49.668526Z","steps":["trace[1256602359] 'process raft request' (duration: 286.552788ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:49.669479Z","caller":"traceutil/trace.go:171","msg":"trace[1001264941] transaction","detail":"{read_only:false; response_revision:24490; number_of_response:1; }","duration":"146.883998ms","start":"2026-06-09T23:09:49.522281Z","end":"2026-06-09T23:09:49.669165Z","steps":["trace[1001264941] 'process raft request' (duration: 146.733734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:49.947502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.251253ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:09:49.947658Z","caller":"traceutil/trace.go:171","msg":"trace[1026986619] transaction","detail":"{read_only:false; response_revision:24492; number_of_response:1; }","duration":"277.504909ms","start":"2026-06-09T23:09:49.670137Z","end":"2026-06-09T23:09:49.947642Z","steps":["trace[1026986619] 'process raft request' (duration: 135.951077ms)","trace[1026986619] 'compare' (duration: 140.898784ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:09:50.125161Z","caller":"traceutil/trace.go:171","msg":"trace[1908581708] transaction","detail":"{read_only:false; response_revision:24494; number_of_response:1; }","duration":"189.895994ms","start":"2026-06-09T23:09:49.935243Z","end":"2026-06-09T23:09:50.125139Z","steps":["trace[1908581708] 'process raft request' (duration: 157.544672ms)","trace[1908581708] 'compare' (duration: 32.145956ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:09:50.125202Z","caller":"traceutil/trace.go:171","msg":"trace[1561619430] linearizableReadLoop","detail":"{readStateIndex:25298; appliedIndex:25297; }","duration":"162.973912ms","start":"2026-06-09T23:09:49.962213Z","end":"2026-06-09T23:09:50.125187Z","steps":["trace[1561619430] 'read index received' (duration: 130.458436ms)","trace[1561619430] 'applied index is now lower than readState.Index' (duration: 32.514956ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:09:50.125439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.215589ms","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-06-09T23:09:50.125539Z","caller":"traceutil/trace.go:171","msg":"trace[441498631] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24495; }","duration":"163.312342ms","start":"2026-06-09T23:09:49.962193Z","end":"2026-06-09T23:09:50.125505Z","steps":["trace[441498631] 'agreement among raft nodes before linearized reading' (duration: 163.055125ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:50.276904Z","caller":"traceutil/trace.go:171","msg":"trace[1841074698] linearizableReadLoop","detail":"{readStateIndex:25300; appliedIndex:25299; }","duration":"117.504899ms","start":"2026-06-09T23:09:50.15937Z","end":"2026-06-09T23:09:50.276875Z","steps":["trace[1841074698] 'read index received' (duration: 88.086078ms)","trace[1841074698] 'applied index is now lower than readState.Index' (duration: 29.417711ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:09:50.277196Z","caller":"traceutil/trace.go:171","msg":"trace[1400762184] transaction","detail":"{read_only:false; response_revision:24496; number_of_response:1; }","duration":"146.541959ms","start":"2026-06-09T23:09:50.13064Z","end":"2026-06-09T23:09:50.277182Z","steps":["trace[1400762184] 'process raft request' (duration: 116.757019ms)","trace[1400762184] 'compare' (duration: 29.336038ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:09:50.277396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.007482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:09:50.277472Z","caller":"traceutil/trace.go:171","msg":"trace[632089290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24496; }","duration":"118.124166ms","start":"2026-06-09T23:09:50.159331Z","end":"2026-06-09T23:09:50.277455Z","steps":["trace[632089290] 'agreement among raft nodes before linearized reading' (duration: 117.997202ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:50.552319Z","caller":"traceutil/trace.go:171","msg":"trace[1417130828] transaction","detail":"{read_only:false; response_revision:24497; number_of_response:1; }","duration":"114.834535ms","start":"2026-06-09T23:09:50.437458Z","end":"2026-06-09T23:09:50.552292Z","steps":["trace[1417130828] 'process raft request' (duration: 114.684831ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:50.83865Z","caller":"traceutil/trace.go:171","msg":"trace[1127062804] linearizableReadLoop","detail":"{readStateIndex:25302; appliedIndex:25300; }","duration":"397.184157ms","start":"2026-06-09T23:09:50.441441Z","end":"2026-06-09T23:09:50.838625Z","steps":["trace[1127062804] 'read index received' (duration: 110.719581ms)","trace[1127062804] 'applied index is now lower than readState.Index' (duration: 286.460946ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:09:50.838866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.421484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-09T23:09:50.838909Z","caller":"traceutil/trace.go:171","msg":"trace[1177824586] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24498; }","duration":"398.140113ms","start":"2026-06-09T23:09:50.440747Z","end":"2026-06-09T23:09:50.838888Z","steps":["trace[1177824586] 'agreement among raft nodes before linearized reading' (duration: 397.993179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:50.838937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:09:50.44073Z","time spent":"398.200855ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-09T23:09:50.838929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.038035ms","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":"warn","ts":"2026-06-09T23:09:50.838983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.965404ms","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-06-09T23:09:50.839006Z","caller":"traceutil/trace.go:171","msg":"trace[1610763618] 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:24498; }","duration":"359.16579ms","start":"2026-06-09T23:09:50.479822Z","end":"2026-06-09T23:09:50.838987Z","steps":["trace[1610763618] 'agreement among raft nodes before linearized reading' (duration: 359.032376ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:09:50.83904Z","caller":"traceutil/trace.go:171","msg":"trace[76474179] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24498; }","duration":"158.072037ms","start":"2026-06-09T23:09:50.680956Z","end":"2026-06-09T23:09:50.839028Z","steps":["trace[76474179] 'agreement among raft nodes before linearized reading' (duration: 157.984435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:50.839056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:09:50.479801Z","time spent":"359.242241ms","remote":"127.0.0.1:48568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-06-09T23:09:50.839355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.763298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-09T23:09:50.839385Z","caller":"traceutil/trace.go:171","msg":"trace[648195055] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:24498; }","duration":"272.82178ms","start":"2026-06-09T23:09:50.566554Z","end":"2026-06-09T23:09:50.839376Z","steps":["trace[648195055] 'agreement among raft nodes before linearized reading' (duration: 272.668675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:09:51.092625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.848413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-09T23:09:51.092711Z","caller":"traceutil/trace.go:171","msg":"trace[1105851693] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24498; }","duration":"111.940716ms","start":"2026-06-09T23:09:50.980752Z","end":"2026-06-09T23:09:51.092693Z","steps":["trace[1105851693] 'range keys from in-memory index tree' (duration: 111.695939ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:01.873035Z","caller":"traceutil/trace.go:171","msg":"trace[619159546] linearizableReadLoop","detail":"{readStateIndex:25400; appliedIndex:25399; }","duration":"159.877217ms","start":"2026-06-09T23:10:01.713137Z","end":"2026-06-09T23:10:01.873014Z","steps":["trace[619159546] 'read index received' (duration: 159.739263ms)","trace[619159546] 'applied index is now lower than readState.Index' (duration: 136.844µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:01.873181Z","caller":"traceutil/trace.go:171","msg":"trace[1959261560] transaction","detail":"{read_only:false; response_revision:24593; number_of_response:1; }","duration":"163.858526ms","start":"2026-06-09T23:10:01.709282Z","end":"2026-06-09T23:10:01.87314Z","steps":["trace[1959261560] 'process raft request' (duration: 163.532937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:01.873257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.086332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T23:10:01.873291Z","caller":"traceutil/trace.go:171","msg":"trace[1454032083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24593; }","duration":"160.178355ms","start":"2026-06-09T23:10:01.713102Z","end":"2026-06-09T23:10:01.873281Z","steps":["trace[1454032083] 'agreement among raft nodes before linearized reading' (duration: 160.016781ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:01.874218Z","caller":"traceutil/trace.go:171","msg":"trace[290478643] transaction","detail":"{read_only:false; response_revision:24594; number_of_response:1; }","duration":"156.517574ms","start":"2026-06-09T23:10:01.717673Z","end":"2026-06-09T23:10:01.874191Z","steps":["trace[290478643] 'process raft request' (duration: 156.324159ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:01.874342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.336479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-09T23:10:01.874411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.797682ms","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-06-09T23:10:01.874463Z","caller":"traceutil/trace.go:171","msg":"trace[2090988054] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24594; }","duration":"156.897194ms","start":"2026-06-09T23:10:01.717552Z","end":"2026-06-09T23:10:01.874449Z","steps":["trace[2090988054] 'agreement among raft nodes before linearized reading' (duration: 156.586086ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:01.874425Z","caller":"traceutil/trace.go:171","msg":"trace[268814760] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24594; }","duration":"156.455602ms","start":"2026-06-09T23:10:01.717955Z","end":"2026-06-09T23:10:01.874411Z","steps":["trace[268814760] 'agreement among raft nodes before linearized reading' (duration: 156.234596ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:03.667688Z","caller":"traceutil/trace.go:171","msg":"trace[1612416557] transaction","detail":"{read_only:false; response_revision:24607; number_of_response:1; }","duration":"115.211866ms","start":"2026-06-09T23:10:03.552443Z","end":"2026-06-09T23:10:03.667655Z","steps":["trace[1612416557] 'process raft request' (duration: 114.119726ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:03.83405Z","caller":"traceutil/trace.go:171","msg":"trace[295423508] linearizableReadLoop","detail":"{readStateIndex:25415; appliedIndex:25414; }","duration":"113.175909ms","start":"2026-06-09T23:10:03.720851Z","end":"2026-06-09T23:10:03.834027Z","steps":["trace[295423508] 'read index received' (duration: 112.875891ms)","trace[295423508] 'applied index is now lower than readState.Index' (duration: 299.078µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:03.834346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.483168ms","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":"info","ts":"2026-06-09T23:10:03.83439Z","caller":"traceutil/trace.go:171","msg":"trace[324235825] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:24608; }","duration":"113.605991ms","start":"2026-06-09T23:10:03.720773Z","end":"2026-06-09T23:10:03.834379Z","steps":["trace[324235825] 'agreement among raft nodes before linearized reading' (duration: 113.348124ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:03.834908Z","caller":"traceutil/trace.go:171","msg":"trace[1585246119] transaction","detail":"{read_only:false; response_revision:24608; number_of_response:1; }","duration":"152.690659ms","start":"2026-06-09T23:10:03.68219Z","end":"2026-06-09T23:10:03.834881Z","steps":["trace[1585246119] 'process raft request' (duration: 151.597629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.16403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.275973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:04.164196Z","caller":"traceutil/trace.go:171","msg":"trace[797703178] transaction","detail":"{read_only:false; response_revision:24609; number_of_response:1; }","duration":"321.394259ms","start":"2026-06-09T23:10:03.842774Z","end":"2026-06-09T23:10:04.164168Z","steps":["trace[797703178] 'process raft request' (duration: 146.898019ms)","trace[797703178] 'compare' (duration: 174.15055ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:04.164292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.842754Z","time spent":"321.488341ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2720,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:04.227486Z","caller":"traceutil/trace.go:171","msg":"trace[96026924] transaction","detail":"{read_only:false; response_revision:24610; number_of_response:1; }","duration":"348.652729ms","start":"2026-06-09T23:10:03.87881Z","end":"2026-06-09T23:10:04.227462Z","steps":["trace[96026924] 'process raft request' (duration: 348.472824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.227613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.878794Z","time spent":"348.756223ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:04.227601Z","caller":"traceutil/trace.go:171","msg":"trace[1689433227] linearizableReadLoop","detail":"{readStateIndex:25418; appliedIndex:25415; }","duration":"345.824602ms","start":"2026-06-09T23:10:03.881739Z","end":"2026-06-09T23:10:04.227564Z","steps":["trace[1689433227] 'read index received' (duration: 107.947496ms)","trace[1689433227] 'applied index is now lower than readState.Index' (duration: 237.875276ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:04.227648Z","caller":"traceutil/trace.go:171","msg":"trace[1161316750] transaction","detail":"{read_only:false; response_revision:24611; number_of_response:1; }","duration":"348.736262ms","start":"2026-06-09T23:10:03.878899Z","end":"2026-06-09T23:10:04.227635Z","steps":["trace[1161316750] 'process raft request' (duration: 348.515786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.227718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.878869Z","time spent":"348.818854ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:04.22784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.079979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-09T23:10:04.227877Z","caller":"traceutil/trace.go:171","msg":"trace[1526126726] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24611; }","duration":"346.15292ms","start":"2026-06-09T23:10:03.881712Z","end":"2026-06-09T23:10:04.227865Z","steps":["trace[1526126726] 'agreement among raft nodes before linearized reading' (duration: 345.984186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.227919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.881704Z","time spent":"346.206493ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-09T23:10:04.408829Z","caller":"traceutil/trace.go:171","msg":"trace[2142899150] transaction","detail":"{read_only:false; response_revision:24612; number_of_response:1; }","duration":"411.267795ms","start":"2026-06-09T23:10:03.997538Z","end":"2026-06-09T23:10:04.408806Z","steps":["trace[2142899150] 'process raft request' (duration: 411.08468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.40903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.997515Z","time spent":"411.43561ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:04.409168Z","caller":"traceutil/trace.go:171","msg":"trace[240192055] transaction","detail":"{read_only:false; response_revision:24613; number_of_response:1; }","duration":"410.109873ms","start":"2026-06-09T23:10:03.999025Z","end":"2026-06-09T23:10:04.409135Z","steps":["trace[240192055] 'process raft request' (duration: 409.741483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.409331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.999005Z","time spent":"410.239527ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:04.409439Z","caller":"traceutil/trace.go:171","msg":"trace[699507095] transaction","detail":"{read_only:false; response_revision:24614; number_of_response:1; }","duration":"409.457355ms","start":"2026-06-09T23:10:03.99997Z","end":"2026-06-09T23:10:04.409427Z","steps":["trace[699507095] 'process raft request' (duration: 409.013993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.409509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.999956Z","time spent":"409.508887ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:04.409549Z","caller":"traceutil/trace.go:171","msg":"trace[1732021257] transaction","detail":"{read_only:false; response_revision:24615; number_of_response:1; }","duration":"247.620055ms","start":"2026-06-09T23:10:04.161902Z","end":"2026-06-09T23:10:04.409522Z","steps":["trace[1732021257] 'process raft request' (duration: 247.43145ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:04.410096Z","caller":"traceutil/trace.go:171","msg":"trace[1302164281] linearizableReadLoop","detail":"{readStateIndex:25422; appliedIndex:25418; }","duration":"182.383777ms","start":"2026-06-09T23:10:04.227668Z","end":"2026-06-09T23:10:04.410052Z","steps":["trace[1302164281] 'read index received' (duration: 181.007869ms)","trace[1302164281] 'applied index is now lower than readState.Index' (duration: 1.372848ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:04.410155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.803607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:04.410195Z","caller":"traceutil/trace.go:171","msg":"trace[1124688457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24615; }","duration":"248.872529ms","start":"2026-06-09T23:10:04.161313Z","end":"2026-06-09T23:10:04.410185Z","steps":["trace[1124688457] 'agreement among raft nodes before linearized reading' (duration: 248.791137ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.410247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.260717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-09T23:10:04.410277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.804368ms","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-06-09T23:10:04.410355Z","caller":"traceutil/trace.go:171","msg":"trace[708008902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24615; }","duration":"523.89646ms","start":"2026-06-09T23:10:03.886447Z","end":"2026-06-09T23:10:04.410344Z","steps":["trace[708008902] 'agreement among raft nodes before linearized reading' (duration: 523.699154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.410389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.886441Z","time spent":"523.940911ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T23:10:04.410295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.616804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T23:10:04.410446Z","caller":"traceutil/trace.go:171","msg":"trace[990729021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24615; }","duration":"526.782689ms","start":"2026-06-09T23:10:03.883656Z","end":"2026-06-09T23:10:04.410439Z","steps":["trace[990729021] 'agreement among raft nodes before linearized reading' (duration: 526.533672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.410472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:03.88365Z","time spent":"526.81451ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-09T23:10:04.410308Z","caller":"traceutil/trace.go:171","msg":"trace[327890540] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:0; response_revision:24615; }","duration":"242.36592ms","start":"2026-06-09T23:10:04.167929Z","end":"2026-06-09T23:10:04.410295Z","steps":["trace[327890540] 'agreement among raft nodes before linearized reading' (duration: 242.241007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.726358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.083694ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:04.7265Z","caller":"traceutil/trace.go:171","msg":"trace[1915810167] transaction","detail":"{read_only:false; response_revision:24616; number_of_response:1; }","duration":"492.220157ms","start":"2026-06-09T23:10:04.234253Z","end":"2026-06-09T23:10:04.726473Z","steps":["trace[1915810167] 'process raft request' (duration: 340.959788ms)","trace[1915810167] 'compare' (duration: 150.758025ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:04.726553Z","caller":"traceutil/trace.go:171","msg":"trace[2077100171] linearizableReadLoop","detail":"{readStateIndex:25423; appliedIndex:25422; }","duration":"316.38076ms","start":"2026-06-09T23:10:04.410159Z","end":"2026-06-09T23:10:04.726539Z","steps":["trace[2077100171] 'read index received' (duration: 165.129931ms)","trace[2077100171] 'applied index is now lower than readState.Index' (duration: 151.249839ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:04.726614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:04.234228Z","time spent":"492.318869ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:04.726716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.121534ms","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-06-09T23:10:04.726737Z","caller":"traceutil/trace.go:171","msg":"trace[273491794] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24617; }","duration":"385.170676ms","start":"2026-06-09T23:10:04.341558Z","end":"2026-06-09T23:10:04.726729Z","steps":["trace[273491794] 'agreement among raft nodes before linearized reading' (duration: 385.047153ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.726763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:04.34154Z","time spent":"385.216347ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-09T23:10:04.726791Z","caller":"traceutil/trace.go:171","msg":"trace[967667929] transaction","detail":"{read_only:false; response_revision:24619; number_of_response:1; }","duration":"312.562045ms","start":"2026-06-09T23:10:04.414206Z","end":"2026-06-09T23:10:04.726768Z","steps":["trace[967667929] 'process raft request' (duration: 312.517304ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:04.726938Z","caller":"traceutil/trace.go:171","msg":"trace[797090707] transaction","detail":"{read_only:false; response_revision:24617; number_of_response:1; }","duration":"313.690966ms","start":"2026-06-09T23:10:04.413238Z","end":"2026-06-09T23:10:04.726929Z","steps":["trace[797090707] 'process raft request' (duration: 313.192163ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.726982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:04.413223Z","time spent":"313.739487ms","remote":"127.0.0.1:43402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1240,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T23:10:04.727001Z","caller":"traceutil/trace.go:171","msg":"trace[591873927] transaction","detail":"{read_only:false; response_revision:24618; number_of_response:1; }","duration":"312.799951ms","start":"2026-06-09T23:10:04.414191Z","end":"2026-06-09T23:10:04.726991Z","steps":["trace[591873927] 'process raft request' (duration: 312.457692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.727046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:04.414168Z","time spent":"312.854953ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:04.726929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:04.414185Z","time spent":"312.679718ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:04.75059Z","caller":"traceutil/trace.go:171","msg":"trace[781667032] transaction","detail":"{read_only:false; response_revision:24620; number_of_response:1; }","duration":"144.599015ms","start":"2026-06-09T23:10:04.605972Z","end":"2026-06-09T23:10:04.750572Z","steps":["trace[781667032] 'process raft request' (duration: 144.498282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.751394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.75807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:04.751458Z","caller":"traceutil/trace.go:171","msg":"trace[1586649604] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/ports/; range_end:/registry/openstack.k-orc.cloud/ports0; response_count:0; response_revision:24620; }","duration":"312.871043ms","start":"2026-06-09T23:10:04.438571Z","end":"2026-06-09T23:10:04.751442Z","steps":["trace[1586649604] 'agreement among raft nodes before linearized reading' (duration: 312.74198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.7515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:04.438555Z","time spent":"312.934885ms","remote":"127.0.0.1:44590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/ports/\" range_end:\"/registry/openstack.k-orc.cloud/ports0\" count_only:true "} {"level":"warn","ts":"2026-06-09T23:10:04.751733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.703231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:04.751764Z","caller":"traceutil/trace.go:171","msg":"trace[399713218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24620; }","duration":"340.733322ms","start":"2026-06-09T23:10:04.411021Z","end":"2026-06-09T23:10:04.751754Z","steps":["trace[399713218] 'agreement among raft nodes before linearized reading' (duration: 340.67657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.751792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:04.410967Z","time spent":"340.817224ms","remote":"127.0.0.1:43214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T23:10:04.909169Z","caller":"traceutil/trace.go:171","msg":"trace[802621250] transaction","detail":"{read_only:false; response_revision:24624; number_of_response:1; }","duration":"177.292267ms","start":"2026-06-09T23:10:04.731853Z","end":"2026-06-09T23:10:04.909145Z","steps":["trace[802621250] 'process raft request' (duration: 177.236225ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:04.909274Z","caller":"traceutil/trace.go:171","msg":"trace[660391084] transaction","detail":"{read_only:false; response_revision:24621; number_of_response:1; }","duration":"179.015854ms","start":"2026-06-09T23:10:04.730214Z","end":"2026-06-09T23:10:04.90923Z","steps":["trace[660391084] 'process raft request' (duration: 178.51783ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:04.90935Z","caller":"traceutil/trace.go:171","msg":"trace[1258980597] transaction","detail":"{read_only:false; response_revision:24622; number_of_response:1; }","duration":"178.924561ms","start":"2026-06-09T23:10:04.730418Z","end":"2026-06-09T23:10:04.909342Z","steps":["trace[1258980597] 'process raft request' (duration: 178.565751ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:04.909374Z","caller":"traceutil/trace.go:171","msg":"trace[1791442190] linearizableReadLoop","detail":"{readStateIndex:25431; appliedIndex:25431; }","duration":"158.073737ms","start":"2026-06-09T23:10:04.751283Z","end":"2026-06-09T23:10:04.909356Z","steps":["trace[1791442190] 'read index received' (duration: 158.067167ms)","trace[1791442190] 'applied index is now lower than readState.Index' (duration: 5.68µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:04.909542Z","caller":"traceutil/trace.go:171","msg":"trace[640504761] transaction","detail":"{read_only:false; response_revision:24623; number_of_response:1; }","duration":"179.013385ms","start":"2026-06-09T23:10:04.730521Z","end":"2026-06-09T23:10:04.909535Z","steps":["trace[640504761] 'process raft request' (duration: 178.531511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:04.909615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.119107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:125149"} {"level":"info","ts":"2026-06-09T23:10:04.90965Z","caller":"traceutil/trace.go:171","msg":"trace[871631893] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:24624; }","duration":"179.203529ms","start":"2026-06-09T23:10:04.730435Z","end":"2026-06-09T23:10:04.909639Z","steps":["trace[871631893] 'agreement among raft nodes before linearized reading' (duration: 178.980983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.136689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.288585ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:05.136837Z","caller":"traceutil/trace.go:171","msg":"trace[813302053] transaction","detail":"{read_only:false; response_revision:24626; number_of_response:1; }","duration":"224.430036ms","start":"2026-06-09T23:10:04.912376Z","end":"2026-06-09T23:10:05.136806Z","steps":["trace[813302053] 'process raft request' (duration: 107.945335ms)","trace[813302053] 'compare' (duration: 116.122771ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:05.38525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.325117ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-06-09T23:10:05.478471Z","caller":"traceutil/trace.go:171","msg":"trace[432382066] linearizableReadLoop","detail":"{readStateIndex:25435; appliedIndex:25433; }","duration":"317.015458ms","start":"2026-06-09T23:10:05.161433Z","end":"2026-06-09T23:10:05.478449Z","steps":["trace[432382066] 'read index received' (duration: 95.465902ms)","trace[432382066] 'applied index is now lower than readState.Index' (duration: 221.548686ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:05.478588Z","caller":"traceutil/trace.go:171","msg":"trace[1995922622] transaction","detail":"{read_only:false; response_revision:24627; number_of_response:1; }","duration":"339.785785ms","start":"2026-06-09T23:10:05.138788Z","end":"2026-06-09T23:10:05.478573Z","steps":["trace[1995922622] 'process raft request' (duration: 339.516848ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.478669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:05.138768Z","time spent":"339.845156ms","remote":"127.0.0.1:43402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T23:10:05.478802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.344377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:05.478875Z","caller":"traceutil/trace.go:171","msg":"trace[741024083] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24627; }","duration":"317.46918ms","start":"2026-06-09T23:10:05.161387Z","end":"2026-06-09T23:10:05.478856Z","steps":["trace[741024083] 'agreement among raft nodes before linearized reading' (duration: 317.222193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.478919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:05.16137Z","time spent":"317.541233ms","remote":"127.0.0.1:43206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-09T23:10:05.533269Z","caller":"traceutil/trace.go:171","msg":"trace[403211237] transaction","detail":"{read_only:false; response_revision:24628; number_of_response:1; }","duration":"146.662782ms","start":"2026-06-09T23:10:05.386573Z","end":"2026-06-09T23:10:05.533236Z","steps":["trace[403211237] 'process raft request' (duration: 144.193874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.533394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.412574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-09T23:10:05.533467Z","caller":"traceutil/trace.go:171","msg":"trace[1286099394] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24628; }","duration":"364.526517ms","start":"2026-06-09T23:10:05.168924Z","end":"2026-06-09T23:10:05.53345Z","steps":["trace[1286099394] 'agreement among raft nodes before linearized reading' (duration: 364.301271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.533506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:05.168893Z","time spent":"364.604799ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-09T23:10:05.714211Z","caller":"traceutil/trace.go:171","msg":"trace[709849578] linearizableReadLoop","detail":"{readStateIndex:25441; appliedIndex:25440; }","duration":"148.053451ms","start":"2026-06-09T23:10:05.566137Z","end":"2026-06-09T23:10:05.71419Z","steps":["trace[709849578] 'read index received' (duration: 130.039874ms)","trace[709849578] 'applied index is now lower than readState.Index' (duration: 18.012917ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:05.714278Z","caller":"traceutil/trace.go:171","msg":"trace[259750376] transaction","detail":"{read_only:false; response_revision:24633; number_of_response:1; }","duration":"177.188773ms","start":"2026-06-09T23:10:05.537062Z","end":"2026-06-09T23:10:05.714251Z","steps":["trace[259750376] 'process raft request' (duration: 159.102315ms)","trace[259750376] 'compare' (duration: 17.930584ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:05.714425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.459936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:423"} {"level":"info","ts":"2026-06-09T23:10:05.714486Z","caller":"traceutil/trace.go:171","msg":"trace[155308212] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:24633; }","duration":"179.568229ms","start":"2026-06-09T23:10:05.534904Z","end":"2026-06-09T23:10:05.714472Z","steps":["trace[155308212] 'agreement among raft nodes before linearized reading' (duration: 179.365234ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:05.967843Z","caller":"traceutil/trace.go:171","msg":"trace[1122077794] transaction","detail":"{read_only:false; response_revision:24634; number_of_response:1; }","duration":"396.603031ms","start":"2026-06-09T23:10:05.571211Z","end":"2026-06-09T23:10:05.967814Z","steps":["trace[1122077794] 'process raft request' (duration: 335.849206ms)","trace[1122077794] 'compare' (duration: 60.502698ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:05.967871Z","caller":"traceutil/trace.go:171","msg":"trace[611019527] linearizableReadLoop","detail":"{readStateIndex:25444; appliedIndex:25441; }","duration":"253.576849ms","start":"2026-06-09T23:10:05.714271Z","end":"2026-06-09T23:10:05.967848Z","steps":["trace[611019527] 'read index received' (duration: 192.744522ms)","trace[611019527] 'applied index is now lower than readState.Index' (duration: 60.831347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:05.96796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:05.571195Z","time spent":"396.708544ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1137,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T23:10:05.96813Z","caller":"traceutil/trace.go:171","msg":"trace[174709937] transaction","detail":"{read_only:false; response_revision:24635; number_of_response:1; }","duration":"396.260272ms","start":"2026-06-09T23:10:05.571851Z","end":"2026-06-09T23:10:05.968111Z","steps":["trace[174709937] 'process raft request' (duration: 395.856691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.968267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:05.571841Z","time spent":"396.341474ms","remote":"127.0.0.1:43282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T23:10:05.968339Z","caller":"traceutil/trace.go:171","msg":"trace[1528664086] transaction","detail":"{read_only:false; response_revision:24636; number_of_response:1; }","duration":"396.341864ms","start":"2026-06-09T23:10:05.571987Z","end":"2026-06-09T23:10:05.968329Z","steps":["trace[1528664086] 'process raft request' (duration: 395.795369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.968392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:05.571979Z","time spent":"396.379005ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:05.968492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.429755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"} {"level":"info","ts":"2026-06-09T23:10:05.968557Z","caller":"traceutil/trace.go:171","msg":"trace[446706405] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:24636; }","duration":"397.548177ms","start":"2026-06-09T23:10:05.570995Z","end":"2026-06-09T23:10:05.968543Z","steps":["trace[446706405] 'agreement among raft nodes before linearized reading' (duration: 397.30838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.968587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:05.570975Z","time spent":"397.606259ms","remote":"127.0.0.1:43574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1148,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"warn","ts":"2026-06-09T23:10:05.96859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.508717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1125"} {"level":"warn","ts":"2026-06-09T23:10:05.968618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.422098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-09T23:10:05.968652Z","caller":"traceutil/trace.go:171","msg":"trace[2076521858] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:24636; }","duration":"397.591179ms","start":"2026-06-09T23:10:05.571043Z","end":"2026-06-09T23:10:05.968634Z","steps":["trace[2076521858] 'agreement among raft nodes before linearized reading' (duration: 397.354532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:05.968713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:05.571038Z","time spent":"397.66177ms","remote":"127.0.0.1:43574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1148,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"warn","ts":"2026-06-09T23:10:05.96875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.688886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"} {"level":"info","ts":"2026-06-09T23:10:05.968668Z","caller":"traceutil/trace.go:171","msg":"trace[1634154730] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:24636; }","duration":"252.478659ms","start":"2026-06-09T23:10:05.716179Z","end":"2026-06-09T23:10:05.968658Z","steps":["trace[1634154730] 'agreement among raft nodes before linearized reading' (duration: 252.347216ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:05.968791Z","caller":"traceutil/trace.go:171","msg":"trace[674589885] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24636; }","duration":"235.725298ms","start":"2026-06-09T23:10:05.733054Z","end":"2026-06-09T23:10:05.968779Z","steps":["trace[674589885] 'agreement among raft nodes before linearized reading' (duration: 235.646235ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:06.118951Z","caller":"traceutil/trace.go:171","msg":"trace[298008145] linearizableReadLoop","detail":"{readStateIndex:25446; appliedIndex:25445; }","duration":"138.010034ms","start":"2026-06-09T23:10:05.980921Z","end":"2026-06-09T23:10:06.118931Z","steps":["trace[298008145] 'read index received' (duration: 10.475189ms)","trace[298008145] 'applied index is now lower than readState.Index' (duration: 127.534065ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:06.119112Z","caller":"traceutil/trace.go:171","msg":"trace[945638794] transaction","detail":"{read_only:false; response_revision:24638; number_of_response:1; }","duration":"143.020912ms","start":"2026-06-09T23:10:05.976084Z","end":"2026-06-09T23:10:06.119105Z","steps":["trace[945638794] 'process raft request' (duration: 140.952965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.119416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.055835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-09T23:10:06.119448Z","caller":"traceutil/trace.go:171","msg":"trace[1831476419] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:24638; }","duration":"138.112557ms","start":"2026-06-09T23:10:05.981329Z","end":"2026-06-09T23:10:06.119441Z","steps":["trace[1831476419] 'agreement among raft nodes before linearized reading' (duration: 137.996164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.119422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.475507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1344"} {"level":"info","ts":"2026-06-09T23:10:06.119507Z","caller":"traceutil/trace.go:171","msg":"trace[1134670329] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:24638; }","duration":"138.59391ms","start":"2026-06-09T23:10:05.980882Z","end":"2026-06-09T23:10:06.119476Z","steps":["trace[1134670329] 'agreement among raft nodes before linearized reading' (duration: 138.358864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.603189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.322759ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:06.603578Z","caller":"traceutil/trace.go:171","msg":"trace[288972948] transaction","detail":"{read_only:false; response_revision:24642; number_of_response:1; }","duration":"376.044193ms","start":"2026-06-09T23:10:06.227507Z","end":"2026-06-09T23:10:06.603551Z","steps":["trace[288972948] 'process raft request' (duration: 248.287282ms)","trace[288972948] 'compare' (duration: 126.918378ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:06.603682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:06.227499Z","time spent":"376.136936ms","remote":"127.0.0.1:43282","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":732,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T23:10:06.603737Z","caller":"traceutil/trace.go:171","msg":"trace[758427407] transaction","detail":"{read_only:false; response_revision:24643; number_of_response:1; }","duration":"371.18348ms","start":"2026-06-09T23:10:06.232525Z","end":"2026-06-09T23:10:06.603708Z","steps":["trace[758427407] 'process raft request' (duration: 370.85153ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:06.603751Z","caller":"traceutil/trace.go:171","msg":"trace[578418966] transaction","detail":"{read_only:false; response_revision:24644; number_of_response:1; }","duration":"369.589396ms","start":"2026-06-09T23:10:06.23413Z","end":"2026-06-09T23:10:06.603719Z","steps":["trace[578418966] 'process raft request' (duration: 369.400091ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:06.603819Z","caller":"traceutil/trace.go:171","msg":"trace[1232582095] linearizableReadLoop","detail":"{readStateIndex:25450; appliedIndex:25448; }","duration":"373.265097ms","start":"2026-06-09T23:10:06.230528Z","end":"2026-06-09T23:10:06.603793Z","steps":["trace[1232582095] 'read index received' (duration: 57.938486ms)","trace[1232582095] 'applied index is now lower than readState.Index' (duration: 315.323911ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:06.603879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:06.232506Z","time spent":"371.297382ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:06.603903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:06.234114Z","time spent":"369.704099ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:06.603967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.433511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-09T23:10:06.604Z","caller":"traceutil/trace.go:171","msg":"trace[1009464943] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24644; }","duration":"373.491533ms","start":"2026-06-09T23:10:06.230501Z","end":"2026-06-09T23:10:06.603992Z","steps":["trace[1009464943] 'agreement among raft nodes before linearized reading' (duration: 373.36887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.60402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:06.23049Z","time spent":"373.526334ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-09T23:10:06.604573Z","caller":"traceutil/trace.go:171","msg":"trace[60067247] transaction","detail":"{read_only:false; response_revision:24645; number_of_response:1; }","duration":"188.177697ms","start":"2026-06-09T23:10:06.416382Z","end":"2026-06-09T23:10:06.60456Z","steps":["trace[60067247] 'process raft request' (duration: 187.20163ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:06.604666Z","caller":"traceutil/trace.go:171","msg":"trace[513549057] transaction","detail":"{read_only:false; response_revision:24646; number_of_response:1; }","duration":"187.881698ms","start":"2026-06-09T23:10:06.416759Z","end":"2026-06-09T23:10:06.604641Z","steps":["trace[513549057] 'process raft request' (duration: 187.58705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.604926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.088595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:06.605034Z","caller":"traceutil/trace.go:171","msg":"trace[2040989723] transaction","detail":"{read_only:false; response_revision:24647; number_of_response:1; }","duration":"187.893289ms","start":"2026-06-09T23:10:06.417121Z","end":"2026-06-09T23:10:06.605014Z","steps":["trace[2040989723] 'process raft request' (duration: 187.298902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.605051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.966781ms","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-06-09T23:10:06.605081Z","caller":"traceutil/trace.go:171","msg":"trace[1871793760] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:24647; }","duration":"270.052053ms","start":"2026-06-09T23:10:06.335021Z","end":"2026-06-09T23:10:06.605073Z","steps":["trace[1871793760] 'agreement among raft nodes before linearized reading' (duration: 269.93385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.605904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.309946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:98 size:80429"} {"level":"info","ts":"2026-06-09T23:10:06.605989Z","caller":"traceutil/trace.go:171","msg":"trace[2121001014] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:98; response_revision:24647; }","duration":"313.426649ms","start":"2026-06-09T23:10:06.292534Z","end":"2026-06-09T23:10:06.60596Z","steps":["trace[2121001014] 'agreement among raft nodes before linearized reading' (duration: 312.535634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.606049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:06.292524Z","time spent":"313.509111ms","remote":"127.0.0.1:43552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":98,"response size":80452,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"warn","ts":"2026-06-09T23:10:06.609394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.832807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224964"} {"level":"info","ts":"2026-06-09T23:10:06.609469Z","caller":"traceutil/trace.go:171","msg":"trace[1338452213] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:24647; }","duration":"351.910459ms","start":"2026-06-09T23:10:06.257545Z","end":"2026-06-09T23:10:06.609456Z","steps":["trace[1338452213] 'agreement among raft nodes before linearized reading' (duration: 347.640371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.609524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:06.25749Z","time spent":"352.023213ms","remote":"127.0.0.1:43316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":57,"response size":2224987,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-06-09T23:10:06.605045Z","caller":"traceutil/trace.go:171","msg":"trace[311005853] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:24647; }","duration":"368.248809ms","start":"2026-06-09T23:10:06.236777Z","end":"2026-06-09T23:10:06.605026Z","steps":["trace[311005853] 'agreement among raft nodes before linearized reading' (duration: 368.106755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.617077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:06.236746Z","time spent":"380.315471ms","remote":"127.0.0.1:43302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":29,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" "} {"level":"info","ts":"2026-06-09T23:10:06.837047Z","caller":"traceutil/trace.go:171","msg":"trace[194344807] linearizableReadLoop","detail":"{readStateIndex:25457; appliedIndex:25456; }","duration":"204.732723ms","start":"2026-06-09T23:10:06.632294Z","end":"2026-06-09T23:10:06.837026Z","steps":["trace[194344807] 'read index received' (duration: 204.643141ms)","trace[194344807] 'applied index is now lower than readState.Index' (duration: 88.172µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:06.837245Z","caller":"traceutil/trace.go:171","msg":"trace[2004255763] transaction","detail":"{read_only:false; response_revision:24649; number_of_response:1; }","duration":"207.852709ms","start":"2026-06-09T23:10:06.629376Z","end":"2026-06-09T23:10:06.837229Z","steps":["trace[2004255763] 'process raft request' (duration: 207.5214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.837846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.649783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1826"} {"level":"info","ts":"2026-06-09T23:10:06.837894Z","caller":"traceutil/trace.go:171","msg":"trace[1683120508] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:24650; }","duration":"199.723995ms","start":"2026-06-09T23:10:06.638157Z","end":"2026-06-09T23:10:06.837881Z","steps":["trace[1683120508] 'agreement among raft nodes before linearized reading' (duration: 199.603541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.838043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.157095ms","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-06-09T23:10:06.838113Z","caller":"traceutil/trace.go:171","msg":"trace[1804836078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24650; }","duration":"106.242808ms","start":"2026-06-09T23:10:06.731855Z","end":"2026-06-09T23:10:06.838098Z","steps":["trace[1804836078] 'agreement among raft nodes before linearized reading' (duration: 106.091374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.838163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.979788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T23:10:06.838203Z","caller":"traceutil/trace.go:171","msg":"trace[1116346065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24650; }","duration":"107.04379ms","start":"2026-06-09T23:10:06.731146Z","end":"2026-06-09T23:10:06.838189Z","steps":["trace[1116346065] 'agreement among raft nodes before linearized reading' (duration: 106.971248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.838267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.437413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-06-09T23:10:06.838292Z","caller":"traceutil/trace.go:171","msg":"trace[272500839] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:24649; }","duration":"206.009738ms","start":"2026-06-09T23:10:06.632275Z","end":"2026-06-09T23:10:06.838285Z","steps":["trace[272500839] 'agreement among raft nodes before linearized reading' (duration: 205.142104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:06.83807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.059028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-09T23:10:06.838356Z","caller":"traceutil/trace.go:171","msg":"trace[2022531325] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24650; }","duration":"108.359946ms","start":"2026-06-09T23:10:06.729974Z","end":"2026-06-09T23:10:06.838334Z","steps":["trace[2022531325] 'agreement among raft nodes before linearized reading' (duration: 108.014807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:08.268629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.135049ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:08.268797Z","caller":"traceutil/trace.go:171","msg":"trace[436987545] transaction","detail":"{read_only:false; response_revision:24699; number_of_response:1; }","duration":"286.510537ms","start":"2026-06-09T23:10:07.982257Z","end":"2026-06-09T23:10:08.268768Z","steps":["trace[436987545] 'process raft request' (duration: 127.971627ms)","trace[436987545] 'compare' (duration: 158.040586ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:08.268823Z","caller":"traceutil/trace.go:171","msg":"trace[477704959] linearizableReadLoop","detail":"{readStateIndex:25507; appliedIndex:25506; }","duration":"286.433695ms","start":"2026-06-09T23:10:07.982298Z","end":"2026-06-09T23:10:08.268732Z","steps":["trace[477704959] 'read index received' (duration: 127.881795ms)","trace[477704959] 'applied index is now lower than readState.Index' (duration: 158.55001ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:08.269126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.800645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-769dc933-fe13-4da5-9cb6-7cebd2ba3ab0\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-09T23:10:08.26925Z","caller":"traceutil/trace.go:171","msg":"trace[1403599187] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-769dc933-fe13-4da5-9cb6-7cebd2ba3ab0; range_end:; response_count:1; response_revision:24699; }","duration":"286.9581ms","start":"2026-06-09T23:10:07.982268Z","end":"2026-06-09T23:10:08.269226Z","steps":["trace[1403599187] 'agreement among raft nodes before linearized reading' (duration: 286.671412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:08.269278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.896762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:08.269601Z","caller":"traceutil/trace.go:171","msg":"trace[1506016260] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24699; }","duration":"101.262992ms","start":"2026-06-09T23:10:08.168323Z","end":"2026-06-09T23:10:08.269586Z","steps":["trace[1506016260] 'agreement among raft nodes before linearized reading' (duration: 100.808709ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:14.426982Z","caller":"traceutil/trace.go:171","msg":"trace[216673524] transaction","detail":"{read_only:false; response_revision:24775; number_of_response:1; }","duration":"118.64801ms","start":"2026-06-09T23:10:14.30831Z","end":"2026-06-09T23:10:14.426958Z","steps":["trace[216673524] 'process raft request' (duration: 118.508906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:14.714308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.661173ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:14.714484Z","caller":"traceutil/trace.go:171","msg":"trace[61127021] linearizableReadLoop","detail":"{readStateIndex:25587; appliedIndex:25585; }","duration":"260.441298ms","start":"2026-06-09T23:10:14.454025Z","end":"2026-06-09T23:10:14.714466Z","steps":["trace[61127021] 'read index received' (duration: 105.539659ms)","trace[61127021] 'applied index is now lower than readState.Index' (duration: 154.900569ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:14.714492Z","caller":"traceutil/trace.go:171","msg":"trace[521253691] transaction","detail":"{read_only:false; response_revision:24776; number_of_response:1; }","duration":"292.43026ms","start":"2026-06-09T23:10:14.42204Z","end":"2026-06-09T23:10:14.714471Z","steps":["trace[521253691] 'process raft request' (duration: 137.527301ms)","trace[521253691] 'compare' (duration: 154.536169ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:14.714638Z","caller":"traceutil/trace.go:171","msg":"trace[706159281] transaction","detail":"{read_only:false; response_revision:24777; number_of_response:1; }","duration":"273.027625ms","start":"2026-06-09T23:10:14.4416Z","end":"2026-06-09T23:10:14.714628Z","steps":["trace[706159281] 'process raft request' (duration: 272.812809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:14.714793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.754577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10359"} {"level":"info","ts":"2026-06-09T23:10:14.714816Z","caller":"traceutil/trace.go:171","msg":"trace[890920635] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24777; }","duration":"260.790358ms","start":"2026-06-09T23:10:14.45402Z","end":"2026-06-09T23:10:14.71481Z","steps":["trace[890920635] 'agreement among raft nodes before linearized reading' (duration: 260.688306ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:14.746549Z","caller":"traceutil/trace.go:171","msg":"trace[726451688] transaction","detail":"{read_only:false; response_revision:24781; number_of_response:1; }","duration":"104.977623ms","start":"2026-06-09T23:10:14.641528Z","end":"2026-06-09T23:10:14.746505Z","steps":["trace[726451688] 'process raft request' (duration: 104.901401ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:14.746722Z","caller":"traceutil/trace.go:171","msg":"trace[1440888885] transaction","detail":"{read_only:false; response_revision:24780; number_of_response:1; }","duration":"109.19829ms","start":"2026-06-09T23:10:14.637513Z","end":"2026-06-09T23:10:14.746711Z","steps":["trace[1440888885] 'process raft request' (duration: 108.807519ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:14.746775Z","caller":"traceutil/trace.go:171","msg":"trace[1632338205] transaction","detail":"{read_only:false; response_revision:24782; number_of_response:1; }","duration":"103.915294ms","start":"2026-06-09T23:10:14.642837Z","end":"2026-06-09T23:10:14.746753Z","steps":["trace[1632338205] 'process raft request' (duration: 103.616186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:14.746684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.121434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-09T23:10:14.746828Z","caller":"traceutil/trace.go:171","msg":"trace[868888967] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24782; }","duration":"254.3142ms","start":"2026-06-09T23:10:14.492498Z","end":"2026-06-09T23:10:14.746812Z","steps":["trace[868888967] 'agreement among raft nodes before linearized reading' (duration: 253.98132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:18.271842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10434733333872016006,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T23:10:18.337432Z","caller":"traceutil/trace.go:171","msg":"trace[473483173] linearizableReadLoop","detail":"{readStateIndex:25624; appliedIndex:25623; }","duration":"566.464553ms","start":"2026-06-09T23:10:17.770935Z","end":"2026-06-09T23:10:18.337399Z","steps":["trace[473483173] 'read index received' (duration: 566.079072ms)","trace[473483173] 'applied index is now lower than readState.Index' (duration: 383.731µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:18.337586Z","caller":"traceutil/trace.go:171","msg":"trace[630128425] transaction","detail":"{read_only:false; response_revision:24813; number_of_response:1; }","duration":"606.668741ms","start":"2026-06-09T23:10:17.730888Z","end":"2026-06-09T23:10:18.337557Z","steps":["trace[630128425] 'process raft request' (duration: 606.326942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:18.33784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:17.730861Z","time spent":"606.790855ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:18.337929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.978607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-06-09T23:10:18.337969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.624348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:18.337991Z","caller":"traceutil/trace.go:171","msg":"trace[939311929] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24813; }","duration":"567.08768ms","start":"2026-06-09T23:10:17.770886Z","end":"2026-06-09T23:10:18.337974Z","steps":["trace[939311929] 'agreement among raft nodes before linearized reading' (duration: 566.796182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:18.338039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:17.770869Z","time spent":"567.161572ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-09T23:10:18.338039Z","caller":"traceutil/trace.go:171","msg":"trace[802988191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24813; }","duration":"176.730411ms","start":"2026-06-09T23:10:18.161291Z","end":"2026-06-09T23:10:18.338022Z","steps":["trace[802988191] 'agreement among raft nodes before linearized reading' (duration: 176.615118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:18.612483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.554609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:18.612621Z","caller":"traceutil/trace.go:171","msg":"trace[349895439] linearizableReadLoop","detail":"{readStateIndex:25625; appliedIndex:25624; }","duration":"169.185823ms","start":"2026-06-09T23:10:18.443412Z","end":"2026-06-09T23:10:18.612597Z","steps":["trace[349895439] 'read index received' (duration: 67.310755ms)","trace[349895439] 'applied index is now lower than readState.Index' (duration: 101.873158ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:18.61266Z","caller":"traceutil/trace.go:171","msg":"trace[1721945444] transaction","detail":"{read_only:false; response_revision:24814; number_of_response:1; }","duration":"269.322423ms","start":"2026-06-09T23:10:18.34331Z","end":"2026-06-09T23:10:18.612632Z","steps":["trace[1721945444] 'process raft request' (duration: 167.495206ms)","trace[1721945444] 'compare' (duration: 101.245101ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:18.612832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.43592ms","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-06-09T23:10:18.6129Z","caller":"traceutil/trace.go:171","msg":"trace[675570282] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24814; }","duration":"169.546423ms","start":"2026-06-09T23:10:18.443337Z","end":"2026-06-09T23:10:18.612884Z","steps":["trace[675570282] 'agreement among raft nodes before linearized reading' (duration: 169.332197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:47.353108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.531693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:47.353559Z","caller":"traceutil/trace.go:171","msg":"trace[676635282] linearizableReadLoop","detail":"{readStateIndex:25864; appliedIndex:25863; }","duration":"277.590181ms","start":"2026-06-09T23:10:47.075951Z","end":"2026-06-09T23:10:47.353541Z","steps":["trace[676635282] 'read index received' (duration: 144.494063ms)","trace[676635282] 'applied index is now lower than readState.Index' (duration: 133.094838ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:47.353603Z","caller":"traceutil/trace.go:171","msg":"trace[392134460] transaction","detail":"{read_only:false; response_revision:25046; number_of_response:1; }","duration":"308.73759ms","start":"2026-06-09T23:10:47.044824Z","end":"2026-06-09T23:10:47.353561Z","steps":["trace[392134460] 'process raft request' (duration: 175.60349ms)","trace[392134460] 'compare' (duration: 132.402549ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:47.353725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.766086ms","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-06-09T23:10:47.353745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.792399ms","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-06-09T23:10:47.353766Z","caller":"traceutil/trace.go:171","msg":"trace[496133840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25046; }","duration":"314.821297ms","start":"2026-06-09T23:10:47.038934Z","end":"2026-06-09T23:10:47.353755Z","steps":["trace[496133840] 'agreement among raft nodes before linearized reading' (duration: 314.680983ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:47.353827Z","caller":"traceutil/trace.go:171","msg":"trace[880446503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25046; }","duration":"317.899362ms","start":"2026-06-09T23:10:47.035894Z","end":"2026-06-09T23:10:47.353793Z","steps":["trace[880446503] 'agreement among raft nodes before linearized reading' (duration: 317.733217ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:47.353842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.038927Z","time spent":"314.905439ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-09T23:10:47.35386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.035874Z","time spent":"317.978345ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T23:10:47.353855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.044804Z","time spent":"308.887553ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:47.717458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.223775ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:47.717734Z","caller":"traceutil/trace.go:171","msg":"trace[219132590] transaction","detail":"{read_only:false; response_revision:25049; number_of_response:1; }","duration":"358.248195ms","start":"2026-06-09T23:10:47.359464Z","end":"2026-06-09T23:10:47.717712Z","steps":["trace[219132590] 'process raft request' (duration: 358.207513ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:47.718007Z","caller":"traceutil/trace.go:171","msg":"trace[1371194152] transaction","detail":"{read_only:false; response_revision:25047; number_of_response:1; }","duration":"632.717029ms","start":"2026-06-09T23:10:47.08527Z","end":"2026-06-09T23:10:47.717987Z","steps":["trace[1371194152] 'process raft request' (duration: 528.882977ms)","trace[1371194152] 'compare' (duration: 103.086452ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:47.718026Z","caller":"traceutil/trace.go:171","msg":"trace[1893387123] transaction","detail":"{read_only:false; response_revision:25048; number_of_response:1; }","duration":"358.80878ms","start":"2026-06-09T23:10:47.359196Z","end":"2026-06-09T23:10:47.718005Z","steps":["trace[1893387123] 'process raft request' (duration: 358.385508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:47.71809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.085252Z","time spent":"632.795541ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:47.717711Z","caller":"traceutil/trace.go:171","msg":"trace[334953515] linearizableReadLoop","detail":"{readStateIndex:25865; appliedIndex:25864; }","duration":"364.094706ms","start":"2026-06-09T23:10:47.353588Z","end":"2026-06-09T23:10:47.717682Z","steps":["trace[334953515] 'read index received' (duration: 260.578422ms)","trace[334953515] 'applied index is now lower than readState.Index' (duration: 103.514424ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:47.718123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.359176Z","time spent":"358.884592ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:47.717809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.359457Z","time spent":"358.318016ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:47.718126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.804257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:47.718212Z","caller":"traceutil/trace.go:171","msg":"trace[1070973749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25049; }","duration":"556.935641ms","start":"2026-06-09T23:10:47.161255Z","end":"2026-06-09T23:10:47.718191Z","steps":["trace[1070973749] 'agreement among raft nodes before linearized reading' (duration: 556.750106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:47.718215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.127396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T23:10:47.718241Z","caller":"traceutil/trace.go:171","msg":"trace[704870535] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:25049; }","duration":"364.184768ms","start":"2026-06-09T23:10:47.354049Z","end":"2026-06-09T23:10:47.718234Z","steps":["trace[704870535] 'agreement among raft nodes before linearized reading' (duration: 364.123146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:47.718245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.161232Z","time spent":"557.007082ms","remote":"127.0.0.1:43206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T23:10:47.71826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.354028Z","time spent":"364.22821ms","remote":"127.0.0.1:43664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":20,"response size":31,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-09T23:10:47.718287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.544266ms","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":"warn","ts":"2026-06-09T23:10:47.718303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.497609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-09T23:10:47.718312Z","caller":"traceutil/trace.go:171","msg":"trace[672105703] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25049; }","duration":"582.610148ms","start":"2026-06-09T23:10:47.135693Z","end":"2026-06-09T23:10:47.718303Z","steps":["trace[672105703] 'agreement among raft nodes before linearized reading' (duration: 582.072613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:47.718333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.13566Z","time spent":"582.66851ms","remote":"127.0.0.1:43468","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":"info","ts":"2026-06-09T23:10:47.718335Z","caller":"traceutil/trace.go:171","msg":"trace[1527092586] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25049; }","duration":"363.574381ms","start":"2026-06-09T23:10:47.35475Z","end":"2026-06-09T23:10:47.718324Z","steps":["trace[1527092586] 'agreement among raft nodes before linearized reading' (duration: 363.450188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:47.718364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:47.354733Z","time spent":"363.625842ms","remote":"127.0.0.1:43400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-09T23:10:47.718431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.365178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:47.718583Z","caller":"traceutil/trace.go:171","msg":"trace[931616418] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:25049; }","duration":"251.581654ms","start":"2026-06-09T23:10:47.46696Z","end":"2026-06-09T23:10:47.718542Z","steps":["trace[931616418] 'agreement among raft nodes before linearized reading' (duration: 251.237585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:47.988471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.438901ms","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-06-09T23:10:47.988563Z","caller":"traceutil/trace.go:171","msg":"trace[31296123] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25050; }","duration":"144.584155ms","start":"2026-06-09T23:10:47.843961Z","end":"2026-06-09T23:10:47.988545Z","steps":["trace[31296123] 'range keys from in-memory index tree' (duration: 144.344608ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:49.147983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.905987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:49.148134Z","caller":"traceutil/trace.go:171","msg":"trace[949865899] transaction","detail":"{read_only:false; response_revision:25052; number_of_response:1; }","duration":"307.864945ms","start":"2026-06-09T23:10:48.840245Z","end":"2026-06-09T23:10:49.14811Z","steps":["trace[949865899] 'process raft request' (duration: 184.781413ms)","trace[949865899] 'compare' (duration: 122.611349ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:49.148208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:48.840206Z","time spent":"307.963558ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:49.184326Z","caller":"traceutil/trace.go:171","msg":"trace[188396969] transaction","detail":"{read_only:false; response_revision:25054; number_of_response:1; }","duration":"343.604851ms","start":"2026-06-09T23:10:48.840694Z","end":"2026-06-09T23:10:49.184299Z","steps":["trace[188396969] 'process raft request' (duration: 343.512488ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:49.184532Z","caller":"traceutil/trace.go:171","msg":"trace[40501315] transaction","detail":"{read_only:false; response_revision:25055; number_of_response:1; }","duration":"341.184004ms","start":"2026-06-09T23:10:48.843341Z","end":"2026-06-09T23:10:49.184525Z","steps":["trace[40501315] 'process raft request' (duration: 340.916467ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:49.18436Z","caller":"traceutil/trace.go:171","msg":"trace[1716084440] transaction","detail":"{read_only:false; response_revision:25053; number_of_response:1; }","duration":"344.046833ms","start":"2026-06-09T23:10:48.840286Z","end":"2026-06-09T23:10:49.184333Z","steps":["trace[1716084440] 'process raft request' (duration: 343.727104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:49.18454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:48.840666Z","time spent":"343.770824ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:49.184638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:48.84333Z","time spent":"341.230305ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:49.184664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:48.840261Z","time spent":"344.31274ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:49.184833Z","caller":"traceutil/trace.go:171","msg":"trace[1050334094] transaction","detail":"{read_only:false; response_revision:25056; number_of_response:1; }","duration":"328.732271ms","start":"2026-06-09T23:10:48.856075Z","end":"2026-06-09T23:10:49.184807Z","steps":["trace[1050334094] 'process raft request' (duration: 328.389881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:49.184966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:48.856055Z","time spent":"328.842283ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:49.185917Z","caller":"traceutil/trace.go:171","msg":"trace[426559994] transaction","detail":"{read_only:false; response_revision:25057; number_of_response:1; }","duration":"318.572201ms","start":"2026-06-09T23:10:48.867322Z","end":"2026-06-09T23:10:49.185894Z","steps":["trace[426559994] 'process raft request' (duration: 317.426769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:49.186061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:48.8673Z","time spent":"318.685104ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:49.377473Z","caller":"traceutil/trace.go:171","msg":"trace[116760798] transaction","detail":"{read_only:false; response_revision:25058; number_of_response:1; }","duration":"294.99263ms","start":"2026-06-09T23:10:49.082435Z","end":"2026-06-09T23:10:49.377428Z","steps":["trace[116760798] 'process raft request' (duration: 294.701902ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:49.37753Z","caller":"traceutil/trace.go:171","msg":"trace[207126878] linearizableReadLoop","detail":"{readStateIndex:25877; appliedIndex:25870; }","duration":"215.717595ms","start":"2026-06-09T23:10:49.161788Z","end":"2026-06-09T23:10:49.377506Z","steps":["trace[207126878] 'read index received' (duration: 22.257024ms)","trace[207126878] 'applied index is now lower than readState.Index' (duration: 193.459421ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:49.377643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.846398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:49.377685Z","caller":"traceutil/trace.go:171","msg":"trace[869058497] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25059; }","duration":"215.94691ms","start":"2026-06-09T23:10:49.161728Z","end":"2026-06-09T23:10:49.377675Z","steps":["trace[869058497] 'agreement among raft nodes before linearized reading' (duration: 215.862298ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:49.377722Z","caller":"traceutil/trace.go:171","msg":"trace[21103703] transaction","detail":"{read_only:false; response_revision:25059; number_of_response:1; }","duration":"276.90156ms","start":"2026-06-09T23:10:49.100805Z","end":"2026-06-09T23:10:49.377706Z","steps":["trace[21103703] 'process raft request' (duration: 276.484429ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:49.599158Z","caller":"traceutil/trace.go:171","msg":"trace[1678442436] transaction","detail":"{read_only:false; response_revision:25060; number_of_response:1; }","duration":"238.067431ms","start":"2026-06-09T23:10:49.361062Z","end":"2026-06-09T23:10:49.59913Z","steps":["trace[1678442436] 'process raft request' (duration: 237.870866ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:51.284643Z","caller":"traceutil/trace.go:171","msg":"trace[884562344] transaction","detail":"{read_only:false; response_revision:25067; number_of_response:1; }","duration":"130.079086ms","start":"2026-06-09T23:10:51.154536Z","end":"2026-06-09T23:10:51.284615Z","steps":["trace[884562344] 'process raft request' (duration: 129.775748ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:51.492771Z","caller":"traceutil/trace.go:171","msg":"trace[1907044201] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"301.985223ms","start":"2026-06-09T23:10:51.190759Z","end":"2026-06-09T23:10:51.492744Z","steps":["trace[1907044201] 'process raft request' (duration: 301.902811ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:51.492768Z","caller":"traceutil/trace.go:171","msg":"trace[1509750476] transaction","detail":"{read_only:false; response_revision:25068; number_of_response:1; }","duration":"303.472085ms","start":"2026-06-09T23:10:51.189258Z","end":"2026-06-09T23:10:51.492731Z","steps":["trace[1509750476] 'process raft request' (duration: 303.112085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:51.492942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.190733Z","time spent":"302.118927ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:51.492972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.189242Z","time spent":"303.623729ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:51.492833Z","caller":"traceutil/trace.go:171","msg":"trace[1825663956] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"302.850788ms","start":"2026-06-09T23:10:51.189943Z","end":"2026-06-09T23:10:51.492794Z","steps":["trace[1825663956] 'process raft request' (duration: 302.668923ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:51.493108Z","caller":"traceutil/trace.go:171","msg":"trace[1194157333] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"249.24832ms","start":"2026-06-09T23:10:51.243837Z","end":"2026-06-09T23:10:51.493085Z","steps":["trace[1194157333] 'process raft request' (duration: 249.132397ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:51.493167Z","caller":"traceutil/trace.go:171","msg":"trace[2126427292] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"300.449572ms","start":"2026-06-09T23:10:51.192699Z","end":"2026-06-09T23:10:51.493148Z","steps":["trace[2126427292] 'process raft request' (duration: 300.004429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:51.493273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.192687Z","time spent":"300.530683ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:51.493276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.189931Z","time spent":"303.177016ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:51.788834Z","caller":"traceutil/trace.go:171","msg":"trace[1649634465] linearizableReadLoop","detail":"{readStateIndex:25893; appliedIndex:25886; }","duration":"364.226179ms","start":"2026-06-09T23:10:51.424582Z","end":"2026-06-09T23:10:51.788809Z","steps":["trace[1649634465] 'read index received' (duration: 67.943662ms)","trace[1649634465] 'applied index is now lower than readState.Index' (duration: 296.281477ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:51.788952Z","caller":"traceutil/trace.go:171","msg":"trace[91181547] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"499.471917ms","start":"2026-06-09T23:10:51.289448Z","end":"2026-06-09T23:10:51.78892Z","steps":["trace[91181547] 'process raft request' (duration: 463.30176ms)","trace[91181547] 'compare' (duration: 35.489768ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:51.789016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.392524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:51.789084Z","caller":"traceutil/trace.go:171","msg":"trace[317266264] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:25074; }","duration":"364.522528ms","start":"2026-06-09T23:10:51.424537Z","end":"2026-06-09T23:10:51.789059Z","steps":["trace[317266264] 'agreement among raft nodes before linearized reading' (duration: 364.370073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:51.789109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.289428Z","time spent":"499.60225ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:51.789139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.424517Z","time spent":"364.611729ms","remote":"127.0.0.1:56252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true "} {"level":"info","ts":"2026-06-09T23:10:51.789176Z","caller":"traceutil/trace.go:171","msg":"trace[1004528291] transaction","detail":"{read_only:false; response_revision:25074; number_of_response:1; }","duration":"404.648893ms","start":"2026-06-09T23:10:51.384495Z","end":"2026-06-09T23:10:51.789144Z","steps":["trace[1004528291] 'process raft request' (duration: 404.212141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:51.789325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.384475Z","time spent":"404.769317ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:51.857218Z","caller":"traceutil/trace.go:171","msg":"trace[1874812850] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"251.959964ms","start":"2026-06-09T23:10:51.605237Z","end":"2026-06-09T23:10:51.857197Z","steps":["trace[1874812850] 'process raft request' (duration: 251.79639ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:51.990087Z","caller":"traceutil/trace.go:171","msg":"trace[1267243126] transaction","detail":"{read_only:false; response_revision:25076; number_of_response:1; }","duration":"128.570643ms","start":"2026-06-09T23:10:51.861492Z","end":"2026-06-09T23:10:51.990062Z","steps":["trace[1267243126] 'process raft request' (duration: 128.416349ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:52.217958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.141471ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:10:52.218182Z","caller":"traceutil/trace.go:171","msg":"trace[1979863130] linearizableReadLoop","detail":"{readStateIndex:25898; appliedIndex:25895; }","duration":"100.587512ms","start":"2026-06-09T23:10:52.117578Z","end":"2026-06-09T23:10:52.218165Z","steps":["trace[1979863130] 'read index received' (duration: 35.611µs)","trace[1979863130] 'applied index is now lower than readState.Index' (duration: 100.550791ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:52.21826Z","caller":"traceutil/trace.go:171","msg":"trace[1873096608] transaction","detail":"{read_only:false; response_revision:25077; number_of_response:1; }","duration":"356.438845ms","start":"2026-06-09T23:10:51.861778Z","end":"2026-06-09T23:10:52.218217Z","steps":["trace[1873096608] 'process raft request' (duration: 206.939894ms)","trace[1873096608] 'compare' (duration: 148.968226ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:52.218304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.718456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:52.218263Z","caller":"traceutil/trace.go:171","msg":"trace[1915520085] transaction","detail":"{read_only:false; response_revision:25078; number_of_response:1; }","duration":"355.56115ms","start":"2026-06-09T23:10:51.862654Z","end":"2026-06-09T23:10:52.218215Z","steps":["trace[1915520085] 'process raft request' (duration: 355.408155ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:52.218344Z","caller":"traceutil/trace.go:171","msg":"trace[1437107748] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:25079; }","duration":"100.791328ms","start":"2026-06-09T23:10:52.117542Z","end":"2026-06-09T23:10:52.218333Z","steps":["trace[1437107748] 'agreement among raft nodes before linearized reading' (duration: 100.723756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:52.218445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.861757Z","time spent":"356.582118ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:10:52.218489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.862645Z","time spent":"355.725735ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:52.218272Z","caller":"traceutil/trace.go:171","msg":"trace[123694681] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"354.133201ms","start":"2026-06-09T23:10:51.864115Z","end":"2026-06-09T23:10:52.218248Z","steps":["trace[123694681] 'process raft request' (duration: 354.001247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:52.218626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:10:51.864103Z","time spent":"354.49218ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:10:52.469629Z","caller":"traceutil/trace.go:171","msg":"trace[1809103993] linearizableReadLoop","detail":"{readStateIndex:25899; appliedIndex:25898; }","duration":"156.75123ms","start":"2026-06-09T23:10:52.31284Z","end":"2026-06-09T23:10:52.469592Z","steps":["trace[1809103993] 'read index received' (duration: 137.931862ms)","trace[1809103993] 'applied index is now lower than readState.Index' (duration: 18.818018ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:52.469661Z","caller":"traceutil/trace.go:171","msg":"trace[1435370230] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"223.455499ms","start":"2026-06-09T23:10:52.246167Z","end":"2026-06-09T23:10:52.469622Z","steps":["trace[1435370230] 'process raft request' (duration: 204.694502ms)","trace[1435370230] 'compare' (duration: 18.550731ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:10:52.469794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.940135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-09T23:10:52.469878Z","caller":"traceutil/trace.go:171","msg":"trace[622243553] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:25080; }","duration":"157.038468ms","start":"2026-06-09T23:10:52.312823Z","end":"2026-06-09T23:10:52.469862Z","steps":["trace[622243553] 'agreement among raft nodes before linearized reading' (duration: 156.861533ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:53.693482Z","caller":"traceutil/trace.go:171","msg":"trace[537101535] transaction","detail":"{read_only:false; response_revision:25086; number_of_response:1; }","duration":"192.842505ms","start":"2026-06-09T23:10:53.500618Z","end":"2026-06-09T23:10:53.69346Z","steps":["trace[537101535] 'process raft request' (duration: 192.802834ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:53.693871Z","caller":"traceutil/trace.go:171","msg":"trace[798689625] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"194.093539ms","start":"2026-06-09T23:10:53.499767Z","end":"2026-06-09T23:10:53.693861Z","steps":["trace[798689625] 'process raft request' (duration: 193.456502ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:53.693963Z","caller":"traceutil/trace.go:171","msg":"trace[638449520] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"194.12996ms","start":"2026-06-09T23:10:53.499826Z","end":"2026-06-09T23:10:53.693956Z","steps":["trace[638449520] 'process raft request' (duration: 193.557354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:54.314636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.228214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:10:54.314741Z","caller":"traceutil/trace.go:171","msg":"trace[831482044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25090; }","duration":"153.351177ms","start":"2026-06-09T23:10:54.161373Z","end":"2026-06-09T23:10:54.314724Z","steps":["trace[831482044] 'range keys from in-memory index tree' (duration: 153.12253ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:56.525639Z","caller":"traceutil/trace.go:171","msg":"trace[960010450] linearizableReadLoop","detail":"{readStateIndex:25928; appliedIndex:25927; }","duration":"117.278233ms","start":"2026-06-09T23:10:56.408338Z","end":"2026-06-09T23:10:56.525616Z","steps":["trace[960010450] 'read index received' (duration: 117.067467ms)","trace[960010450] 'applied index is now lower than readState.Index' (duration: 209.936µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:56.525953Z","caller":"traceutil/trace.go:171","msg":"trace[1560780627] transaction","detail":"{read_only:false; response_revision:25108; number_of_response:1; }","duration":"125.686075ms","start":"2026-06-09T23:10:56.400253Z","end":"2026-06-09T23:10:56.525939Z","steps":["trace[1560780627] 'process raft request' (duration: 125.213062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:56.526234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.046746ms","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-06-09T23:10:56.52632Z","caller":"traceutil/trace.go:171","msg":"trace[2122845709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25108; }","duration":"109.154019ms","start":"2026-06-09T23:10:56.417148Z","end":"2026-06-09T23:10:56.526302Z","steps":["trace[2122845709] 'agreement among raft nodes before linearized reading' (duration: 108.957473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:56.526485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.128156ms","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-06-09T23:10:56.526547Z","caller":"traceutil/trace.go:171","msg":"trace[588606989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25108; }","duration":"118.230979ms","start":"2026-06-09T23:10:56.408304Z","end":"2026-06-09T23:10:56.526535Z","steps":["trace[588606989] 'agreement among raft nodes before linearized reading' (duration: 118.065685ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:59.838308Z","caller":"traceutil/trace.go:171","msg":"trace[1948608466] transaction","detail":"{read_only:false; response_revision:25127; number_of_response:1; }","duration":"100.064978ms","start":"2026-06-09T23:10:59.738211Z","end":"2026-06-09T23:10:59.838276Z","steps":["trace[1948608466] 'process raft request' (duration: 22.082219ms)","trace[1948608466] 'compare' (duration: 77.847465ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:59.930261Z","caller":"traceutil/trace.go:171","msg":"trace[294215846] transaction","detail":"{read_only:false; response_revision:25128; number_of_response:1; }","duration":"184.190916ms","start":"2026-06-09T23:10:59.746052Z","end":"2026-06-09T23:10:59.930243Z","steps":["trace[294215846] 'process raft request' (duration: 184.048012ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:59.930525Z","caller":"traceutil/trace.go:171","msg":"trace[1954811663] transaction","detail":"{read_only:false; response_revision:25129; number_of_response:1; }","duration":"175.798545ms","start":"2026-06-09T23:10:59.754695Z","end":"2026-06-09T23:10:59.930494Z","steps":["trace[1954811663] 'process raft request' (duration: 175.513597ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:59.930547Z","caller":"traceutil/trace.go:171","msg":"trace[1204718541] linearizableReadLoop","detail":"{readStateIndex:25948; appliedIndex:25946; }","duration":"183.064545ms","start":"2026-06-09T23:10:59.747462Z","end":"2026-06-09T23:10:59.930527Z","steps":["trace[1204718541] 'read index received' (duration: 12.820303ms)","trace[1204718541] 'applied index is now lower than readState.Index' (duration: 170.243302ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:10:59.930594Z","caller":"traceutil/trace.go:171","msg":"trace[1452961555] transaction","detail":"{read_only:false; response_revision:25130; number_of_response:1; }","duration":"175.448596ms","start":"2026-06-09T23:10:59.755136Z","end":"2026-06-09T23:10:59.930584Z","steps":["trace[1452961555] 'process raft request' (duration: 175.288931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:10:59.930677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.188928ms","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-06-09T23:10:59.930705Z","caller":"traceutil/trace.go:171","msg":"trace[1514880536] 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:25130; }","duration":"183.261211ms","start":"2026-06-09T23:10:59.747435Z","end":"2026-06-09T23:10:59.930697Z","steps":["trace[1514880536] 'agreement among raft nodes before linearized reading' (duration: 183.182069ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:10:59.930975Z","caller":"traceutil/trace.go:171","msg":"trace[13086064] transaction","detail":"{read_only:false; response_revision:25131; number_of_response:1; }","duration":"117.56791ms","start":"2026-06-09T23:10:59.813399Z","end":"2026-06-09T23:10:59.930967Z","steps":["trace[13086064] 'process raft request' (duration: 117.484558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:01.868258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.201894ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T23:11:01.868376Z","caller":"traceutil/trace.go:171","msg":"trace[1533555921] transaction","detail":"{read_only:false; response_revision:25143; number_of_response:1; }","duration":"252.756846ms","start":"2026-06-09T23:11:01.615593Z","end":"2026-06-09T23:11:01.86835Z","steps":["trace[1533555921] 'process raft request' (duration: 120.372767ms)","trace[1533555921] 'compare' (duration: 131.833164ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:11:28.54227Z","caller":"traceutil/trace.go:171","msg":"trace[1205015572] transaction","detail":"{read_only:false; response_revision:25488; number_of_response:1; }","duration":"496.191886ms","start":"2026-06-09T23:11:28.046045Z","end":"2026-06-09T23:11:28.542237Z","steps":["trace[1205015572] 'process raft request' (duration: 496.061522ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:28.542371Z","caller":"traceutil/trace.go:171","msg":"trace[1199472585] transaction","detail":"{read_only:false; response_revision:25487; number_of_response:1; }","duration":"556.697683ms","start":"2026-06-09T23:11:27.985593Z","end":"2026-06-09T23:11:28.542291Z","steps":["trace[1199472585] 'process raft request' (duration: 556.238081ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:28.542464Z","caller":"traceutil/trace.go:171","msg":"trace[619677260] linearizableReadLoop","detail":"{readStateIndex:26314; appliedIndex:26312; }","duration":"516.032153ms","start":"2026-06-09T23:11:28.026409Z","end":"2026-06-09T23:11:28.542441Z","steps":["trace[619677260] 'read index received' (duration: 33.401431ms)","trace[619677260] 'applied index is now lower than readState.Index' (duration: 482.629562ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T23:11:28.542638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:28.046021Z","time spent":"496.444483ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:28.542739Z","caller":"traceutil/trace.go:171","msg":"trace[1805257422] transaction","detail":"{read_only:false; response_revision:25491; number_of_response:1; }","duration":"488.937327ms","start":"2026-06-09T23:11:28.053795Z","end":"2026-06-09T23:11:28.542732Z","steps":["trace[1805257422] 'process raft request' (duration: 488.601277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:28.542701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:27.98557Z","time spent":"556.983542ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T23:11:28.542847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:28.053761Z","time spent":"489.013768ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:28.542679Z","caller":"traceutil/trace.go:171","msg":"trace[907895364] transaction","detail":"{read_only:false; response_revision:25489; number_of_response:1; }","duration":"491.456456ms","start":"2026-06-09T23:11:28.051212Z","end":"2026-06-09T23:11:28.542668Z","steps":["trace[907895364] 'process raft request' (duration: 490.969082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:28.54299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.757707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-09T23:11:28.543054Z","caller":"traceutil/trace.go:171","msg":"trace[291936554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25491; }","duration":"469.84247ms","start":"2026-06-09T23:11:28.073193Z","end":"2026-06-09T23:11:28.543036Z","steps":["trace[291936554] 'agreement among raft nodes before linearized reading' (duration: 469.646154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:28.54307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.65128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-09T23:11:28.543056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.666722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-09T23:11:28.543138Z","caller":"traceutil/trace.go:171","msg":"trace[1814253999] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:25491; }","duration":"516.768073ms","start":"2026-06-09T23:11:28.026351Z","end":"2026-06-09T23:11:28.543119Z","steps":["trace[1814253999] 'agreement among raft nodes before linearized reading' (duration: 516.65829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:28.543003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:28.051198Z","time spent":"491.776544ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:28.543141Z","caller":"traceutil/trace.go:171","msg":"trace[1453007148] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25491; }","duration":"376.816915ms","start":"2026-06-09T23:11:28.16631Z","end":"2026-06-09T23:11:28.543127Z","steps":["trace[1453007148] 'agreement among raft nodes before linearized reading' (duration: 376.659021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:28.543181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:28.026332Z","time spent":"516.839696ms","remote":"127.0.0.1:34520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-06-09T23:11:28.54318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.574178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-09T23:11:28.543232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:28.166274Z","time spent":"376.945949ms","remote":"127.0.0.1:43206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-09T23:11:28.543089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:28.073183Z","time spent":"469.897631ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-09T23:11:28.543284Z","caller":"traceutil/trace.go:171","msg":"trace[1766385617] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25491; }","duration":"233.735362ms","start":"2026-06-09T23:11:28.309523Z","end":"2026-06-09T23:11:28.543258Z","steps":["trace[1766385617] 'agreement among raft nodes before linearized reading' (duration: 233.390953ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:11:28.54271Z","caller":"traceutil/trace.go:171","msg":"trace[877943909] transaction","detail":"{read_only:false; response_revision:25490; number_of_response:1; }","duration":"489.108581ms","start":"2026-06-09T23:11:28.053594Z","end":"2026-06-09T23:11:28.542703Z","steps":["trace[877943909] 'process raft request' (duration: 488.71255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T23:11:28.543487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T23:11:28.053585Z","time spent":"489.81889ms","remote":"127.0.0.1:43468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T23:11:28.675026Z","caller":"traceutil/trace.go:171","msg":"trace[1843453213] transaction","detail":"{read_only:false; response_revision:25493; number_of_response:1; }","duration":"125.723904ms","start":"2026-06-09T23:11:28.549263Z","end":"2026-06-09T23:11:28.674987Z","steps":["trace[1843453213] 'process raft request' (duration: 71.682324ms)","trace[1843453213] 'compare' (duration: 53.879085ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T23:12:34.28689Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006915.wal"} {"level":"info","ts":"2026-06-09T23:13:01.5599Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23438} {"level":"info","ts":"2026-06-09T23:13:01.694555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23438,"took":"130.420232ms","hash":682850045,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":37179392,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-06-09T23:13:01.694628Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":682850045,"revision":23438,"compact-revision":20106} {"level":"info","ts":"2026-06-09T23:18:01.56675Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26333} {"level":"info","ts":"2026-06-09T23:18:01.714945Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26333,"took":"143.959307ms","hash":1808809370,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":33308672,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-09T23:18:01.715067Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1808809370,"revision":26333,"compact-revision":23438} {"level":"info","ts":"2026-06-09T23:18:26.104094Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c9b4049ccf4190cf","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T23:18:26.109345Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-09T23:18:26.109469Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-09T23:23:01.572341Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28896} {"level":"info","ts":"2026-06-09T23:23:01.705348Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28896,"took":"128.843982ms","hash":3243639764,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":30179328,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-09T23:23:01.705411Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3243639764,"revision":28896,"compact-revision":26333} {"level":"info","ts":"2026-06-09T23:28:01.578926Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31115} {"level":"info","ts":"2026-06-09T23:28:01.70252Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31115,"took":"119.381421ms","hash":624244249,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":30490624,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-09T23:28:01.702639Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":624244249,"revision":31115,"compact-revision":28896} {"level":"info","ts":"2026-06-09T23:33:01.584086Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33413} {"level":"info","ts":"2026-06-09T23:33:01.732557Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33413,"took":"144.58504ms","hash":854123098,"current-db-size-bytes":58552320,"current-db-size":"59 MB","current-db-size-in-use-bytes":32571392,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-09T23:33:01.73262Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":854123098,"revision":33413,"compact-revision":31115} {"level":"info","ts":"2026-06-09T23:38:01.589467Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35677} {"level":"info","ts":"2026-06-09T23:38:01.723308Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35677,"took":"130.870341ms","hash":2285576214,"current-db-size-bytes":59445248,"current-db-size":"59 MB","current-db-size-in-use-bytes":31584256,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-09T23:38:01.723364Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2285576214,"revision":35677,"compact-revision":33413} {"level":"info","ts":"2026-06-09T23:39:55.9502Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c9b4049ccf4190cf","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T23:39:55.954022Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-09T23:39:55.954144Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}