{"level":"warn","ts":"2026-06-13T22:41:41.448652Z","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-13T22:41:41.44872Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-13T22:41:41.448794Z","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-13T22:41:41.448856Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-06-13T22:41:41.44889Z","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-13T22:41:41.44947Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-06-13T22:41:41.449576Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-13T22:41:41.454102Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.802517ms"} {"level":"info","ts":"2026-06-13T22:41:41.460519Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-06-13T22:41:41.460612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-06-13T22:41:41.460639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-06-13T22:41:41.460653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-13T22:41:41.461418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-06-13T22:41:41.461504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-06-13T22:41:41.469123Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-13T22:41:41.471252Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-13T22:41:41.47255Z","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-13T22:41:41.474694Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-13T22:41:41.474858Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-13T22:41:41.475117Z","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-13T22:41:41.475239Z","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-13T22:41:41.475338Z","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-13T22:41:41.475744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-06-13T22:41:41.475832Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-06-13T22:41:41.477793Z","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-13T22:41:41.477905Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-06-13T22:41:41.477928Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-06-13T22:41:41.478322Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-13T22:41:41.478365Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-13T22:41:42.462141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-06-13T22:41:42.46228Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-13T22:41:42.462413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-06-13T22:41:42.462492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-06-13T22:41:42.462551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-06-13T22:41:42.4626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-06-13T22:41:42.462682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-06-13T22:41:42.463708Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:41:42.464691Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T22:41:42.464691Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-06-13T22:41:42.464777Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-13T22:41:42.465091Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-13T22:41:42.465234Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:41:42.465368Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-13T22:41:42.46544Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:41:42.465609Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-13T22:41:42.467458Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-06-13T22:41:42.469541Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-13T22:41:47.824788Z","caller":"traceutil/trace.go:171","msg":"trace[1368250411] linearizableReadLoop","detail":"{readStateIndex:265; appliedIndex:264; }","duration":"224.935473ms","start":"2026-06-13T22:41:47.599829Z","end":"2026-06-13T22:41:47.824765Z","steps":["trace[1368250411] 'read index received' (duration: 224.723493ms)","trace[1368250411] 'applied index is now lower than readState.Index' (duration: 210.9µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:41:47.824853Z","caller":"traceutil/trace.go:171","msg":"trace[1358453105] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"235.863314ms","start":"2026-06-13T22:41:47.588954Z","end":"2026-06-13T22:41:47.824817Z","steps":["trace[1358453105] 'process raft request' (duration: 235.646603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:41:47.825006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.120192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-13T22:41:47.825081Z","caller":"traceutil/trace.go:171","msg":"trace[813580305] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:258; }","duration":"225.268609ms","start":"2026-06-13T22:41:47.5998Z","end":"2026-06-13T22:41:47.825069Z","steps":["trace[813580305] 'agreement among raft nodes before linearized reading' (duration: 225.0938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:41:48.089113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.467878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:41:48.089241Z","caller":"traceutil/trace.go:171","msg":"trace[410646515] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"260.293675ms","start":"2026-06-13T22:41:47.828925Z","end":"2026-06-13T22:41:48.089219Z","steps":["trace[410646515] 'process raft request' (duration: 100.065079ms)","trace[410646515] 'compare' (duration: 159.304741ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:41:48.360863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.156193ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:41:48.361053Z","caller":"traceutil/trace.go:171","msg":"trace[1052320890] linearizableReadLoop","detail":"{readStateIndex:267; appliedIndex:265; }","duration":"530.19588ms","start":"2026-06-13T22:41:47.830789Z","end":"2026-06-13T22:41:48.360985Z","steps":["trace[1052320890] 'read index received' (duration: 98.212799ms)","trace[1052320890] 'applied index is now lower than readState.Index' (duration: 431.981601ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:41:48.361183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.38324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-13T22:41:48.361236Z","caller":"traceutil/trace.go:171","msg":"trace[622629029] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:260; }","duration":"530.445413ms","start":"2026-06-13T22:41:47.830779Z","end":"2026-06-13T22:41:48.361224Z","steps":["trace[622629029] 'agreement among raft nodes before linearized reading' (duration: 530.333607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:41:48.361258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:41:47.830746Z","time spent":"530.507175ms","remote":"127.0.0.1:39258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-06-13T22:41:48.361504Z","caller":"traceutil/trace.go:171","msg":"trace[2073854331] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"531.381618ms","start":"2026-06-13T22:41:47.830007Z","end":"2026-06-13T22:41:48.361389Z","steps":["trace[2073854331] 'process raft request' (duration: 361.612564ms)","trace[2073854331] 'compare' (duration: 168.597496ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:41:48.361816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:41:47.82999Z","time spent":"531.665492ms","remote":"127.0.0.1:39540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":420,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T22:41:48.369339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.478026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:41:48.369353Z","caller":"traceutil/trace.go:171","msg":"trace[1115409310] transaction","detail":"{read_only:false; number_of_response:0; response_revision:261; }","duration":"210.277473ms","start":"2026-06-13T22:41:48.159056Z","end":"2026-06-13T22:41:48.369333Z","steps":["trace[1115409310] 'process raft request' (duration: 210.200609ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:41:48.3694Z","caller":"traceutil/trace.go:171","msg":"trace[65288614] transaction","detail":"{read_only:false; number_of_response:0; response_revision:261; }","duration":"210.21822ms","start":"2026-06-13T22:41:48.159177Z","end":"2026-06-13T22:41:48.369396Z","steps":["trace[65288614] 'process raft request' (duration: 210.093224ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:41:48.369484Z","caller":"traceutil/trace.go:171","msg":"trace[1320705501] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"276.556731ms","start":"2026-06-13T22:41:48.092917Z","end":"2026-06-13T22:41:48.369474Z","steps":["trace[1320705501] 'process raft request' (duration: 276.251586ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:41:48.369657Z","caller":"traceutil/trace.go:171","msg":"trace[1414105771] transaction","detail":"{read_only:false; number_of_response:0; response_revision:261; }","duration":"210.799318ms","start":"2026-06-13T22:41:48.158849Z","end":"2026-06-13T22:41:48.369648Z","steps":["trace[1414105771] 'process raft request' (duration: 210.379168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:41:48.369687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.045028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-06-13T22:41:48.369719Z","caller":"traceutil/trace.go:171","msg":"trace[434447702] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:261; }","duration":"213.122311ms","start":"2026-06-13T22:41:48.156589Z","end":"2026-06-13T22:41:48.369711Z","steps":["trace[434447702] 'agreement among raft nodes before linearized reading' (duration: 213.048788ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:41:48.369377Z","caller":"traceutil/trace.go:171","msg":"trace[1525203946] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:261; }","duration":"516.548659ms","start":"2026-06-13T22:41:47.85282Z","end":"2026-06-13T22:41:48.369369Z","steps":["trace[1525203946] 'agreement among raft nodes before linearized reading' (duration: 516.470046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:41:48.369804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:41:47.852807Z","time spent":"516.981301ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T22:41:48.369997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.592651ms","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-13T22:41:48.370082Z","caller":"traceutil/trace.go:171","msg":"trace[1580474648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:263; }","duration":"277.717457ms","start":"2026-06-13T22:41:48.092341Z","end":"2026-06-13T22:41:48.370059Z","steps":["trace[1580474648] 'agreement among raft nodes before linearized reading' (duration: 277.508187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:41:57.433528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.6852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:41:57.433616Z","caller":"traceutil/trace.go:171","msg":"trace[697777233] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:365; }","duration":"132.829537ms","start":"2026-06-13T22:41:57.300768Z","end":"2026-06-13T22:41:57.433597Z","steps":["trace[697777233] 'range keys from in-memory index tree' (duration: 132.597615ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:41:58.599597Z","caller":"traceutil/trace.go:171","msg":"trace[864989275] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:378; }","duration":"128.470891ms","start":"2026-06-13T22:41:58.471106Z","end":"2026-06-13T22:41:58.599576Z","steps":["trace[864989275] 'read index received' (duration: 50.032856ms)","trace[864989275] 'applied index is now lower than readState.Index' (duration: 78.437015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:41:58.599744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.623849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5336"} {"level":"info","ts":"2026-06-13T22:41:58.599796Z","caller":"traceutil/trace.go:171","msg":"trace[1676124948] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:368; }","duration":"128.720334ms","start":"2026-06-13T22:41:58.471065Z","end":"2026-06-13T22:41:58.599785Z","steps":["trace[1676124948] 'agreement among raft nodes before linearized reading' (duration: 128.597277ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:41:58.599885Z","caller":"traceutil/trace.go:171","msg":"trace[1442056563] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"129.585529ms","start":"2026-06-13T22:41:58.470185Z","end":"2026-06-13T22:41:58.599771Z","steps":["trace[1442056563] 'process raft request' (duration: 77.083695ms)","trace[1442056563] 'compare' (duration: 52.212949ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:42:26.747648Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844068784134707,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-13T22:42:26.782066Z","caller":"traceutil/trace.go:171","msg":"trace[724221168] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"534.825188ms","start":"2026-06-13T22:42:26.247213Z","end":"2026-06-13T22:42:26.782038Z","steps":["trace[724221168] 'read index received' (duration: 532.827568ms)","trace[724221168] 'applied index is now lower than readState.Index' (duration: 1.99657ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:42:26.782143Z","caller":"traceutil/trace.go:171","msg":"trace[205868386] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"545.452615ms","start":"2026-06-13T22:42:26.236652Z","end":"2026-06-13T22:42:26.782105Z","steps":["trace[205868386] 'process raft request' (duration: 543.680097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:26.782414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.356634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:42:26.782474Z","caller":"traceutil/trace.go:171","msg":"trace[2012030046] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"482.440918ms","start":"2026-06-13T22:42:26.300015Z","end":"2026-06-13T22:42:26.782456Z","steps":["trace[2012030046] 'agreement among raft nodes before linearized reading' (duration: 482.337493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:26.782474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.244042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-v97sg\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-13T22:42:26.782508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.300005Z","time spent":"482.495901ms","remote":"127.0.0.1:39156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-13T22:42:26.782519Z","caller":"traceutil/trace.go:171","msg":"trace[1289847833] range","detail":"{range_begin:/registry/pods/kube-system/cilium-v97sg; range_end:; response_count:1; response_revision:582; }","duration":"535.334676ms","start":"2026-06-13T22:42:26.247171Z","end":"2026-06-13T22:42:26.782506Z","steps":["trace[1289847833] 'agreement among raft nodes before linearized reading' (duration: 535.005718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:26.782562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.247151Z","time spent":"535.40291ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-v97sg\" "} {"level":"warn","ts":"2026-06-13T22:42:26.782578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.236628Z","time spent":"545.594162ms","remote":"127.0.0.1:39244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:42:26.782769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.167434ms","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-13T22:42:26.782854Z","caller":"traceutil/trace.go:171","msg":"trace[503273476] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"109.29696ms","start":"2026-06-13T22:42:26.673533Z","end":"2026-06-13T22:42:26.78283Z","steps":["trace[503273476] 'agreement among raft nodes before linearized reading' (duration: 109.002424ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:27.2566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.806517ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:42:27.256744Z","caller":"traceutil/trace.go:171","msg":"trace[1614590723] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"468.049335ms","start":"2026-06-13T22:42:26.788669Z","end":"2026-06-13T22:42:27.256719Z","steps":["trace[1614590723] 'process raft request' (duration: 340.998255ms)","trace[1614590723] 'compare' (duration: 126.50297ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:42:27.256816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.788649Z","time spent":"468.13507ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:42:27.26271Z","caller":"traceutil/trace.go:171","msg":"trace[411547151] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"473.947511ms","start":"2026-06-13T22:42:26.788722Z","end":"2026-06-13T22:42:27.26267Z","steps":["trace[411547151] 'process raft request' (duration: 473.759581ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:42:27.262723Z","caller":"traceutil/trace.go:171","msg":"trace[299153635] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:604; }","duration":"336.341299ms","start":"2026-06-13T22:42:26.92636Z","end":"2026-06-13T22:42:27.262701Z","steps":["trace[299153635] 'read index received' (duration: 203.321309ms)","trace[299153635] 'applied index is now lower than readState.Index' (duration: 133.01892ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:42:27.262831Z","caller":"traceutil/trace.go:171","msg":"trace[77226892] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"403.543147ms","start":"2026-06-13T22:42:26.859278Z","end":"2026-06-13T22:42:27.262821Z","steps":["trace[77226892] 'process raft request' (duration: 403.375347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:27.26307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.788699Z","time spent":"474.076468ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:42:27.262863Z","caller":"traceutil/trace.go:171","msg":"trace[1782862989] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"446.483775ms","start":"2026-06-13T22:42:26.816335Z","end":"2026-06-13T22:42:27.262819Z","steps":["trace[1782862989] 'process raft request' (duration: 446.272154ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:27.263109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.859247Z","time spent":"403.619701ms","remote":"127.0.0.1:39366","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T22:42:27.263172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.816299Z","time spent":"446.823074ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:42:27.263241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.339173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-13T22:42:27.263328Z","caller":"traceutil/trace.go:171","msg":"trace[407821848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"335.4543ms","start":"2026-06-13T22:42:26.927835Z","end":"2026-06-13T22:42:27.263289Z","steps":["trace[407821848] 'agreement among raft nodes before linearized reading' (duration: 335.034317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:27.26334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.975074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-13T22:42:27.263376Z","caller":"traceutil/trace.go:171","msg":"trace[381676619] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"337.059499ms","start":"2026-06-13T22:42:26.926306Z","end":"2026-06-13T22:42:27.263365Z","steps":["trace[381676619] 'agreement among raft nodes before linearized reading' (duration: 336.926881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:27.26343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.927824Z","time spent":"335.529844ms","remote":"127.0.0.1:39436","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-13T22:42:27.263406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:26.926283Z","time spent":"337.117061ms","remote":"127.0.0.1:39436","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-13T22:42:27.900946Z","caller":"traceutil/trace.go:171","msg":"trace[1143220402] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"155.571717ms","start":"2026-06-13T22:42:27.74535Z","end":"2026-06-13T22:42:27.900922Z","steps":["trace[1143220402] 'process raft request' (duration: 154.428293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:28.578645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.104217ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:42:28.57895Z","caller":"traceutil/trace.go:171","msg":"trace[1025356848] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:611; }","duration":"277.525888ms","start":"2026-06-13T22:42:28.301407Z","end":"2026-06-13T22:42:28.578933Z","steps":["trace[1025356848] 'read index received' (duration: 51.376883ms)","trace[1025356848] 'applied index is now lower than readState.Index' (duration: 226.147795ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:42:28.579044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.642354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:42:28.579075Z","caller":"traceutil/trace.go:171","msg":"trace[1764024958] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:591; }","duration":"277.710978ms","start":"2026-06-13T22:42:28.301354Z","end":"2026-06-13T22:42:28.579065Z","steps":["trace[1764024958] 'agreement among raft nodes before linearized reading' (duration: 277.634724ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:42:28.579022Z","caller":"traceutil/trace.go:171","msg":"trace[1173689987] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"830.972345ms","start":"2026-06-13T22:42:27.748013Z","end":"2026-06-13T22:42:28.578986Z","steps":["trace[1173689987] 'process raft request' (duration: 429.444525ms)","trace[1173689987] 'compare' (duration: 400.922046ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:42:28.579211Z","caller":"traceutil/trace.go:171","msg":"trace[1900230786] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"616.44516ms","start":"2026-06-13T22:42:27.96275Z","end":"2026-06-13T22:42:28.579195Z","steps":["trace[1900230786] 'process raft request' (duration: 615.998005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:42:28.5793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:27.962725Z","time spent":"616.534605ms","remote":"127.0.0.1:39508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-13T22:42:28.579269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:42:27.747987Z","time spent":"831.167895ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:43:32.708547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.265523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-create-nrwtc\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-06-13T22:43:32.708638Z","caller":"traceutil/trace.go:171","msg":"trace[868309369] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-create-nrwtc; range_end:; response_count:1; response_revision:1309; }","duration":"108.396394ms","start":"2026-06-13T22:43:32.600221Z","end":"2026-06-13T22:43:32.708617Z","steps":["trace[868309369] 'range keys from in-memory index tree' (duration: 108.124661ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:43:39.84197Z","caller":"traceutil/trace.go:171","msg":"trace[1754304773] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"119.434176ms","start":"2026-06-13T22:43:39.72251Z","end":"2026-06-13T22:43:39.841944Z","steps":["trace[1754304773] 'process raft request' (duration: 119.293394ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:43:39.847101Z","caller":"traceutil/trace.go:171","msg":"trace[950276296] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"114.737193ms","start":"2026-06-13T22:43:39.732348Z","end":"2026-06-13T22:43:39.847086Z","steps":["trace[950276296] 'process raft request' (duration: 114.697022ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:43:39.847284Z","caller":"traceutil/trace.go:171","msg":"trace[427388457] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"124.075399ms","start":"2026-06-13T22:43:39.723171Z","end":"2026-06-13T22:43:39.847247Z","steps":["trace[427388457] 'process raft request' (duration: 123.795285ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:43:47.150338Z","caller":"traceutil/trace.go:171","msg":"trace[1336152809] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1538; }","duration":"125.00075ms","start":"2026-06-13T22:43:47.025308Z","end":"2026-06-13T22:43:47.150308Z","steps":["trace[1336152809] 'process raft request' (duration: 124.864817ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:43:55.367554Z","caller":"traceutil/trace.go:171","msg":"trace[671265002] transaction","detail":"{read_only:false; response_revision:1708; number_of_response:1; }","duration":"118.753363ms","start":"2026-06-13T22:43:55.24874Z","end":"2026-06-13T22:43:55.367493Z","steps":["trace[671265002] 'process raft request' (duration: 118.456387ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:43:55.571909Z","caller":"traceutil/trace.go:171","msg":"trace[1141622227] transaction","detail":"{read_only:false; response_revision:1709; number_of_response:1; }","duration":"159.041033ms","start":"2026-06-13T22:43:55.412833Z","end":"2026-06-13T22:43:55.571874Z","steps":["trace[1141622227] 'process raft request' (duration: 59.933738ms)","trace[1141622227] 'compare' (duration: 98.916411ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:44:05.141605Z","caller":"traceutil/trace.go:171","msg":"trace[1014815966] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"580.767029ms","start":"2026-06-13T22:44:04.560777Z","end":"2026-06-13T22:44:05.141544Z","steps":["trace[1014815966] 'process raft request' (duration: 508.252324ms)","trace[1014815966] 'compare' (duration: 72.099984ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:44:05.141721Z","caller":"traceutil/trace.go:171","msg":"trace[1060338058] linearizableReadLoop","detail":"{readStateIndex:1907; appliedIndex:1906; }","duration":"572.206076ms","start":"2026-06-13T22:44:04.56949Z","end":"2026-06-13T22:44:05.141696Z","steps":["trace[1060338058] 'read index received' (duration: 499.545818ms)","trace[1060338058] 'applied index is now lower than readState.Index' (duration: 72.659218ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:44:05.141766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:04.560758Z","time spent":"580.927413ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:44:05.142188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.783073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b580a301-a273-48ff-97cb-0785f4389ea5\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-13T22:44:05.142232Z","caller":"traceutil/trace.go:171","msg":"trace[1404302515] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b580a301-a273-48ff-97cb-0785f4389ea5; range_end:; response_count:1; response_revision:1836; }","duration":"378.884306ms","start":"2026-06-13T22:44:04.763339Z","end":"2026-06-13T22:44:05.142223Z","steps":["trace[1404302515] 'agreement among raft nodes before linearized reading' (duration: 378.741932ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:05.142259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:04.76331Z","time spent":"378.942578ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b580a301-a273-48ff-97cb-0785f4389ea5\" "} {"level":"warn","ts":"2026-06-13T22:44:05.142465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.973595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-13T22:44:05.142488Z","caller":"traceutil/trace.go:171","msg":"trace[877059090] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1836; }","duration":"573.021956ms","start":"2026-06-13T22:44:04.569456Z","end":"2026-06-13T22:44:05.142478Z","steps":["trace[877059090] 'agreement among raft nodes before linearized reading' (duration: 572.596886ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:05.142506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:04.569442Z","time spent":"573.060117ms","remote":"127.0.0.1:43232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-13T22:44:05.301873Z","caller":"traceutil/trace.go:171","msg":"trace[1937465470] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"149.473112ms","start":"2026-06-13T22:44:05.152367Z","end":"2026-06-13T22:44:05.30184Z","steps":["trace[1937465470] 'process raft request' (duration: 125.234839ms)","trace[1937465470] 'compare' (duration: 24.095309ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:44:05.778965Z","caller":"traceutil/trace.go:171","msg":"trace[1566565103] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1908; }","duration":"477.018568ms","start":"2026-06-13T22:44:05.301928Z","end":"2026-06-13T22:44:05.778946Z","steps":["trace[1566565103] 'read index received' (duration: 476.989018ms)","trace[1566565103] 'applied index is now lower than readState.Index' (duration: 28.71µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:44:05.779034Z","caller":"traceutil/trace.go:171","msg":"trace[2146451657] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"526.649643ms","start":"2026-06-13T22:44:05.252337Z","end":"2026-06-13T22:44:05.778987Z","steps":["trace[2146451657] 'process raft request' (duration: 526.478179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:05.779158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.210843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:44:05.779246Z","caller":"traceutil/trace.go:171","msg":"trace[2137672855] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1838; }","duration":"477.352477ms","start":"2026-06-13T22:44:05.301885Z","end":"2026-06-13T22:44:05.779237Z","steps":["trace[2137672855] 'agreement among raft nodes before linearized reading' (duration: 477.205293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:05.779301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:05.301859Z","time spent":"477.433538ms","remote":"127.0.0.1:39144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-13T22:44:05.779485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:05.252307Z","time spent":"526.809518ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:44:05.852332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.315537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b580a301-a273-48ff-97cb-0785f4389ea5\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-06-13T22:44:05.852469Z","caller":"traceutil/trace.go:171","msg":"trace[691141930] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b580a301-a273-48ff-97cb-0785f4389ea5; range_end:; response_count:1; response_revision:1839; }","duration":"353.453021ms","start":"2026-06-13T22:44:05.498971Z","end":"2026-06-13T22:44:05.852424Z","steps":["trace[691141930] 'agreement among raft nodes before linearized reading' (duration: 353.239416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:05.852581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:05.498951Z","time spent":"353.617045ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b580a301-a273-48ff-97cb-0785f4389ea5\" "} {"level":"warn","ts":"2026-06-13T22:44:05.852621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.774611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-13T22:44:05.852692Z","caller":"traceutil/trace.go:171","msg":"trace[1341395137] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:1839; }","duration":"442.854073ms","start":"2026-06-13T22:44:05.409821Z","end":"2026-06-13T22:44:05.852675Z","steps":["trace[1341395137] 'agreement among raft nodes before linearized reading' (duration: 442.689108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:05.852732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:05.409768Z","time spent":"442.955886ms","remote":"127.0.0.1:39180","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.205\" "} {"level":"info","ts":"2026-06-13T22:44:05.974321Z","caller":"traceutil/trace.go:171","msg":"trace[709083087] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"117.595005ms","start":"2026-06-13T22:44:05.85671Z","end":"2026-06-13T22:44:05.974305Z","steps":["trace[709083087] 'process raft request' (duration: 115.999324ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:05.974544Z","caller":"traceutil/trace.go:171","msg":"trace[652763373] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"117.264076ms","start":"2026-06-13T22:44:05.85727Z","end":"2026-06-13T22:44:05.974534Z","steps":["trace[652763373] 'process raft request' (duration: 116.99547ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:09.320201Z","caller":"traceutil/trace.go:171","msg":"trace[792884916] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"154.666783ms","start":"2026-06-13T22:44:09.165511Z","end":"2026-06-13T22:44:09.320178Z","steps":["trace[792884916] 'process raft request' (duration: 154.55938ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:09.320277Z","caller":"traceutil/trace.go:171","msg":"trace[29164770] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1952; }","duration":"148.18055ms","start":"2026-06-13T22:44:09.172074Z","end":"2026-06-13T22:44:09.320254Z","steps":["trace[29164770] 'read index received' (duration: 148.170629ms)","trace[29164770] 'applied index is now lower than readState.Index' (duration: 8.131µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:44:09.320473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.383805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-13T22:44:09.320533Z","caller":"traceutil/trace.go:171","msg":"trace[1518348649] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1879; }","duration":"148.473867ms","start":"2026-06-13T22:44:09.17204Z","end":"2026-06-13T22:44:09.320514Z","steps":["trace[1518348649] 'agreement among raft nodes before linearized reading' (duration: 148.321182ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:09.556326Z","caller":"traceutil/trace.go:171","msg":"trace[1302263287] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1954; }","duration":"107.681706ms","start":"2026-06-13T22:44:09.44862Z","end":"2026-06-13T22:44:09.556302Z","steps":["trace[1302263287] 'read index received' (duration: 107.44519ms)","trace[1302263287] 'applied index is now lower than readState.Index' (duration: 235.336µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:44:09.556501Z","caller":"traceutil/trace.go:171","msg":"trace[330141020] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"151.59547ms","start":"2026-06-13T22:44:09.40488Z","end":"2026-06-13T22:44:09.556476Z","steps":["trace[330141020] 'process raft request' (duration: 151.274031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:09.556652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.008126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-06-13T22:44:09.556727Z","caller":"traceutil/trace.go:171","msg":"trace[1834390476] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1882; }","duration":"108.125688ms","start":"2026-06-13T22:44:09.448588Z","end":"2026-06-13T22:44:09.556714Z","steps":["trace[1834390476] 'agreement among raft nodes before linearized reading' (duration: 107.79629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:09.759358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.940791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-06-13T22:44:09.75947Z","caller":"traceutil/trace.go:171","msg":"trace[1620777552] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1882; }","duration":"109.097525ms","start":"2026-06-13T22:44:09.650353Z","end":"2026-06-13T22:44:09.759451Z","steps":["trace[1620777552] 'range keys from in-memory index tree' (duration: 108.807347ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:10.418325Z","caller":"traceutil/trace.go:171","msg":"trace[1898667471] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"108.602069ms","start":"2026-06-13T22:44:10.309692Z","end":"2026-06-13T22:44:10.418294Z","steps":["trace[1898667471] 'process raft request' (duration: 108.411934ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:10.580758Z","caller":"traceutil/trace.go:171","msg":"trace[1580952285] transaction","detail":"{read_only:false; response_revision:1892; number_of_response:1; }","duration":"153.74075ms","start":"2026-06-13T22:44:10.42698Z","end":"2026-06-13T22:44:10.580721Z","steps":["trace[1580952285] 'process raft request' (duration: 149.266319ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:10.580963Z","caller":"traceutil/trace.go:171","msg":"trace[1731359525] transaction","detail":"{read_only:false; response_revision:1893; number_of_response:1; }","duration":"152.913688ms","start":"2026-06-13T22:44:10.428021Z","end":"2026-06-13T22:44:10.580935Z","steps":["trace[1731359525] 'process raft request' (duration: 152.62216ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:15.047754Z","caller":"traceutil/trace.go:171","msg":"trace[1357410468] linearizableReadLoop","detail":"{readStateIndex:2004; appliedIndex:2002; }","duration":"175.425911ms","start":"2026-06-13T22:44:14.872309Z","end":"2026-06-13T22:44:15.047735Z","steps":["trace[1357410468] 'read index received' (duration: 49.984098ms)","trace[1357410468] 'applied index is now lower than readState.Index' (duration: 125.440833ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:44:15.047852Z","caller":"traceutil/trace.go:171","msg":"trace[2106829536] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"200.06531ms","start":"2026-06-13T22:44:14.84778Z","end":"2026-06-13T22:44:15.047845Z","steps":["trace[2106829536] 'process raft request' (duration: 199.835033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:15.048184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.531604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-06-13T22:44:15.048272Z","caller":"traceutil/trace.go:171","msg":"trace[275974264] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1930; }","duration":"126.667777ms","start":"2026-06-13T22:44:14.921583Z","end":"2026-06-13T22:44:15.04825Z","steps":["trace[275974264] 'agreement among raft nodes before linearized reading' (duration: 126.446221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:15.048352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.037499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:44:15.048387Z","caller":"traceutil/trace.go:171","msg":"trace[1463104004] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1930; }","duration":"176.0879ms","start":"2026-06-13T22:44:14.872289Z","end":"2026-06-13T22:44:15.048377Z","steps":["trace[1463104004] 'agreement among raft nodes before linearized reading' (duration: 176.006398ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:20.378993Z","caller":"traceutil/trace.go:171","msg":"trace[362660489] linearizableReadLoop","detail":"{readStateIndex:2037; appliedIndex:2036; }","duration":"224.205589ms","start":"2026-06-13T22:44:20.154769Z","end":"2026-06-13T22:44:20.378975Z","steps":["trace[362660489] 'read index received' (duration: 215.547947ms)","trace[362660489] 'applied index is now lower than readState.Index' (duration: 8.656882ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:44:20.379084Z","caller":"traceutil/trace.go:171","msg":"trace[262668508] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"234.193731ms","start":"2026-06-13T22:44:20.144883Z","end":"2026-06-13T22:44:20.379077Z","steps":["trace[262668508] 'process raft request' (duration: 225.518109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:20.379257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.851116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-13T22:44:20.379355Z","caller":"traceutil/trace.go:171","msg":"trace[221644007] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1962; }","duration":"208.98056ms","start":"2026-06-13T22:44:20.170351Z","end":"2026-06-13T22:44:20.379331Z","steps":["trace[221644007] 'agreement among raft nodes before linearized reading' (duration: 208.757223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:20.379477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.464539ms","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-13T22:44:20.379503Z","caller":"traceutil/trace.go:171","msg":"trace[1708397783] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1962; }","duration":"184.513581ms","start":"2026-06-13T22:44:20.194983Z","end":"2026-06-13T22:44:20.379497Z","steps":["trace[1708397783] 'agreement among raft nodes before linearized reading' (duration: 184.394417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:20.379623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.839849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-messaging-topology-operator-7f8596f788-2sdl4\" ","response":"range_response_count:1 size:6111"} {"level":"info","ts":"2026-06-13T22:44:20.379682Z","caller":"traceutil/trace.go:171","msg":"trace[1696638655] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-messaging-topology-operator-7f8596f788-2sdl4; range_end:; response_count:1; response_revision:1962; }","duration":"224.950512ms","start":"2026-06-13T22:44:20.154715Z","end":"2026-06-13T22:44:20.379665Z","steps":["trace[1696638655] 'agreement among raft nodes before linearized reading' (duration: 224.763356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:20.379718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.798133ms","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-13T22:44:20.379773Z","caller":"traceutil/trace.go:171","msg":"trace[2010669171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1962; }","duration":"205.861645ms","start":"2026-06-13T22:44:20.173897Z","end":"2026-06-13T22:44:20.379759Z","steps":["trace[2010669171] 'agreement among raft nodes before linearized reading' (duration: 205.724941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:20.380145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.791039ms","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-13T22:44:20.380176Z","caller":"traceutil/trace.go:171","msg":"trace[478565276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1962; }","duration":"184.863231ms","start":"2026-06-13T22:44:20.195306Z","end":"2026-06-13T22:44:20.380169Z","steps":["trace[478565276] 'agreement among raft nodes before linearized reading' (duration: 183.978864ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:34.91488Z","caller":"traceutil/trace.go:171","msg":"trace[891459820] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"113.274631ms","start":"2026-06-13T22:44:34.801561Z","end":"2026-06-13T22:44:34.914835Z","steps":["trace[891459820] 'process raft request' (duration: 113.094225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:41.069173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.107706ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:44:41.069429Z","caller":"traceutil/trace.go:171","msg":"trace[884201787] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"518.106295ms","start":"2026-06-13T22:44:40.551292Z","end":"2026-06-13T22:44:41.069398Z","steps":["trace[884201787] 'process raft request' (duration: 329.677258ms)","trace[884201787] 'compare' (duration: 187.706532ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:44:41.069587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:40.551279Z","time spent":"518.228889ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:44:41.06961Z","caller":"traceutil/trace.go:171","msg":"trace[1098315913] linearizableReadLoop","detail":"{readStateIndex:2167; appliedIndex:2166; }","duration":"436.586439ms","start":"2026-06-13T22:44:40.632986Z","end":"2026-06-13T22:44:41.069573Z","steps":["trace[1098315913] 'read index received' (duration: 248.001416ms)","trace[1098315913] 'applied index is now lower than readState.Index' (duration: 188.581382ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:44:41.099268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.261669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-06-13T22:44:41.099312Z","caller":"traceutil/trace.go:171","msg":"trace[998736907] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2088; }","duration":"466.326791ms","start":"2026-06-13T22:44:40.632972Z","end":"2026-06-13T22:44:41.099299Z","steps":["trace[998736907] 'agreement among raft nodes before linearized reading' (duration: 436.743945ms)","trace[998736907] 'range keys from in-memory index tree' (duration: 29.430781ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:44:41.099335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:40.632917Z","time spent":"466.412444ms","remote":"127.0.0.1:43232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-13T22:44:41.099344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.922797ms","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-13T22:44:41.099407Z","caller":"traceutil/trace.go:171","msg":"trace[1980203349] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2088; }","duration":"163.01813ms","start":"2026-06-13T22:44:40.936365Z","end":"2026-06-13T22:44:41.099383Z","steps":["trace[1980203349] 'agreement among raft nodes before linearized reading' (duration: 162.805002ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:41.250581Z","caller":"traceutil/trace.go:171","msg":"trace[1174899031] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"146.814561ms","start":"2026-06-13T22:44:41.103742Z","end":"2026-06-13T22:44:41.250556Z","steps":["trace[1174899031] 'process raft request' (duration: 146.655466ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:41.418282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.687426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:44:41.418357Z","caller":"traceutil/trace.go:171","msg":"trace[911916960] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2089; }","duration":"116.81389ms","start":"2026-06-13T22:44:41.301525Z","end":"2026-06-13T22:44:41.418338Z","steps":["trace[911916960] 'range keys from in-memory index tree' (duration: 116.545861ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:44:41.700718Z","caller":"traceutil/trace.go:171","msg":"trace[1201002498] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"159.850272ms","start":"2026-06-13T22:44:41.540844Z","end":"2026-06-13T22:44:41.700694Z","steps":["trace[1201002498] 'process raft request' (duration: 159.709127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:44:42.100925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.104855ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:44:42.101265Z","caller":"traceutil/trace.go:171","msg":"trace[992294511] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"535.930417ms","start":"2026-06-13T22:44:41.565308Z","end":"2026-06-13T22:44:42.101239Z","steps":["trace[992294511] 'process raft request' (duration: 361.305353ms)","trace[992294511] 'compare' (duration: 173.799675ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:44:42.101397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:44:41.565297Z","time spent":"536.033611ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:44:42.60729Z","caller":"traceutil/trace.go:171","msg":"trace[1347325173] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"103.946398ms","start":"2026-06-13T22:44:42.503308Z","end":"2026-06-13T22:44:42.607254Z","steps":["trace[1347325173] 'process raft request' (duration: 83.356185ms)","trace[1347325173] 'compare' (duration: 20.441967ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:46:15.325203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.105448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-13T22:46:15.325695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.788741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-13T22:46:15.325733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.56689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-13T22:46:15.32578Z","caller":"traceutil/trace.go:171","msg":"trace[2121474852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2700; }","duration":"273.901926ms","start":"2026-06-13T22:46:15.051861Z","end":"2026-06-13T22:46:15.325762Z","steps":["trace[2121474852] 'range keys from in-memory index tree' (duration: 273.621563ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:15.325787Z","caller":"traceutil/trace.go:171","msg":"trace[740590950] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2700; }","duration":"298.638733ms","start":"2026-06-13T22:46:15.027135Z","end":"2026-06-13T22:46:15.325773Z","steps":["trace[740590950] 'range keys from in-memory index tree' (duration: 298.389372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:46:15.325498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.912915ms","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-13T22:46:15.326121Z","caller":"traceutil/trace.go:171","msg":"trace[1199279984] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2700; }","duration":"306.554863ms","start":"2026-06-13T22:46:15.01953Z","end":"2026-06-13T22:46:15.326085Z","steps":["trace[1199279984] 'range keys from in-memory index tree' (duration: 305.780679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:46:15.326234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:46:15.019516Z","time spent":"306.678569ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-13T22:46:15.326466Z","caller":"traceutil/trace.go:171","msg":"trace[1853040400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2700; }","duration":"269.682524ms","start":"2026-06-13T22:46:15.055997Z","end":"2026-06-13T22:46:15.325679Z","steps":["trace[1853040400] 'range keys from in-memory index tree' (duration: 268.797774ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:46:15.650586Z","caller":"traceutil/trace.go:171","msg":"trace[2082935474] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"210.418755ms","start":"2026-06-13T22:46:15.440137Z","end":"2026-06-13T22:46:15.650556Z","steps":["trace[2082935474] 'process raft request' (duration: 210.283439ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:12.113653Z","caller":"traceutil/trace.go:171","msg":"trace[339019756] linearizableReadLoop","detail":"{readStateIndex:3522; appliedIndex:3521; }","duration":"108.454343ms","start":"2026-06-13T22:48:12.005173Z","end":"2026-06-13T22:48:12.113627Z","steps":["trace[339019756] 'read index received' (duration: 108.200668ms)","trace[339019756] 'applied index is now lower than readState.Index' (duration: 252.625µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:48:12.11406Z","caller":"traceutil/trace.go:171","msg":"trace[2102266879] transaction","detail":"{read_only:false; response_revision:3391; number_of_response:1; }","duration":"109.2823ms","start":"2026-06-13T22:48:12.004762Z","end":"2026-06-13T22:48:12.114044Z","steps":["trace[2102266879] 'process raft request' (duration: 108.683588ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:12.114436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.237389ms","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-13T22:48:12.114484Z","caller":"traceutil/trace.go:171","msg":"trace[855505045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3391; }","duration":"109.312801ms","start":"2026-06-13T22:48:12.005158Z","end":"2026-06-13T22:48:12.114471Z","steps":["trace[855505045] 'agreement among raft nodes before linearized reading' (duration: 109.152078ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:48:12.120376Z","caller":"traceutil/trace.go:171","msg":"trace[1550048398] transaction","detail":"{read_only:false; response_revision:3392; number_of_response:1; }","duration":"115.065514ms","start":"2026-06-13T22:48:12.005283Z","end":"2026-06-13T22:48:12.120348Z","steps":["trace[1550048398] 'process raft request' (duration: 114.790629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:12.120985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.670897ms","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-13T22:48:12.121197Z","caller":"traceutil/trace.go:171","msg":"trace[951150450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3392; }","duration":"112.951083ms","start":"2026-06-13T22:48:12.008222Z","end":"2026-06-13T22:48:12.121173Z","steps":["trace[951150450] 'agreement among raft nodes before linearized reading' (duration: 112.041775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:48:41.20707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.417697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:48:41.207745Z","caller":"traceutil/trace.go:171","msg":"trace[1576806798] transaction","detail":"{read_only:false; response_revision:3560; number_of_response:1; }","duration":"177.460158ms","start":"2026-06-13T22:48:41.030221Z","end":"2026-06-13T22:48:41.207681Z","steps":["trace[1576806798] 'process raft request' (duration: 62.325044ms)","trace[1576806798] 'compare' (duration: 114.262373ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:48:57.583736Z","caller":"traceutil/trace.go:171","msg":"trace[20523501] transaction","detail":"{read_only:false; response_revision:3650; number_of_response:1; }","duration":"141.828718ms","start":"2026-06-13T22:48:57.441867Z","end":"2026-06-13T22:48:57.583696Z","steps":["trace[20523501] 'process raft request' (duration: 141.594832ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:24.089833Z","caller":"traceutil/trace.go:171","msg":"trace[1364114625] transaction","detail":"{read_only:false; response_revision:3855; number_of_response:1; }","duration":"189.756681ms","start":"2026-06-13T22:49:23.900057Z","end":"2026-06-13T22:49:24.089813Z","steps":["trace[1364114625] 'process raft request' (duration: 189.632987ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:25.044267Z","caller":"traceutil/trace.go:171","msg":"trace[1765341866] transaction","detail":"{read_only:false; response_revision:3861; number_of_response:1; }","duration":"110.830325ms","start":"2026-06-13T22:49:24.933409Z","end":"2026-06-13T22:49:25.044239Z","steps":["trace[1765341866] 'process raft request' (duration: 110.639049ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:39.283047Z","caller":"traceutil/trace.go:171","msg":"trace[1984530011] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3944; }","duration":"119.644095ms","start":"2026-06-13T22:49:39.163362Z","end":"2026-06-13T22:49:39.283006Z","steps":["trace[1984530011] 'process raft request' (duration: 115.811714ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:39.872238Z","caller":"traceutil/trace.go:171","msg":"trace[1788731249] linearizableReadLoop","detail":"{readStateIndex:4107; appliedIndex:4106; }","duration":"110.720673ms","start":"2026-06-13T22:49:39.761488Z","end":"2026-06-13T22:49:39.872209Z","steps":["trace[1788731249] 'read index received' (duration: 109.99755ms)","trace[1788731249] 'applied index is now lower than readState.Index' (duration: 721.533µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:39.872342Z","caller":"traceutil/trace.go:171","msg":"trace[1738484271] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3946; }","duration":"213.905308ms","start":"2026-06-13T22:49:39.658399Z","end":"2026-06-13T22:49:39.872304Z","steps":["trace[1738484271] 'process raft request' (duration: 213.219257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:39.872631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.019412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-13T22:49:39.872722Z","caller":"traceutil/trace.go:171","msg":"trace[771913746] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3946; }","duration":"111.223229ms","start":"2026-06-13T22:49:39.761477Z","end":"2026-06-13T22:49:39.872701Z","steps":["trace[771913746] 'agreement among raft nodes before linearized reading' (duration: 110.826966ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:40.965335Z","caller":"traceutil/trace.go:171","msg":"trace[855647993] transaction","detail":"{read_only:false; response_revision:3953; number_of_response:1; }","duration":"141.389684ms","start":"2026-06-13T22:49:40.823926Z","end":"2026-06-13T22:49:40.965315Z","steps":["trace[855647993] 'process raft request' (duration: 141.335552ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:40.965621Z","caller":"traceutil/trace.go:171","msg":"trace[341996258] transaction","detail":"{read_only:false; response_revision:3952; number_of_response:1; }","duration":"141.983512ms","start":"2026-06-13T22:49:40.823629Z","end":"2026-06-13T22:49:40.965613Z","steps":["trace[341996258] 'process raft request' (duration: 94.411977ms)","trace[341996258] 'compare' (duration: 47.134561ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:43.622718Z","caller":"traceutil/trace.go:171","msg":"trace[1004173317] transaction","detail":"{read_only:false; response_revision:3964; number_of_response:1; }","duration":"135.219997ms","start":"2026-06-13T22:49:43.487482Z","end":"2026-06-13T22:49:43.622702Z","steps":["trace[1004173317] 'process raft request' (duration: 135.077732ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:43.935217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.750218ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:49:43.935659Z","caller":"traceutil/trace.go:171","msg":"trace[1168678716] transaction","detail":"{read_only:false; response_revision:3965; number_of_response:1; }","duration":"233.209394ms","start":"2026-06-13T22:49:43.702434Z","end":"2026-06-13T22:49:43.935644Z","steps":["trace[1168678716] 'process raft request' (duration: 52.94223ms)","trace[1168678716] 'compare' (duration: 179.613323ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:43.935813Z","caller":"traceutil/trace.go:171","msg":"trace[346503503] transaction","detail":"{read_only:false; response_revision:3966; number_of_response:1; }","duration":"213.6717ms","start":"2026-06-13T22:49:43.722134Z","end":"2026-06-13T22:49:43.935806Z","steps":["trace[346503503] 'process raft request' (duration: 213.180755ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:48.160654Z","caller":"traceutil/trace.go:171","msg":"trace[1867363185] transaction","detail":"{read_only:false; response_revision:3986; number_of_response:1; }","duration":"205.364323ms","start":"2026-06-13T22:49:47.955259Z","end":"2026-06-13T22:49:48.160623Z","steps":["trace[1867363185] 'process raft request' (duration: 205.170207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:48.438522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.489158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:49:48.438742Z","caller":"traceutil/trace.go:171","msg":"trace[1982872959] transaction","detail":"{read_only:false; response_revision:3988; number_of_response:1; }","duration":"216.956983ms","start":"2026-06-13T22:49:48.221768Z","end":"2026-06-13T22:49:48.438725Z","steps":["trace[1982872959] 'process raft request' (duration: 216.86321ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:48.43877Z","caller":"traceutil/trace.go:171","msg":"trace[2010734194] linearizableReadLoop","detail":"{readStateIndex:4152; appliedIndex:4151; }","duration":"278.018079ms","start":"2026-06-13T22:49:48.160728Z","end":"2026-06-13T22:49:48.438746Z","steps":["trace[2010734194] 'read index received' (duration: 120.333945ms)","trace[2010734194] 'applied index is now lower than readState.Index' (duration: 157.676484ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:48.438882Z","caller":"traceutil/trace.go:171","msg":"trace[578935932] transaction","detail":"{read_only:false; response_revision:3987; number_of_response:1; }","duration":"292.371315ms","start":"2026-06-13T22:49:48.146501Z","end":"2026-06-13T22:49:48.438872Z","steps":["trace[578935932] 'process raft request' (duration: 134.428312ms)","trace[578935932] 'compare' (duration: 157.279001ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:48.43916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.418973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-06-13T22:49:48.439202Z","caller":"traceutil/trace.go:171","msg":"trace[1075952528] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3988; }","duration":"278.509666ms","start":"2026-06-13T22:49:48.16068Z","end":"2026-06-13T22:49:48.43919Z","steps":["trace[1075952528] 'agreement among raft nodes before linearized reading' (duration: 278.33035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:48.439229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.311112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:49:48.439295Z","caller":"traceutil/trace.go:171","msg":"trace[1585683580] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3988; }","duration":"136.413996ms","start":"2026-06-13T22:49:48.302864Z","end":"2026-06-13T22:49:48.439278Z","steps":["trace[1585683580] 'agreement among raft nodes before linearized reading' (duration: 136.318573ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:53.651382Z","caller":"traceutil/trace.go:171","msg":"trace[1652774717] transaction","detail":"{read_only:false; response_revision:4015; number_of_response:1; }","duration":"110.578057ms","start":"2026-06-13T22:49:53.540764Z","end":"2026-06-13T22:49:53.651342Z","steps":["trace[1652774717] 'process raft request' (duration: 110.109851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:53.85559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.347864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:49:53.855684Z","caller":"traceutil/trace.go:171","msg":"trace[701198477] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission; range_end:; response_count:0; response_revision:4015; }","duration":"165.496949ms","start":"2026-06-13T22:49:53.690162Z","end":"2026-06-13T22:49:53.855659Z","steps":["trace[701198477] 'range keys from in-memory index tree' (duration: 165.262021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:53.855769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.74051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-13T22:49:53.855903Z","caller":"traceutil/trace.go:171","msg":"trace[486071184] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4015; }","duration":"127.948057ms","start":"2026-06-13T22:49:53.727928Z","end":"2026-06-13T22:49:53.855876Z","steps":["trace[486071184] 'range keys from in-memory index tree' (duration: 127.500002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:54.436353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.555735ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:49:54.436475Z","caller":"traceutil/trace.go:171","msg":"trace[1702600712] linearizableReadLoop","detail":"{readStateIndex:4188; appliedIndex:4187; }","duration":"176.489584ms","start":"2026-06-13T22:49:54.259965Z","end":"2026-06-13T22:49:54.436455Z","steps":["trace[1702600712] 'read index received' (duration: 34.700191ms)","trace[1702600712] 'applied index is now lower than readState.Index' (duration: 141.787993ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:54.436728Z","caller":"traceutil/trace.go:171","msg":"trace[290717215] transaction","detail":"{read_only:false; response_revision:4021; number_of_response:1; }","duration":"197.091851ms","start":"2026-06-13T22:49:54.239604Z","end":"2026-06-13T22:49:54.436695Z","steps":["trace[290717215] 'process raft request' (duration: 55.105722ms)","trace[290717215] 'compare' (duration: 141.305517ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:54.436765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.788574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:49:54.436805Z","caller":"traceutil/trace.go:171","msg":"trace[180431953] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:4021; }","duration":"176.845425ms","start":"2026-06-13T22:49:54.259948Z","end":"2026-06-13T22:49:54.436793Z","steps":["trace[180431953] 'agreement among raft nodes before linearized reading' (duration: 176.724902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:54.436907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.059445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:49:54.437016Z","caller":"traceutil/trace.go:171","msg":"trace[1883953771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4021; }","duration":"136.195589ms","start":"2026-06-13T22:49:54.300808Z","end":"2026-06-13T22:49:54.437004Z","steps":["trace[1883953771] 'agreement among raft nodes before linearized reading' (duration: 136.019854ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:54.599518Z","caller":"traceutil/trace.go:171","msg":"trace[948222018] transaction","detail":"{read_only:false; response_revision:4022; number_of_response:1; }","duration":"111.433815ms","start":"2026-06-13T22:49:54.488061Z","end":"2026-06-13T22:49:54.599495Z","steps":["trace[948222018] 'process raft request' (duration: 103.647049ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:54.713607Z","caller":"traceutil/trace.go:171","msg":"trace[2011486531] transaction","detail":"{read_only:false; response_revision:4023; number_of_response:1; }","duration":"140.17703ms","start":"2026-06-13T22:49:54.573384Z","end":"2026-06-13T22:49:54.713561Z","steps":["trace[2011486531] 'process raft request' (duration: 139.191948ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:54.714426Z","caller":"traceutil/trace.go:171","msg":"trace[2100490078] transaction","detail":"{read_only:false; response_revision:4024; number_of_response:1; }","duration":"137.978108ms","start":"2026-06-13T22:49:54.576416Z","end":"2026-06-13T22:49:54.714395Z","steps":["trace[2100490078] 'process raft request' (duration: 137.283955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:54.952856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.196818ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:49:54.953733Z","caller":"traceutil/trace.go:171","msg":"trace[1374004005] transaction","detail":"{read_only:false; response_revision:4026; number_of_response:1; }","duration":"191.239299ms","start":"2026-06-13T22:49:54.762452Z","end":"2026-06-13T22:49:54.953691Z","steps":["trace[1374004005] 'process raft request' (duration: 51.144992ms)","trace[1374004005] 'compare' (duration: 139.057263ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:54.954251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.839386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:49:54.954158Z","caller":"traceutil/trace.go:171","msg":"trace[1911962707] linearizableReadLoop","detail":"{readStateIndex:4193; appliedIndex:4192; }","duration":"176.726172ms","start":"2026-06-13T22:49:54.777401Z","end":"2026-06-13T22:49:54.954128Z","steps":["trace[1911962707] 'read index received' (duration: 36.088486ms)","trace[1911962707] 'applied index is now lower than readState.Index' (duration: 140.576974ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:54.954305Z","caller":"traceutil/trace.go:171","msg":"trace[1543177106] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:4026; }","duration":"176.952779ms","start":"2026-06-13T22:49:54.777341Z","end":"2026-06-13T22:49:54.954294Z","steps":["trace[1543177106] 'agreement among raft nodes before linearized reading' (duration: 176.848946ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:54.956005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.337599ms","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-13T22:49:54.956058Z","caller":"traceutil/trace.go:171","msg":"trace[1281922894] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4027; }","duration":"169.410582ms","start":"2026-06-13T22:49:54.786634Z","end":"2026-06-13T22:49:54.956045Z","steps":["trace[1281922894] 'agreement among raft nodes before linearized reading' (duration: 169.223045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:54.956436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.008262ms","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-13T22:49:54.956488Z","caller":"traceutil/trace.go:171","msg":"trace[702810011] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4027; }","duration":"115.108046ms","start":"2026-06-13T22:49:54.841368Z","end":"2026-06-13T22:49:54.956476Z","steps":["trace[702810011] 'agreement among raft nodes before linearized reading' (duration: 114.978152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:55.672278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.825433ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:49:55.672833Z","caller":"traceutil/trace.go:171","msg":"trace[158507940] transaction","detail":"{read_only:false; response_revision:4035; number_of_response:1; }","duration":"343.35097ms","start":"2026-06-13T22:49:55.329449Z","end":"2026-06-13T22:49:55.6728Z","steps":["trace[158507940] 'process raft request' (duration: 164.39316ms)","trace[158507940] 'compare' (duration: 177.648787ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:55.672955Z","caller":"traceutil/trace.go:171","msg":"trace[944802513] linearizableReadLoop","detail":"{readStateIndex:4202; appliedIndex:4201; }","duration":"343.128593ms","start":"2026-06-13T22:49:55.329773Z","end":"2026-06-13T22:49:55.672901Z","steps":["trace[944802513] 'read index received' (duration: 164.060979ms)","trace[944802513] 'applied index is now lower than readState.Index' (duration: 179.064784ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:55.673073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:55.329437Z","time spent":"343.475465ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:49:55.673145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.354311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:49:55.673202Z","caller":"traceutil/trace.go:171","msg":"trace[892242982] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4035; }","duration":"343.426273ms","start":"2026-06-13T22:49:55.329758Z","end":"2026-06-13T22:49:55.673184Z","steps":["trace[892242982] 'agreement among raft nodes before linearized reading' (duration: 343.32562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:55.673243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:49:55.329752Z","time spent":"343.483475ms","remote":"127.0.0.1:39356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-13T22:49:55.673456Z","caller":"traceutil/trace.go:171","msg":"trace[781882481] transaction","detail":"{read_only:false; response_revision:4036; number_of_response:1; }","duration":"238.38507ms","start":"2026-06-13T22:49:55.435056Z","end":"2026-06-13T22:49:55.673441Z","steps":["trace[781882481] 'process raft request' (duration: 237.757279ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:55.673686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.163727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.205\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-13T22:49:55.675083Z","caller":"traceutil/trace.go:171","msg":"trace[959419504] range","detail":"{range_begin:/registry/masterleases/199.204.45.205; range_end:; response_count:1; response_revision:4036; }","duration":"244.624605ms","start":"2026-06-13T22:49:55.430447Z","end":"2026-06-13T22:49:55.675072Z","steps":["trace[959419504] 'agreement among raft nodes before linearized reading' (duration: 242.94029ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:57.095661Z","caller":"traceutil/trace.go:171","msg":"trace[550294254] transaction","detail":"{read_only:false; response_revision:4053; number_of_response:1; }","duration":"116.124986ms","start":"2026-06-13T22:49:56.979495Z","end":"2026-06-13T22:49:57.09562Z","steps":["trace[550294254] 'process raft request' (duration: 115.844626ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:57.183806Z","caller":"traceutil/trace.go:171","msg":"trace[1766684068] linearizableReadLoop","detail":"{readStateIndex:4222; appliedIndex:4220; }","duration":"199.353404ms","start":"2026-06-13T22:49:56.984424Z","end":"2026-06-13T22:49:57.183777Z","steps":["trace[1766684068] 'read index received' (duration: 110.934164ms)","trace[1766684068] 'applied index is now lower than readState.Index' (duration: 88.41793ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:49:57.183913Z","caller":"traceutil/trace.go:171","msg":"trace[1179896601] transaction","detail":"{read_only:false; response_revision:4054; number_of_response:1; }","duration":"201.878877ms","start":"2026-06-13T22:49:56.982001Z","end":"2026-06-13T22:49:57.18388Z","steps":["trace[1179896601] 'process raft request' (duration: 159.252845ms)","trace[1179896601] 'compare' (duration: 42.375694ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:49:57.184255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.797818ms","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-13T22:49:57.184304Z","caller":"traceutil/trace.go:171","msg":"trace[315311781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4054; }","duration":"199.888152ms","start":"2026-06-13T22:49:56.984404Z","end":"2026-06-13T22:49:57.184292Z","steps":["trace[315311781] 'agreement among raft nodes before linearized reading' (duration: 199.53496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:49:57.184374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.299846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T22:49:57.18451Z","caller":"traceutil/trace.go:171","msg":"trace[251010180] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:4054; }","duration":"152.578195ms","start":"2026-06-13T22:49:57.031887Z","end":"2026-06-13T22:49:57.184465Z","steps":["trace[251010180] 'agreement among raft nodes before linearized reading' (duration: 152.244774ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:49:58.348489Z","caller":"traceutil/trace.go:171","msg":"trace[178302842] transaction","detail":"{read_only:false; response_revision:4063; number_of_response:1; }","duration":"123.363978ms","start":"2026-06-13T22:49:58.225096Z","end":"2026-06-13T22:49:58.34846Z","steps":["trace[178302842] 'process raft request' (duration: 122.607783ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:04.340442Z","caller":"traceutil/trace.go:171","msg":"trace[893983828] linearizableReadLoop","detail":"{readStateIndex:4623; appliedIndex:4622; }","duration":"211.964332ms","start":"2026-06-13T22:50:04.128456Z","end":"2026-06-13T22:50:04.34042Z","steps":["trace[893983828] 'read index received' (duration: 211.860799ms)","trace[893983828] 'applied index is now lower than readState.Index' (duration: 87.503µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:04.340624Z","caller":"traceutil/trace.go:171","msg":"trace[1343401281] transaction","detail":"{read_only:false; response_revision:4448; number_of_response:1; }","duration":"219.134124ms","start":"2026-06-13T22:50:04.12148Z","end":"2026-06-13T22:50:04.340614Z","steps":["trace[1343401281] 'process raft request' (duration: 218.790142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:04.34092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.452348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-06-13T22:50:04.340996Z","caller":"traceutil/trace.go:171","msg":"trace[1642482554] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4448; }","duration":"212.583693ms","start":"2026-06-13T22:50:04.128395Z","end":"2026-06-13T22:50:04.340979Z","steps":["trace[1642482554] 'agreement among raft nodes before linearized reading' (duration: 212.309624ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:04.345205Z","caller":"traceutil/trace.go:171","msg":"trace[349501395] transaction","detail":"{read_only:false; response_revision:4451; number_of_response:1; }","duration":"155.738637ms","start":"2026-06-13T22:50:04.189377Z","end":"2026-06-13T22:50:04.345115Z","steps":["trace[349501395] 'process raft request' (duration: 155.556491ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:04.345323Z","caller":"traceutil/trace.go:171","msg":"trace[1800181170] transaction","detail":"{read_only:false; response_revision:4452; number_of_response:1; }","duration":"105.294568ms","start":"2026-06-13T22:50:04.240009Z","end":"2026-06-13T22:50:04.345304Z","steps":["trace[1800181170] 'process raft request' (duration: 104.960256ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:04.345669Z","caller":"traceutil/trace.go:171","msg":"trace[366669015] transaction","detail":"{read_only:false; response_revision:4449; number_of_response:1; }","duration":"212.437087ms","start":"2026-06-13T22:50:04.133214Z","end":"2026-06-13T22:50:04.345651Z","steps":["trace[366669015] 'process raft request' (duration: 211.565998ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:04.345897Z","caller":"traceutil/trace.go:171","msg":"trace[1651065294] transaction","detail":"{read_only:false; response_revision:4450; number_of_response:1; }","duration":"196.196681ms","start":"2026-06-13T22:50:04.149693Z","end":"2026-06-13T22:50:04.34589Z","steps":["trace[1651065294] 'process raft request' (duration: 195.188467ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:06.8402Z","caller":"traceutil/trace.go:171","msg":"trace[707392076] transaction","detail":"{read_only:false; response_revision:4551; number_of_response:1; }","duration":"180.367534ms","start":"2026-06-13T22:50:06.659774Z","end":"2026-06-13T22:50:06.840142Z","steps":["trace[707392076] 'process raft request' (duration: 175.21256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:09.209002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.418696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T22:50:09.209092Z","caller":"traceutil/trace.go:171","msg":"trace[842520248] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:4608; }","duration":"254.580771ms","start":"2026-06-13T22:50:08.954493Z","end":"2026-06-13T22:50:09.209074Z","steps":["trace[842520248] 'count revisions from in-memory index tree' (duration: 254.289021ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:09.411569Z","caller":"traceutil/trace.go:171","msg":"trace[1516503534] linearizableReadLoop","detail":"{readStateIndex:4787; appliedIndex:4786; }","duration":"158.539613ms","start":"2026-06-13T22:50:09.253002Z","end":"2026-06-13T22:50:09.411541Z","steps":["trace[1516503534] 'read index received' (duration: 158.392137ms)","trace[1516503534] 'applied index is now lower than readState.Index' (duration: 145.915µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:09.411916Z","caller":"traceutil/trace.go:171","msg":"trace[1961113693] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"187.655835ms","start":"2026-06-13T22:50:09.224246Z","end":"2026-06-13T22:50:09.411902Z","steps":["trace[1961113693] 'process raft request' (duration: 187.133547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:09.412718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.699142ms","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-13T22:50:09.41276Z","caller":"traceutil/trace.go:171","msg":"trace[177148732] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4609; }","duration":"159.795245ms","start":"2026-06-13T22:50:09.252955Z","end":"2026-06-13T22:50:09.41275Z","steps":["trace[177148732] 'agreement among raft nodes before linearized reading' (duration: 159.123172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:09.413414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.963275ms","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-13T22:50:09.413543Z","caller":"traceutil/trace.go:171","msg":"trace[742266701] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4609; }","duration":"156.138811ms","start":"2026-06-13T22:50:09.257375Z","end":"2026-06-13T22:50:09.413513Z","steps":["trace[742266701] 'agreement among raft nodes before linearized reading' (duration: 155.624333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:12.068142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.01317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:12.068266Z","caller":"traceutil/trace.go:171","msg":"trace[1955249926] linearizableReadLoop","detail":"{readStateIndex:4837; appliedIndex:4836; }","duration":"356.284167ms","start":"2026-06-13T22:50:11.711959Z","end":"2026-06-13T22:50:12.068243Z","steps":["trace[1955249926] 'read index received' (duration: 137.04768ms)","trace[1955249926] 'applied index is now lower than readState.Index' (duration: 219.235107ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:12.068525Z","caller":"traceutil/trace.go:171","msg":"trace[1447285318] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"421.449778ms","start":"2026-06-13T22:50:11.647015Z","end":"2026-06-13T22:50:12.068465Z","steps":["trace[1447285318] 'process raft request' (duration: 202.010424ms)","trace[1447285318] 'compare' (duration: 218.766911ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:12.068673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:11.647008Z","time spent":"421.568602ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9742,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:12.068894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.92947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-13T22:50:12.06899Z","caller":"traceutil/trace.go:171","msg":"trace[1016835314] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4656; }","duration":"357.040273ms","start":"2026-06-13T22:50:11.711909Z","end":"2026-06-13T22:50:12.068949Z","steps":["trace[1016835314] 'agreement among raft nodes before linearized reading' (duration: 356.844967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:12.069048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:11.711888Z","time spent":"357.146727ms","remote":"127.0.0.1:39244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3528,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-06-13T22:50:12.069121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.572041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-13T22:50:12.069285Z","caller":"traceutil/trace.go:171","msg":"trace[1874526696] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4656; }","duration":"241.80572ms","start":"2026-06-13T22:50:11.827448Z","end":"2026-06-13T22:50:12.069253Z","steps":["trace[1874526696] 'agreement among raft nodes before linearized reading' (duration: 241.286242ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:12.450055Z","caller":"traceutil/trace.go:171","msg":"trace[855979500] linearizableReadLoop","detail":"{readStateIndex:4841; appliedIndex:4840; }","duration":"150.178761ms","start":"2026-06-13T22:50:12.299842Z","end":"2026-06-13T22:50:12.450021Z","steps":["trace[855979500] 'read index received' (duration: 149.85389ms)","trace[855979500] 'applied index is now lower than readState.Index' (duration: 323.811µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:12.450398Z","caller":"traceutil/trace.go:171","msg":"trace[686256997] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"234.196742ms","start":"2026-06-13T22:50:12.216144Z","end":"2026-06-13T22:50:12.450341Z","steps":["trace[686256997] 'process raft request' (duration: 233.656943ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:12.451091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.221746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:12.451154Z","caller":"traceutil/trace.go:171","msg":"trace[1676722663] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4660; }","duration":"151.33629ms","start":"2026-06-13T22:50:12.299799Z","end":"2026-06-13T22:50:12.451135Z","steps":["trace[1676722663] 'agreement among raft nodes before linearized reading' (duration: 150.530522ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:12.672716Z","caller":"traceutil/trace.go:171","msg":"trace[360390592] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"216.220956ms","start":"2026-06-13T22:50:12.455013Z","end":"2026-06-13T22:50:12.671234Z","steps":["trace[360390592] 'process raft request' (duration: 126.344803ms)","trace[360390592] 'compare' (duration: 89.704197ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:12.695641Z","caller":"traceutil/trace.go:171","msg":"trace[1096668772] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"238.400116ms","start":"2026-06-13T22:50:12.457207Z","end":"2026-06-13T22:50:12.695607Z","steps":["trace[1096668772] 'process raft request' (duration: 238.115717ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:12.696106Z","caller":"traceutil/trace.go:171","msg":"trace[861561290] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"237.423533ms","start":"2026-06-13T22:50:12.458617Z","end":"2026-06-13T22:50:12.69604Z","steps":["trace[861561290] 'process raft request' (duration: 236.890585ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:12.696219Z","caller":"traceutil/trace.go:171","msg":"trace[1499841437] linearizableReadLoop","detail":"{readStateIndex:4844; appliedIndex:4841; }","duration":"212.998596ms","start":"2026-06-13T22:50:12.483199Z","end":"2026-06-13T22:50:12.696197Z","steps":["trace[1499841437] 'read index received' (duration: 98.135256ms)","trace[1499841437] 'applied index is now lower than readState.Index' (duration: 114.86193ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:12.696501Z","caller":"traceutil/trace.go:171","msg":"trace[1517255311] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"212.794418ms","start":"2026-06-13T22:50:12.483692Z","end":"2026-06-13T22:50:12.696486Z","steps":["trace[1517255311] 'process raft request' (duration: 212.179487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:12.696551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.321256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-06-13T22:50:12.696655Z","caller":"traceutil/trace.go:171","msg":"trace[1570860757] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4664; }","duration":"213.485782ms","start":"2026-06-13T22:50:12.48314Z","end":"2026-06-13T22:50:12.696626Z","steps":["trace[1570860757] 'agreement among raft nodes before linearized reading' (duration: 213.199422ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:12.871992Z","caller":"traceutil/trace.go:171","msg":"trace[1503725065] transaction","detail":"{read_only:false; response_revision:4665; number_of_response:1; }","duration":"172.9045ms","start":"2026-06-13T22:50:12.699063Z","end":"2026-06-13T22:50:12.871968Z","steps":["trace[1503725065] 'process raft request' (duration: 87.729069ms)","trace[1503725065] 'compare' (duration: 85.003985ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:12.893901Z","caller":"traceutil/trace.go:171","msg":"trace[42427861] linearizableReadLoop","detail":"{readStateIndex:4847; appliedIndex:4845; }","duration":"172.880709ms","start":"2026-06-13T22:50:12.720986Z","end":"2026-06-13T22:50:12.893867Z","steps":["trace[42427861] 'read index received' (duration: 65.827887ms)","trace[42427861] 'applied index is now lower than readState.Index' (duration: 107.051732ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:12.89396Z","caller":"traceutil/trace.go:171","msg":"trace[1586663697] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"188.187974ms","start":"2026-06-13T22:50:12.705745Z","end":"2026-06-13T22:50:12.893933Z","steps":["trace[1586663697] 'process raft request' (duration: 187.920395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:12.894207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.19279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-13T22:50:12.894264Z","caller":"traceutil/trace.go:171","msg":"trace[144985048] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4666; }","duration":"173.318804ms","start":"2026-06-13T22:50:12.720928Z","end":"2026-06-13T22:50:12.894246Z","steps":["trace[144985048] 'agreement among raft nodes before linearized reading' (duration: 173.097076ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:13.023851Z","caller":"traceutil/trace.go:171","msg":"trace[296949952] linearizableReadLoop","detail":"{readStateIndex:4850; appliedIndex:4849; }","duration":"120.95939ms","start":"2026-06-13T22:50:12.90285Z","end":"2026-06-13T22:50:13.02381Z","steps":["trace[296949952] 'read index received' (duration: 89.151927ms)","trace[296949952] 'applied index is now lower than readState.Index' (duration: 31.805543ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:13.0239Z","caller":"traceutil/trace.go:171","msg":"trace[2139850428] transaction","detail":"{read_only:false; response_revision:4669; number_of_response:1; }","duration":"121.129076ms","start":"2026-06-13T22:50:12.902714Z","end":"2026-06-13T22:50:13.023843Z","steps":["trace[2139850428] 'process raft request' (duration: 89.278912ms)","trace[2139850428] 'compare' (duration: 31.595565ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:13.024159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.2689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-06-13T22:50:13.024256Z","caller":"traceutil/trace.go:171","msg":"trace[1661811462] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4669; }","duration":"121.410825ms","start":"2026-06-13T22:50:12.90282Z","end":"2026-06-13T22:50:13.024231Z","steps":["trace[1661811462] 'agreement among raft nodes before linearized reading' (duration: 121.062073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:13.650649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.019696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:13.651327Z","caller":"traceutil/trace.go:171","msg":"trace[1155117557] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"198.7369ms","start":"2026-06-13T22:50:13.452572Z","end":"2026-06-13T22:50:13.651309Z","steps":["trace[1155117557] 'process raft request' (duration: 198.671358ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:13.651562Z","caller":"traceutil/trace.go:171","msg":"trace[1582523462] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"202.135427ms","start":"2026-06-13T22:50:13.449414Z","end":"2026-06-13T22:50:13.65155Z","steps":["trace[1582523462] 'process raft request' (duration: 73.995963ms)","trace[1582523462] 'compare' (duration: 126.588111ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:13.651701Z","caller":"traceutil/trace.go:171","msg":"trace[137262071] linearizableReadLoop","detail":"{readStateIndex:4853; appliedIndex:4852; }","duration":"200.826012ms","start":"2026-06-13T22:50:13.450864Z","end":"2026-06-13T22:50:13.65169Z","steps":["trace[137262071] 'read index received' (duration: 72.586125ms)","trace[137262071] 'applied index is now lower than readState.Index' (duration: 128.238557ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:13.651847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.986037ms","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-13T22:50:13.651878Z","caller":"traceutil/trace.go:171","msg":"trace[1546542713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4673; }","duration":"201.06393ms","start":"2026-06-13T22:50:13.450806Z","end":"2026-06-13T22:50:13.65187Z","steps":["trace[1546542713] 'agreement among raft nodes before linearized reading' (duration: 200.922446ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:17.815896Z","caller":"traceutil/trace.go:171","msg":"trace[176249364] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"141.644619ms","start":"2026-06-13T22:50:17.674228Z","end":"2026-06-13T22:50:17.815873Z","steps":["trace[176249364] 'process raft request' (duration: 141.479103ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:17.884028Z","caller":"traceutil/trace.go:171","msg":"trace[446943101] linearizableReadLoop","detail":"{readStateIndex:4883; appliedIndex:4881; }","duration":"204.208027ms","start":"2026-06-13T22:50:17.679802Z","end":"2026-06-13T22:50:17.88401Z","steps":["trace[446943101] 'read index received' (duration: 135.90239ms)","trace[446943101] 'applied index is now lower than readState.Index' (duration: 68.304367ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:17.884078Z","caller":"traceutil/trace.go:171","msg":"trace[742416510] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"209.589533ms","start":"2026-06-13T22:50:17.674466Z","end":"2026-06-13T22:50:17.884055Z","steps":["trace[742416510] 'process raft request' (duration: 209.440598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:17.884391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.370862ms","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-13T22:50:17.884431Z","caller":"traceutil/trace.go:171","msg":"trace[1155568110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4700; }","duration":"204.638081ms","start":"2026-06-13T22:50:17.679782Z","end":"2026-06-13T22:50:17.88442Z","steps":["trace[1155568110] 'agreement among raft nodes before linearized reading' (duration: 204.294309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:19.963472Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5646844068784144379,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-13T22:50:19.997891Z","caller":"traceutil/trace.go:171","msg":"trace[179526086] linearizableReadLoop","detail":"{readStateIndex:4947; appliedIndex:4946; }","duration":"534.996884ms","start":"2026-06-13T22:50:19.462875Z","end":"2026-06-13T22:50:19.997872Z","steps":["trace[179526086] 'read index received' (duration: 534.833419ms)","trace[179526086] 'applied index is now lower than readState.Index' (duration: 162.485µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:19.997936Z","caller":"traceutil/trace.go:171","msg":"trace[483947880] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"591.437467ms","start":"2026-06-13T22:50:19.406467Z","end":"2026-06-13T22:50:19.997904Z","steps":["trace[483947880] 'process raft request' (duration: 591.266091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:19.998155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:19.406446Z","time spent":"591.565872ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:19.998161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.99848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:50:19.998341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.539979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:19.99841Z","caller":"traceutil/trace.go:171","msg":"trace[374023365] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:4764; }","duration":"167.660784ms","start":"2026-06-13T22:50:19.830736Z","end":"2026-06-13T22:50:19.998396Z","steps":["trace[374023365] 'agreement among raft nodes before linearized reading' (duration: 167.537739ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:19.99837Z","caller":"traceutil/trace.go:171","msg":"trace[1048507256] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4764; }","duration":"313.252899ms","start":"2026-06-13T22:50:19.685096Z","end":"2026-06-13T22:50:19.998348Z","steps":["trace[1048507256] 'agreement among raft nodes before linearized reading' (duration: 312.98902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:19.998163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.279224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-13T22:50:19.998534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.822472ms","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-13T22:50:19.998604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:19.685075Z","time spent":"313.462556ms","remote":"127.0.0.1:37600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-06-13T22:50:19.998786Z","caller":"traceutil/trace.go:171","msg":"trace[620790499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4764; }","duration":"535.761441ms","start":"2026-06-13T22:50:19.462817Z","end":"2026-06-13T22:50:19.998578Z","steps":["trace[620790499] 'agreement among raft nodes before linearized reading' (duration: 535.178841ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:19.998674Z","caller":"traceutil/trace.go:171","msg":"trace[189632431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4764; }","duration":"108.051889ms","start":"2026-06-13T22:50:19.890589Z","end":"2026-06-13T22:50:19.998641Z","steps":["trace[189632431] 'agreement among raft nodes before linearized reading' (duration: 107.602433ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:19.998861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:19.462795Z","time spent":"536.045301ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T22:50:19.999262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.172029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b47c56df-db66-4c51-906e-ae5f7f947982\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-13T22:50:19.999379Z","caller":"traceutil/trace.go:171","msg":"trace[808686042] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b47c56df-db66-4c51-906e-ae5f7f947982; range_end:; response_count:1; response_revision:4764; }","duration":"276.321894ms","start":"2026-06-13T22:50:19.723039Z","end":"2026-06-13T22:50:19.999361Z","steps":["trace[808686042] 'agreement among raft nodes before linearized reading' (duration: 275.940901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:19.999511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.540337ms","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-13T22:50:19.999649Z","caller":"traceutil/trace.go:171","msg":"trace[594001770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4764; }","duration":"104.760795ms","start":"2026-06-13T22:50:19.894854Z","end":"2026-06-13T22:50:19.999615Z","steps":["trace[594001770] 'agreement among raft nodes before linearized reading' (duration: 104.306459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.000038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.529146ms","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-13T22:50:20.000541Z","caller":"traceutil/trace.go:171","msg":"trace[1614661237] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4764; }","duration":"180.101557ms","start":"2026-06-13T22:50:19.820423Z","end":"2026-06-13T22:50:20.000524Z","steps":["trace[1614661237] 'agreement among raft nodes before linearized reading' (duration: 177.786906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.587102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.362395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:20.587252Z","caller":"traceutil/trace.go:171","msg":"trace[1897163074] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"583.228922ms","start":"2026-06-13T22:50:20.004001Z","end":"2026-06-13T22:50:20.58723Z","steps":["trace[1897163074] 'process raft request' (duration: 382.638379ms)","trace[1897163074] 'compare' (duration: 200.162598ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:20.58732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.003982Z","time spent":"583.307995ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:20.588998Z","caller":"traceutil/trace.go:171","msg":"trace[1193230607] linearizableReadLoop","detail":"{readStateIndex:4952; appliedIndex:4947; }","duration":"445.095387ms","start":"2026-06-13T22:50:20.143887Z","end":"2026-06-13T22:50:20.588982Z","steps":["trace[1193230607] 'read index received' (duration: 242.764383ms)","trace[1193230607] 'applied index is now lower than readState.Index' (duration: 202.329604ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:20.589104Z","caller":"traceutil/trace.go:171","msg":"trace[287266875] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"581.925327ms","start":"2026-06-13T22:50:20.007166Z","end":"2026-06-13T22:50:20.589092Z","steps":["trace[287266875] 'process raft request' (duration: 581.763911ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:20.589098Z","caller":"traceutil/trace.go:171","msg":"trace[1913375585] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"582.594551ms","start":"2026-06-13T22:50:20.006455Z","end":"2026-06-13T22:50:20.589049Z","steps":["trace[1913375585] 'process raft request' (duration: 582.439425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.589175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.00716Z","time spent":"581.972669ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:20.589341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.006443Z","time spent":"582.763456ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:20.589373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.591527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:20.589408Z","caller":"traceutil/trace.go:171","msg":"trace[1842433812] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4769; }","duration":"287.655209ms","start":"2026-06-13T22:50:20.30174Z","end":"2026-06-13T22:50:20.589395Z","steps":["trace[1842433812] 'agreement among raft nodes before linearized reading' (duration: 287.600587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.589546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.853975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b47c56df-db66-4c51-906e-ae5f7f947982\" ","response":"range_response_count:1 size:3766"} {"level":"warn","ts":"2026-06-13T22:50:20.589328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.360948ms","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-13T22:50:20.589624Z","caller":"traceutil/trace.go:171","msg":"trace[1046319214] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b47c56df-db66-4c51-906e-ae5f7f947982; range_end:; response_count:1; response_revision:4769; }","duration":"325.060613ms","start":"2026-06-13T22:50:20.26454Z","end":"2026-06-13T22:50:20.589601Z","steps":["trace[1046319214] 'agreement among raft nodes before linearized reading' (duration: 324.835845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.589654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.77685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-06-13T22:50:20.589675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.264523Z","time spent":"325.138775ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3788,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b47c56df-db66-4c51-906e-ae5f7f947982\" "} {"level":"warn","ts":"2026-06-13T22:50:20.589658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.20365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-06-13T22:50:20.589693Z","caller":"traceutil/trace.go:171","msg":"trace[554883913] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4769; }","duration":"445.856874ms","start":"2026-06-13T22:50:20.143826Z","end":"2026-06-13T22:50:20.589682Z","steps":["trace[554883913] 'agreement among raft nodes before linearized reading' (duration: 445.734689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.589724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.143804Z","time spent":"445.913076ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-13T22:50:20.589729Z","caller":"traceutil/trace.go:171","msg":"trace[1373275457] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4769; }","duration":"344.327814ms","start":"2026-06-13T22:50:20.245383Z","end":"2026-06-13T22:50:20.589711Z","steps":["trace[1373275457] 'agreement among raft nodes before linearized reading' (duration: 344.099076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.589775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.245362Z","time spent":"344.401686ms","remote":"127.0.0.1:43006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3265,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-06-13T22:50:20.589969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.330972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T22:50:20.590047Z","caller":"traceutil/trace.go:171","msg":"trace[2143429920] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:4769; }","duration":"395.454717ms","start":"2026-06-13T22:50:20.194574Z","end":"2026-06-13T22:50:20.590029Z","steps":["trace[2143429920] 'agreement among raft nodes before linearized reading' (duration: 395.352103ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:20.589653Z","caller":"traceutil/trace.go:171","msg":"trace[1413525068] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4769; }","duration":"427.710441ms","start":"2026-06-13T22:50:20.161922Z","end":"2026-06-13T22:50:20.589632Z","steps":["trace[1413525068] 'agreement among raft nodes before linearized reading' (duration: 427.259625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.590162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.161913Z","time spent":"428.227499ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:20.590202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.344153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-13T22:50:20.590234Z","caller":"traceutil/trace.go:171","msg":"trace[1571067013] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4769; }","duration":"210.422316ms","start":"2026-06-13T22:50:20.379803Z","end":"2026-06-13T22:50:20.590226Z","steps":["trace[1571067013] 'agreement among raft nodes before linearized reading' (duration: 210.115005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.590086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.19455Z","time spent":"395.523708ms","remote":"127.0.0.1:60510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"info","ts":"2026-06-13T22:50:20.590789Z","caller":"traceutil/trace.go:171","msg":"trace[1778809993] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"584.914241ms","start":"2026-06-13T22:50:20.005683Z","end":"2026-06-13T22:50:20.590597Z","steps":["trace[1778809993] 'process raft request' (duration: 583.170611ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:20.590297Z","caller":"traceutil/trace.go:171","msg":"trace[601876090] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"584.442664ms","start":"2026-06-13T22:50:20.005657Z","end":"2026-06-13T22:50:20.5901Z","steps":["trace[601876090] 'process raft request' (duration: 583.061846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:20.591065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.005643Z","time spent":"585.348636ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:20.593327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:20.005657Z","time spent":"585.1795ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:24.404566Z","caller":"traceutil/trace.go:171","msg":"trace[1807977259] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"172.384807ms","start":"2026-06-13T22:50:24.232155Z","end":"2026-06-13T22:50:24.40454Z","steps":["trace[1807977259] 'process raft request' (duration: 172.220321ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:24.41838Z","caller":"traceutil/trace.go:171","msg":"trace[1840731064] linearizableReadLoop","detail":"{readStateIndex:4997; appliedIndex:4995; }","duration":"116.735321ms","start":"2026-06-13T22:50:24.301621Z","end":"2026-06-13T22:50:24.418356Z","steps":["trace[1840731064] 'read index received' (duration: 102.833353ms)","trace[1840731064] 'applied index is now lower than readState.Index' (duration: 13.900648ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:24.418434Z","caller":"traceutil/trace.go:171","msg":"trace[1882570436] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"126.052019ms","start":"2026-06-13T22:50:24.292357Z","end":"2026-06-13T22:50:24.418409Z","steps":["trace[1882570436] 'process raft request' (duration: 125.863392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:24.418799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.132184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:24.418874Z","caller":"traceutil/trace.go:171","msg":"trace[578156982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4813; }","duration":"117.220517ms","start":"2026-06-13T22:50:24.301614Z","end":"2026-06-13T22:50:24.418835Z","steps":["trace[578156982] 'agreement among raft nodes before linearized reading' (duration: 116.867805ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:24.702693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.099919ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:24.70281Z","caller":"traceutil/trace.go:171","msg":"trace[160741300] linearizableReadLoop","detail":"{readStateIndex:4998; appliedIndex:4997; }","duration":"284.277917ms","start":"2026-06-13T22:50:24.418509Z","end":"2026-06-13T22:50:24.702787Z","steps":["trace[160741300] 'read index received' (duration: 86.007482ms)","trace[160741300] 'applied index is now lower than readState.Index' (duration: 198.268695ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:24.703141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.625019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:24.70318Z","caller":"traceutil/trace.go:171","msg":"trace[996316924] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4814; }","duration":"282.700572ms","start":"2026-06-13T22:50:24.42047Z","end":"2026-06-13T22:50:24.703171Z","steps":["trace[996316924] 'agreement among raft nodes before linearized reading' (duration: 282.576407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:24.70328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.269172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:9223"} {"level":"info","ts":"2026-06-13T22:50:24.703357Z","caller":"traceutil/trace.go:171","msg":"trace[1560244225] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4814; }","duration":"291.396998ms","start":"2026-06-13T22:50:24.41194Z","end":"2026-06-13T22:50:24.703337Z","steps":["trace[1560244225] 'agreement among raft nodes before linearized reading' (duration: 291.053816ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:24.703392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.32849ms","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:5"} {"level":"info","ts":"2026-06-13T22:50:24.703499Z","caller":"traceutil/trace.go:171","msg":"trace[183647227] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"291.326405ms","start":"2026-06-13T22:50:24.412156Z","end":"2026-06-13T22:50:24.703482Z","steps":["trace[183647227] 'process raft request' (duration: 92.366895ms)","trace[183647227] 'compare' (duration: 197.702306ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:24.703916Z","caller":"traceutil/trace.go:171","msg":"trace[1055477348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4814; }","duration":"100.002494ms","start":"2026-06-13T22:50:24.603901Z","end":"2026-06-13T22:50:24.703904Z","steps":["trace[1055477348] 'agreement among raft nodes before linearized reading' (duration: 99.933691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:24.703915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.55279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-13T22:50:24.703968Z","caller":"traceutil/trace.go:171","msg":"trace[2004404421] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:4814; }","duration":"105.415563ms","start":"2026-06-13T22:50:24.597997Z","end":"2026-06-13T22:50:24.703413Z","steps":["trace[2004404421] 'agreement among raft nodes before linearized reading' (duration: 105.361201ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:24.703975Z","caller":"traceutil/trace.go:171","msg":"trace[2110271549] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4814; }","duration":"191.650853ms","start":"2026-06-13T22:50:24.512306Z","end":"2026-06-13T22:50:24.703957Z","steps":["trace[2110271549] 'agreement among raft nodes before linearized reading' (duration: 191.523099ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:25.059936Z","caller":"traceutil/trace.go:171","msg":"trace[1786833662] transaction","detail":"{read_only:false; response_revision:4831; number_of_response:1; }","duration":"136.755108ms","start":"2026-06-13T22:50:24.923116Z","end":"2026-06-13T22:50:25.059871Z","steps":["trace[1786833662] 'process raft request' (duration: 120.06523ms)","trace[1786833662] 'compare' (duration: 16.1723ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:25.060602Z","caller":"traceutil/trace.go:171","msg":"trace[2025358658] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"109.455249ms","start":"2026-06-13T22:50:24.951119Z","end":"2026-06-13T22:50:25.060574Z","steps":["trace[2025358658] 'process raft request' (duration: 108.89442ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:25.060658Z","caller":"traceutil/trace.go:171","msg":"trace[1693216023] transaction","detail":"{read_only:false; response_revision:4832; number_of_response:1; }","duration":"110.943762ms","start":"2026-06-13T22:50:24.949633Z","end":"2026-06-13T22:50:25.060577Z","steps":["trace[1693216023] 'process raft request' (duration: 110.237867ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:29.27432Z","caller":"traceutil/trace.go:171","msg":"trace[1919086214] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"120.904607ms","start":"2026-06-13T22:50:29.153392Z","end":"2026-06-13T22:50:29.274296Z","steps":["trace[1919086214] 'process raft request' (duration: 120.726471ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:35.876717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:35.433363Z","time spent":"443.350685ms","remote":"127.0.0.1:39180","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-13T22:50:35.877149Z","caller":"traceutil/trace.go:171","msg":"trace[898756937] linearizableReadLoop","detail":"{readStateIndex:5137; appliedIndex:5137; }","duration":"240.375502ms","start":"2026-06-13T22:50:35.63673Z","end":"2026-06-13T22:50:35.877105Z","steps":["trace[898756937] 'read index received' (duration: 240.367022ms)","trace[898756937] 'applied index is now lower than readState.Index' (duration: 7.18µs)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:35.877329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.58762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-06-13T22:50:35.877369Z","caller":"traceutil/trace.go:171","msg":"trace[1618808054] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4947; }","duration":"240.679613ms","start":"2026-06-13T22:50:35.636677Z","end":"2026-06-13T22:50:35.877356Z","steps":["trace[1618808054] 'agreement among raft nodes before linearized reading' (duration: 240.532998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:36.335837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.669956ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:36.335953Z","caller":"traceutil/trace.go:171","msg":"trace[97495272] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4947; }","duration":"419.799441ms","start":"2026-06-13T22:50:35.916136Z","end":"2026-06-13T22:50:36.335936Z","steps":["trace[97495272] 'range keys from in-memory index tree' (duration: 419.654726ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:36.336095Z","caller":"traceutil/trace.go:171","msg":"trace[1610468535] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"507.013046ms","start":"2026-06-13T22:50:35.829037Z","end":"2026-06-13T22:50:36.33605Z","steps":["trace[1610468535] 'process raft request' (duration: 486.316493ms)","trace[1610468535] 'compare' (duration: 20.239167ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:36.336079Z","caller":"traceutil/trace.go:171","msg":"trace[1946288395] linearizableReadLoop","detail":"{readStateIndex:5138; appliedIndex:5137; }","duration":"458.82976ms","start":"2026-06-13T22:50:35.877187Z","end":"2026-06-13T22:50:36.336017Z","steps":["trace[1946288395] 'read index received' (duration: 438.170418ms)","trace[1946288395] 'applied index is now lower than readState.Index' (duration: 20.657572ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:36.336241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:35.829012Z","time spent":"507.155661ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:36.336404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.133932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-06-13T22:50:36.336501Z","caller":"traceutil/trace.go:171","msg":"trace[1558940757] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4948; }","duration":"461.271408ms","start":"2026-06-13T22:50:35.875211Z","end":"2026-06-13T22:50:36.336482Z","steps":["trace[1558940757] 'agreement among raft nodes before linearized reading' (duration: 460.976327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:36.336585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:35.87519Z","time spent":"461.379211ms","remote":"127.0.0.1:39340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10414,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-13T22:50:36.49833Z","caller":"traceutil/trace.go:171","msg":"trace[1537088421] linearizableReadLoop","detail":"{readStateIndex:5139; appliedIndex:5138; }","duration":"162.132209ms","start":"2026-06-13T22:50:36.336173Z","end":"2026-06-13T22:50:36.498305Z","steps":["trace[1537088421] 'read index received' (duration: 145.576794ms)","trace[1537088421] 'applied index is now lower than readState.Index' (duration: 16.554324ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:36.498384Z","caller":"traceutil/trace.go:171","msg":"trace[1848958677] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"620.384488ms","start":"2026-06-13T22:50:35.877967Z","end":"2026-06-13T22:50:36.498352Z","steps":["trace[1848958677] 'process raft request' (duration: 603.654908ms)","trace[1848958677] 'compare' (duration: 16.557184ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:36.499037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:35.877954Z","time spent":"621.01728ms","remote":"127.0.0.1:39180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:36.4985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.489563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T22:50:36.499196Z","caller":"traceutil/trace.go:171","msg":"trace[480602431] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:4949; }","duration":"587.22497ms","start":"2026-06-13T22:50:35.911954Z","end":"2026-06-13T22:50:36.499179Z","steps":["trace[480602431] 'agreement among raft nodes before linearized reading' (duration: 586.489473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:36.499273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:35.911935Z","time spent":"587.318894ms","remote":"127.0.0.1:50306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":29,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:50:36.499299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.737882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-06-13T22:50:36.498778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.698658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1162"} {"level":"info","ts":"2026-06-13T22:50:36.499408Z","caller":"traceutil/trace.go:171","msg":"trace[353594595] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4949; }","duration":"614.513188ms","start":"2026-06-13T22:50:35.884882Z","end":"2026-06-13T22:50:36.499396Z","steps":["trace[353594595] 'agreement among raft nodes before linearized reading' (duration: 613.615075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:36.499484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:35.884865Z","time spent":"614.60572ms","remote":"127.0.0.1:39244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1184,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "} {"level":"info","ts":"2026-06-13T22:50:36.499479Z","caller":"traceutil/trace.go:171","msg":"trace[1354490142] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4949; }","duration":"572.884507ms","start":"2026-06-13T22:50:35.926504Z","end":"2026-06-13T22:50:36.499389Z","steps":["trace[1354490142] 'agreement among raft nodes before linearized reading' (duration: 571.83398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:36.499621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:35.926484Z","time spent":"573.123195ms","remote":"127.0.0.1:39310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-13T22:50:36.521169Z","caller":"traceutil/trace.go:171","msg":"trace[1645127485] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"173.650662ms","start":"2026-06-13T22:50:36.347501Z","end":"2026-06-13T22:50:36.521152Z","steps":["trace[1645127485] 'process raft request' (duration: 173.505197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:36.529092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.011179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-13T22:50:36.529417Z","caller":"traceutil/trace.go:171","msg":"trace[206433691] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4951; }","duration":"110.339431ms","start":"2026-06-13T22:50:36.419065Z","end":"2026-06-13T22:50:36.529404Z","steps":["trace[206433691] 'agreement among raft nodes before linearized reading' (duration: 109.944057ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:36.689473Z","caller":"traceutil/trace.go:171","msg":"trace[1832257382] linearizableReadLoop","detail":"{readStateIndex:5147; appliedIndex:5145; }","duration":"112.123594ms","start":"2026-06-13T22:50:36.577326Z","end":"2026-06-13T22:50:36.68945Z","steps":["trace[1832257382] 'read index received' (duration: 11.825104ms)","trace[1832257382] 'applied index is now lower than readState.Index' (duration: 100.29763ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:36.689526Z","caller":"traceutil/trace.go:171","msg":"trace[1172256899] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"112.271189ms","start":"2026-06-13T22:50:36.577222Z","end":"2026-06-13T22:50:36.689493Z","steps":["trace[1172256899] 'process raft request' (duration: 111.993769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:36.690404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.053487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-06-13T22:50:36.690445Z","caller":"traceutil/trace.go:171","msg":"trace[1198984599] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4957; }","duration":"113.182452ms","start":"2026-06-13T22:50:36.577253Z","end":"2026-06-13T22:50:36.690436Z","steps":["trace[1198984599] 'agreement among raft nodes before linearized reading' (duration: 112.325201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.373222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.029606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:50:37.373568Z","caller":"traceutil/trace.go:171","msg":"trace[1118423554] linearizableReadLoop","detail":"{readStateIndex:5149; appliedIndex:5147; }","duration":"676.307416ms","start":"2026-06-13T22:50:36.697239Z","end":"2026-06-13T22:50:37.373547Z","steps":["trace[1118423554] 'read index received' (duration: 100.00876ms)","trace[1118423554] 'applied index is now lower than readState.Index' (duration: 576.297586ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:37.373572Z","caller":"traceutil/trace.go:171","msg":"trace[2021262764] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"676.579745ms","start":"2026-06-13T22:50:36.696958Z","end":"2026-06-13T22:50:37.373538Z","steps":["trace[2021262764] 'process raft request' (duration: 676.374078ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.373695Z","caller":"traceutil/trace.go:171","msg":"trace[615664941] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"681.18354ms","start":"2026-06-13T22:50:36.692481Z","end":"2026-06-13T22:50:37.373665Z","steps":["trace[615664941] 'process raft request' (duration: 104.613474ms)","trace[615664941] 'compare' (duration: 575.227388ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:37.373753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.696935Z","time spent":"676.730461ms","remote":"127.0.0.1:39326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1329,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:37.373829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.692468Z","time spent":"681.292975ms","remote":"127.0.0.1:39230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":725,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:37.37391Z","caller":"traceutil/trace.go:171","msg":"trace[712025752] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"675.435464ms","start":"2026-06-13T22:50:36.69846Z","end":"2026-06-13T22:50:37.373895Z","steps":["trace[712025752] 'process raft request' (duration: 674.948687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.373996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.698446Z","time spent":"675.504756ms","remote":"127.0.0.1:39448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1951,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:37.374049Z","caller":"traceutil/trace.go:171","msg":"trace[623271265] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"673.884978ms","start":"2026-06-13T22:50:36.700151Z","end":"2026-06-13T22:50:37.374036Z","steps":["trace[623271265] 'process raft request' (duration: 673.346999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.374118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.700138Z","time spent":"673.947291ms","remote":"127.0.0.1:39658","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8237,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:37.374137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.890617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:37.374175Z","caller":"traceutil/trace.go:171","msg":"trace[797528101] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4961; }","duration":"676.957899ms","start":"2026-06-13T22:50:36.697207Z","end":"2026-06-13T22:50:37.374165Z","steps":["trace[797528101] 'agreement among raft nodes before linearized reading' (duration: 676.893567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.374212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.697198Z","time spent":"677.00797ms","remote":"127.0.0.1:39356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-06-13T22:50:37.596252Z","caller":"traceutil/trace.go:171","msg":"trace[1161202693] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"694.776041ms","start":"2026-06-13T22:50:36.90145Z","end":"2026-06-13T22:50:37.596227Z","steps":["trace[1161202693] 'process raft request' (duration: 650.457368ms)","trace[1161202693] 'compare' (duration: 44.149377ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:50:37.596394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.901431Z","time spent":"694.891276ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:37.596576Z","caller":"traceutil/trace.go:171","msg":"trace[1798750698] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"492.205415ms","start":"2026-06-13T22:50:37.104344Z","end":"2026-06-13T22:50:37.59655Z","steps":["trace[1798750698] 'process raft request' (duration: 491.838792ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.596624Z","caller":"traceutil/trace.go:171","msg":"trace[1140299530] linearizableReadLoop","detail":"{readStateIndex:5154; appliedIndex:5151; }","duration":"222.997057ms","start":"2026-06-13T22:50:37.373617Z","end":"2026-06-13T22:50:37.596614Z","steps":["trace[1140299530] 'read index received' (duration: 178.241238ms)","trace[1140299530] 'applied index is now lower than readState.Index' (duration: 44.754999ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:37.596731Z","caller":"traceutil/trace.go:171","msg":"trace[259201712] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"488.292964ms","start":"2026-06-13T22:50:37.108426Z","end":"2026-06-13T22:50:37.596719Z","steps":["trace[259201712] 'process raft request' (duration: 488.014964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.596745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.10432Z","time spent":"492.33411ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:37.596794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.108417Z","time spent":"488.343007ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:37.596898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.630028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:50:37.596934Z","caller":"traceutil/trace.go:171","msg":"trace[280520840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4964; }","duration":"295.703431ms","start":"2026-06-13T22:50:37.301222Z","end":"2026-06-13T22:50:37.596926Z","steps":["trace[280520840] 'agreement among raft nodes before linearized reading' (duration: 295.643868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.597022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"778.823178ms","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-13T22:50:37.597064Z","caller":"traceutil/trace.go:171","msg":"trace[1197118321] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4964; }","duration":"778.88833ms","start":"2026-06-13T22:50:36.818165Z","end":"2026-06-13T22:50:37.597053Z","steps":["trace[1197118321] 'agreement among raft nodes before linearized reading' (duration: 778.765256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.597092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.818155Z","time spent":"778.931272ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-13T22:50:37.597195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.338563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-13T22:50:37.59722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.313213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-13T22:50:37.597228Z","caller":"traceutil/trace.go:171","msg":"trace[1860172374] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:4964; }","duration":"348.407736ms","start":"2026-06-13T22:50:37.248812Z","end":"2026-06-13T22:50:37.59722Z","steps":["trace[1860172374] 'agreement among raft nodes before linearized reading' (duration: 348.343064ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.597248Z","caller":"traceutil/trace.go:171","msg":"trace[1280389681] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4964; }","duration":"787.362975ms","start":"2026-06-13T22:50:36.809877Z","end":"2026-06-13T22:50:37.59724Z","steps":["trace[1280389681] 'agreement among raft nodes before linearized reading' (duration: 787.253401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.597275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.809867Z","time spent":"787.401896ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:37.597349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.610092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-06-13T22:50:37.59736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.978038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-13T22:50:37.597382Z","caller":"traceutil/trace.go:171","msg":"trace[1753075135] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4964; }","duration":"622.662934ms","start":"2026-06-13T22:50:36.974708Z","end":"2026-06-13T22:50:37.597371Z","steps":["trace[1753075135] 'agreement among raft nodes before linearized reading' (duration: 622.583701ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.597389Z","caller":"traceutil/trace.go:171","msg":"trace[646713354] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:4964; }","duration":"795.0291ms","start":"2026-06-13T22:50:36.802351Z","end":"2026-06-13T22:50:37.59738Z","steps":["trace[646713354] 'agreement among raft nodes before linearized reading' (duration: 794.981348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.597408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.974683Z","time spent":"622.719306ms","remote":"127.0.0.1:39310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-06-13T22:50:37.597416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.802338Z","time spent":"795.070391ms","remote":"127.0.0.1:49570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":29,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:50:37.597452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.179541ms","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-13T22:50:37.597559Z","caller":"traceutil/trace.go:171","msg":"trace[1963840349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4964; }","duration":"779.247464ms","start":"2026-06-13T22:50:36.818241Z","end":"2026-06-13T22:50:37.597489Z","steps":["trace[1963840349] 'agreement among raft nodes before linearized reading' (duration: 779.117559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.597594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.818234Z","time spent":"779.351637ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:37.597618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.310558ms","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-13T22:50:37.597645Z","caller":"traceutil/trace.go:171","msg":"trace[1183727183] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4964; }","duration":"827.35946ms","start":"2026-06-13T22:50:36.770277Z","end":"2026-06-13T22:50:37.597637Z","steps":["trace[1183727183] 'agreement among raft nodes before linearized reading' (duration: 827.281297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.597669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.770266Z","time spent":"827.398621ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-13T22:50:37.597718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"779.504053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-06-13T22:50:37.597723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.418072ms","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-13T22:50:37.597751Z","caller":"traceutil/trace.go:171","msg":"trace[264271710] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4964; }","duration":"779.558285ms","start":"2026-06-13T22:50:36.818182Z","end":"2026-06-13T22:50:37.597741Z","steps":["trace[264271710] 'agreement among raft nodes before linearized reading' (duration: 779.467182ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.597753Z","caller":"traceutil/trace.go:171","msg":"trace[84083503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4964; }","duration":"776.461634ms","start":"2026-06-13T22:50:36.821282Z","end":"2026-06-13T22:50:37.597744Z","steps":["trace[84083503] 'agreement among raft nodes before linearized reading' (duration: 776.381951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.59778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.818173Z","time spent":"779.601326ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-13T22:50:37.597783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.821275Z","time spent":"776.502045ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-13T22:50:37.597788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.462588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-13T22:50:37.597815Z","caller":"traceutil/trace.go:171","msg":"trace[726821630] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4964; }","duration":"899.50754ms","start":"2026-06-13T22:50:36.6983Z","end":"2026-06-13T22:50:37.597808Z","steps":["trace[726821630] 'agreement among raft nodes before linearized reading' (duration: 899.425207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.597839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:36.698286Z","time spent":"899.548311ms","remote":"127.0.0.1:39310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-06-13T22:50:37.597275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.248794Z","time spent":"348.455207ms","remote":"127.0.0.1:39638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":16,"response size":29,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-06-13T22:50:37.597983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.106743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-13T22:50:37.598049Z","caller":"traceutil/trace.go:171","msg":"trace[243186443] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4964; }","duration":"220.184886ms","start":"2026-06-13T22:50:37.377847Z","end":"2026-06-13T22:50:37.598032Z","steps":["trace[243186443] 'agreement among raft nodes before linearized reading' (duration: 219.983549ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.896698Z","caller":"traceutil/trace.go:171","msg":"trace[2030932951] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"292.224446ms","start":"2026-06-13T22:50:37.604444Z","end":"2026-06-13T22:50:37.896668Z","steps":["trace[2030932951] 'process raft request' (duration: 217.166697ms)","trace[2030932951] 'compare' (duration: 74.939684ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:37.909321Z","caller":"traceutil/trace.go:171","msg":"trace[1284535658] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"304.153545ms","start":"2026-06-13T22:50:37.605148Z","end":"2026-06-13T22:50:37.909302Z","steps":["trace[1284535658] 'process raft request' (duration: 303.914536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.909414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.605134Z","time spent":"304.222047ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:37.909392Z","caller":"traceutil/trace.go:171","msg":"trace[1816831622] linearizableReadLoop","detail":"{readStateIndex:5160; appliedIndex:5154; }","duration":"302.599478ms","start":"2026-06-13T22:50:37.60677Z","end":"2026-06-13T22:50:37.909369Z","steps":["trace[1816831622] 'read index received' (duration: 214.922306ms)","trace[1816831622] 'applied index is now lower than readState.Index' (duration: 87.675842ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:50:37.909409Z","caller":"traceutil/trace.go:171","msg":"trace[1531539853] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"303.47623ms","start":"2026-06-13T22:50:37.605919Z","end":"2026-06-13T22:50:37.909395Z","steps":["trace[1531539853] 'process raft request' (duration: 303.375027ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.909492Z","caller":"traceutil/trace.go:171","msg":"trace[1421490194] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"304.157155ms","start":"2026-06-13T22:50:37.605326Z","end":"2026-06-13T22:50:37.909483Z","steps":["trace[1421490194] 'process raft request' (duration: 303.909106ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.909474Z","caller":"traceutil/trace.go:171","msg":"trace[472549143] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"303.001423ms","start":"2026-06-13T22:50:37.606451Z","end":"2026-06-13T22:50:37.909453Z","steps":["trace[472549143] 'process raft request' (duration: 302.884769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.909529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.605316Z","time spent":"304.191666ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:37.909549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.605899Z","time spent":"303.576084ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:37.909638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.844347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-06-13T22:50:37.909675Z","caller":"traceutil/trace.go:171","msg":"trace[1536609630] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4970; }","duration":"302.91201ms","start":"2026-06-13T22:50:37.606753Z","end":"2026-06-13T22:50:37.909664Z","steps":["trace[1536609630] 'agreement among raft nodes before linearized reading' (duration: 302.729713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.909719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.606747Z","time spent":"302.963962ms","remote":"127.0.0.1:39652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":9659,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" "} {"level":"warn","ts":"2026-06-13T22:50:37.909714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.606445Z","time spent":"303.161139ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-13T22:50:37.909802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.90411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-06-13T22:50:37.909846Z","caller":"traceutil/trace.go:171","msg":"trace[972925377] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4970; }","duration":"297.951292ms","start":"2026-06-13T22:50:37.61188Z","end":"2026-06-13T22:50:37.909832Z","steps":["trace[972925377] 'agreement among raft nodes before linearized reading' (duration: 297.828918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.909959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.902459ms","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:5"} {"level":"info","ts":"2026-06-13T22:50:37.909998Z","caller":"traceutil/trace.go:171","msg":"trace[301057953] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:4970; }","duration":"107.980622ms","start":"2026-06-13T22:50:37.802007Z","end":"2026-06-13T22:50:37.909987Z","steps":["trace[301057953] 'agreement among raft nodes before linearized reading' (duration: 107.912569ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:37.909361Z","caller":"traceutil/trace.go:171","msg":"trace[785718983] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"304.155565ms","start":"2026-06-13T22:50:37.605181Z","end":"2026-06-13T22:50:37.909337Z","steps":["trace[785718983] 'process raft request' (duration: 304.01747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:50:37.911396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:50:37.605168Z","time spent":"305.162181ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:50:42.909683Z","caller":"traceutil/trace.go:171","msg":"trace[2136801097] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"164.320657ms","start":"2026-06-13T22:50:42.745342Z","end":"2026-06-13T22:50:42.909663Z","steps":["trace[2136801097] 'process raft request' (duration: 164.175231ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:42.909987Z","caller":"traceutil/trace.go:171","msg":"trace[1782042626] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"164.279164ms","start":"2026-06-13T22:50:42.745621Z","end":"2026-06-13T22:50:42.909901Z","steps":["trace[1782042626] 'process raft request' (duration: 164.004804ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:59.838417Z","caller":"traceutil/trace.go:171","msg":"trace[1486933421] transaction","detail":"{read_only:false; response_revision:5125; number_of_response:1; }","duration":"127.447886ms","start":"2026-06-13T22:50:59.710947Z","end":"2026-06-13T22:50:59.838395Z","steps":["trace[1486933421] 'process raft request' (duration: 127.391044ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:50:59.838465Z","caller":"traceutil/trace.go:171","msg":"trace[1161274704] transaction","detail":"{read_only:false; response_revision:5124; number_of_response:1; }","duration":"142.07745ms","start":"2026-06-13T22:50:59.696359Z","end":"2026-06-13T22:50:59.838437Z","steps":["trace[1161274704] 'process raft request' (duration: 95.337723ms)","trace[1161274704] 'compare' (duration: 46.54966ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:00.263734Z","caller":"traceutil/trace.go:171","msg":"trace[1013948467] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"104.918785ms","start":"2026-06-13T22:51:00.15877Z","end":"2026-06-13T22:51:00.263688Z","steps":["trace[1013948467] 'process raft request' (duration: 13.002934ms)","trace[1013948467] 'compare' (duration: 91.572078ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:00.263923Z","caller":"traceutil/trace.go:171","msg":"trace[1490975465] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"103.879636ms","start":"2026-06-13T22:51:00.159959Z","end":"2026-06-13T22:51:00.263838Z","steps":["trace[1490975465] 'process raft request' (duration: 103.814554ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.227178Z","caller":"traceutil/trace.go:171","msg":"trace[1424905978] transaction","detail":"{read_only:false; response_revision:5169; number_of_response:1; }","duration":"147.019187ms","start":"2026-06-13T22:51:08.080141Z","end":"2026-06-13T22:51:08.22716Z","steps":["trace[1424905978] 'process raft request' (duration: 69.407338ms)","trace[1424905978] 'compare' (duration: 77.517045ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:08.24697Z","caller":"traceutil/trace.go:171","msg":"trace[1363112758] linearizableReadLoop","detail":"{readStateIndex:5367; appliedIndex:5365; }","duration":"113.873311ms","start":"2026-06-13T22:51:08.133079Z","end":"2026-06-13T22:51:08.246953Z","steps":["trace[1363112758] 'read index received' (duration: 16.479099ms)","trace[1363112758] 'applied index is now lower than readState.Index' (duration: 97.393562ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:08.247034Z","caller":"traceutil/trace.go:171","msg":"trace[1963286084] transaction","detail":"{read_only:false; response_revision:5170; number_of_response:1; }","duration":"164.064198ms","start":"2026-06-13T22:51:08.082947Z","end":"2026-06-13T22:51:08.247011Z","steps":["trace[1963286084] 'process raft request' (duration: 163.913642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.247146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.068838ms","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-13T22:51:08.24717Z","caller":"traceutil/trace.go:171","msg":"trace[1908999067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5170; }","duration":"114.168202ms","start":"2026-06-13T22:51:08.132994Z","end":"2026-06-13T22:51:08.247162Z","steps":["trace[1908999067] 'agreement among raft nodes before linearized reading' (duration: 114.043647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.247236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.25401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-13T22:51:08.247229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.863263ms","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-13T22:51:08.247284Z","caller":"traceutil/trace.go:171","msg":"trace[1457842211] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5170; }","duration":"100.325343ms","start":"2026-06-13T22:51:08.146945Z","end":"2026-06-13T22:51:08.24727Z","steps":["trace[1457842211] 'agreement among raft nodes before linearized reading' (duration: 100.200478ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.24729Z","caller":"traceutil/trace.go:171","msg":"trace[105174449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5170; }","duration":"108.961747ms","start":"2026-06-13T22:51:08.138316Z","end":"2026-06-13T22:51:08.247278Z","steps":["trace[105174449] 'agreement among raft nodes before linearized reading' (duration: 108.7775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.492115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.214859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:51:08.492366Z","caller":"traceutil/trace.go:171","msg":"trace[1338397450] linearizableReadLoop","detail":"{readStateIndex:5372; appliedIndex:5370; }","duration":"162.632305ms","start":"2026-06-13T22:51:08.329718Z","end":"2026-06-13T22:51:08.492351Z","steps":["trace[1338397450] 'read index received' (duration: 59.087672ms)","trace[1338397450] 'applied index is now lower than readState.Index' (duration: 103.543483ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:08.492452Z","caller":"traceutil/trace.go:171","msg":"trace[530608422] transaction","detail":"{read_only:false; response_revision:5174; number_of_response:1; }","duration":"169.935659ms","start":"2026-06-13T22:51:08.322504Z","end":"2026-06-13T22:51:08.492439Z","steps":["trace[530608422] 'process raft request' (duration: 65.312515ms)","trace[530608422] 'compare' (duration: 103.750691ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:08.492512Z","caller":"traceutil/trace.go:171","msg":"trace[1719961628] transaction","detail":"{read_only:false; response_revision:5176; number_of_response:1; }","duration":"145.667247ms","start":"2026-06-13T22:51:08.34682Z","end":"2026-06-13T22:51:08.492487Z","steps":["trace[1719961628] 'process raft request' (duration: 145.443319ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.492686Z","caller":"traceutil/trace.go:171","msg":"trace[2059973762] transaction","detail":"{read_only:false; response_revision:5175; number_of_response:1; }","duration":"169.774163ms","start":"2026-06-13T22:51:08.322907Z","end":"2026-06-13T22:51:08.492681Z","steps":["trace[2059973762] 'process raft request' (duration: 169.294655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.492714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.987948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-06-13T22:51:08.492746Z","caller":"traceutil/trace.go:171","msg":"trace[1004358568] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:5176; }","duration":"163.03452ms","start":"2026-06-13T22:51:08.329701Z","end":"2026-06-13T22:51:08.492736Z","steps":["trace[1004358568] 'agreement among raft nodes before linearized reading' (duration: 162.923836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.492951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.591342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-13T22:51:08.492983Z","caller":"traceutil/trace.go:171","msg":"trace[2080902826] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5176; }","duration":"100.648134ms","start":"2026-06-13T22:51:08.392327Z","end":"2026-06-13T22:51:08.492975Z","steps":["trace[2080902826] 'agreement among raft nodes before linearized reading' (duration: 100.561711ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.687056Z","caller":"traceutil/trace.go:171","msg":"trace[1387474052] linearizableReadLoop","detail":"{readStateIndex:5397; appliedIndex:5396; }","duration":"108.166827ms","start":"2026-06-13T22:51:08.578862Z","end":"2026-06-13T22:51:08.687029Z","steps":["trace[1387474052] 'read index received' (duration: 107.909877ms)","trace[1387474052] 'applied index is now lower than readState.Index' (duration: 255.98µs)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:08.687177Z","caller":"traceutil/trace.go:171","msg":"trace[901052135] transaction","detail":"{read_only:false; response_revision:5200; number_of_response:1; }","duration":"108.730088ms","start":"2026-06-13T22:51:08.578434Z","end":"2026-06-13T22:51:08.687164Z","steps":["trace[901052135] 'process raft request' (duration: 108.361984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.687457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.613666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:62004"} {"level":"info","ts":"2026-06-13T22:51:08.687526Z","caller":"traceutil/trace.go:171","msg":"trace[1121546291] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5200; }","duration":"107.729671ms","start":"2026-06-13T22:51:08.579779Z","end":"2026-06-13T22:51:08.687509Z","steps":["trace[1121546291] 'agreement among raft nodes before linearized reading' (duration: 107.44834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.687594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.709977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:08.687694Z","caller":"traceutil/trace.go:171","msg":"trace[1644119039] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5200; }","duration":"108.820752ms","start":"2026-06-13T22:51:08.57885Z","end":"2026-06-13T22:51:08.68767Z","steps":["trace[1644119039] 'agreement among raft nodes before linearized reading' (duration: 108.678017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.687745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.398771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-06-13T22:51:08.687826Z","caller":"traceutil/trace.go:171","msg":"trace[1554115841] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5200; }","duration":"106.522445ms","start":"2026-06-13T22:51:08.581282Z","end":"2026-06-13T22:51:08.687805Z","steps":["trace[1554115841] 'agreement among raft nodes before linearized reading' (duration: 106.223774ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.889467Z","caller":"traceutil/trace.go:171","msg":"trace[1460682230] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"104.455468ms","start":"2026-06-13T22:51:08.784987Z","end":"2026-06-13T22:51:08.889443Z","steps":["trace[1460682230] 'process raft request' (duration: 16.277052ms)","trace[1460682230] 'compare' (duration: 88.014809ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:08.897224Z","caller":"traceutil/trace.go:171","msg":"trace[1971071534] linearizableReadLoop","detail":"{readStateIndex:5421; appliedIndex:5409; }","duration":"109.57119ms","start":"2026-06-13T22:51:08.787635Z","end":"2026-06-13T22:51:08.897206Z","steps":["trace[1971071534] 'read index received' (duration: 13.697866ms)","trace[1971071534] 'applied index is now lower than readState.Index' (duration: 95.872574ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:08.897333Z","caller":"traceutil/trace.go:171","msg":"trace[1799470841] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"111.098058ms","start":"2026-06-13T22:51:08.786224Z","end":"2026-06-13T22:51:08.897322Z","steps":["trace[1799470841] 'process raft request' (duration: 110.546197ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.897577Z","caller":"traceutil/trace.go:171","msg":"trace[1449770065] transaction","detail":"{read_only:false; response_revision:5222; number_of_response:1; }","duration":"110.736324ms","start":"2026-06-13T22:51:08.78683Z","end":"2026-06-13T22:51:08.897566Z","steps":["trace[1449770065] 'process raft request' (duration: 110.264646ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.897676Z","caller":"traceutil/trace.go:171","msg":"trace[311116938] transaction","detail":"{read_only:false; response_revision:5223; number_of_response:1; }","duration":"110.807447ms","start":"2026-06-13T22:51:08.786861Z","end":"2026-06-13T22:51:08.897668Z","steps":["trace[311116938] 'process raft request' (duration: 110.273617ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.897566Z","caller":"traceutil/trace.go:171","msg":"trace[230020272] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"110.714683ms","start":"2026-06-13T22:51:08.786791Z","end":"2026-06-13T22:51:08.897506Z","steps":["trace[230020272] 'process raft request' (duration: 110.275806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.897906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.250966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-06-13T22:51:08.897953Z","caller":"traceutil/trace.go:171","msg":"trace[792714722] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:5224; }","duration":"110.323718ms","start":"2026-06-13T22:51:08.787617Z","end":"2026-06-13T22:51:08.897941Z","steps":["trace[792714722] 'agreement among raft nodes before linearized reading' (duration: 110.152192ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.898126Z","caller":"traceutil/trace.go:171","msg":"trace[401585956] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"111.590425ms","start":"2026-06-13T22:51:08.786439Z","end":"2026-06-13T22:51:08.89803Z","steps":["trace[401585956] 'process raft request' (duration: 110.549276ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.89816Z","caller":"traceutil/trace.go:171","msg":"trace[642981466] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"111.797943ms","start":"2026-06-13T22:51:08.786337Z","end":"2026-06-13T22:51:08.898135Z","steps":["trace[642981466] 'process raft request' (duration: 110.594278ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.898199Z","caller":"traceutil/trace.go:171","msg":"trace[698012753] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"111.904508ms","start":"2026-06-13T22:51:08.786272Z","end":"2026-06-13T22:51:08.898176Z","steps":["trace[698012753] 'process raft request' (duration: 110.607599ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.898295Z","caller":"traceutil/trace.go:171","msg":"trace[2086927017] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"111.866916ms","start":"2026-06-13T22:51:08.78642Z","end":"2026-06-13T22:51:08.898286Z","steps":["trace[2086927017] 'process raft request' (duration: 110.541836ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.898335Z","caller":"traceutil/trace.go:171","msg":"trace[1812299851] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"111.620707ms","start":"2026-06-13T22:51:08.786703Z","end":"2026-06-13T22:51:08.898324Z","steps":["trace[1812299851] 'process raft request' (duration: 110.340579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:08.898351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.345449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:08.897752Z","caller":"traceutil/trace.go:171","msg":"trace[1740367280] transaction","detail":"{read_only:false; response_revision:5224; number_of_response:1; }","duration":"110.250876ms","start":"2026-06-13T22:51:08.787494Z","end":"2026-06-13T22:51:08.897745Z","steps":["trace[1740367280] 'process raft request' (duration: 109.677164ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.89839Z","caller":"traceutil/trace.go:171","msg":"trace[952385504] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:5224; }","duration":"110.408801ms","start":"2026-06-13T22:51:08.787967Z","end":"2026-06-13T22:51:08.898376Z","steps":["trace[952385504] 'agreement among raft nodes before linearized reading' (duration: 110.332659ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:08.898429Z","caller":"traceutil/trace.go:171","msg":"trace[350628269] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"111.914148ms","start":"2026-06-13T22:51:08.786503Z","end":"2026-06-13T22:51:08.898418Z","steps":["trace[350628269] 'process raft request' (duration: 110.509835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:19.943218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.855986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:51:19.943321Z","caller":"traceutil/trace.go:171","msg":"trace[2348540] transaction","detail":"{read_only:false; response_revision:5328; number_of_response:1; }","duration":"127.540459ms","start":"2026-06-13T22:51:19.815763Z","end":"2026-06-13T22:51:19.943304Z","steps":["trace[2348540] 'compare' (duration: 119.641498ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:24.164452Z","caller":"traceutil/trace.go:171","msg":"trace[379331163] linearizableReadLoop","detail":"{readStateIndex:5554; appliedIndex:5553; }","duration":"151.91462ms","start":"2026-06-13T22:51:24.012511Z","end":"2026-06-13T22:51:24.164426Z","steps":["trace[379331163] 'read index received' (duration: 130.755759ms)","trace[379331163] 'applied index is now lower than readState.Index' (duration: 21.157641ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:24.164643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.105347ms","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-13T22:51:24.164681Z","caller":"traceutil/trace.go:171","msg":"trace[462501335] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5353; }","duration":"152.176199ms","start":"2026-06-13T22:51:24.012495Z","end":"2026-06-13T22:51:24.164671Z","steps":["trace[462501335] 'agreement among raft nodes before linearized reading' (duration: 152.025403ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:24.164664Z","caller":"traceutil/trace.go:171","msg":"trace[91377057] transaction","detail":"{read_only:false; response_revision:5353; number_of_response:1; }","duration":"162.146322ms","start":"2026-06-13T22:51:24.002485Z","end":"2026-06-13T22:51:24.164631Z","steps":["trace[91377057] 'process raft request' (duration: 140.862276ms)","trace[91377057] 'compare' (duration: 20.933752ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:34.359799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.658463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:34.359885Z","caller":"traceutil/trace.go:171","msg":"trace[39048311] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5424; }","duration":"334.786378ms","start":"2026-06-13T22:51:34.025077Z","end":"2026-06-13T22:51:34.359864Z","steps":["trace[39048311] 'range keys from in-memory index tree' (duration: 334.58567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:34.359923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:34.025058Z","time spent":"334.85631ms","remote":"127.0.0.1:39408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/keystone-db-sync\" "} {"level":"info","ts":"2026-06-13T22:51:34.36008Z","caller":"traceutil/trace.go:171","msg":"trace[1025816095] linearizableReadLoop","detail":"{readStateIndex:5628; appliedIndex:5627; }","duration":"296.561568ms","start":"2026-06-13T22:51:34.063499Z","end":"2026-06-13T22:51:34.36006Z","steps":["trace[1025816095] 'read index received' (duration: 263.225148ms)","trace[1025816095] 'applied index is now lower than readState.Index' (duration: 33.33522ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:34.360189Z","caller":"traceutil/trace.go:171","msg":"trace[1215415117] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"325.267239ms","start":"2026-06-13T22:51:34.034901Z","end":"2026-06-13T22:51:34.360169Z","steps":["trace[1215415117] 'process raft request' (duration: 291.850066ms)","trace[1215415117] 'compare' (duration: 33.188244ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:34.36027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.766086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-13T22:51:34.360311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:34.034885Z","time spent":"325.344953ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:51:34.360375Z","caller":"traceutil/trace.go:171","msg":"trace[518312363] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5425; }","duration":"296.902882ms","start":"2026-06-13T22:51:34.063417Z","end":"2026-06-13T22:51:34.36032Z","steps":["trace[518312363] 'agreement among raft nodes before linearized reading' (duration: 296.800258ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:34.36894Z","caller":"traceutil/trace.go:171","msg":"trace[482361176] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"128.39148ms","start":"2026-06-13T22:51:34.240525Z","end":"2026-06-13T22:51:34.368917Z","steps":["trace[482361176] 'process raft request' (duration: 128.318997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:34.369283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.301314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-db-init-v76vr\" ","response":"range_response_count:1 size:7350"} {"level":"info","ts":"2026-06-13T22:51:34.369346Z","caller":"traceutil/trace.go:171","msg":"trace[1233965943] range","detail":"{range_begin:/registry/pods/openstack/keystone-db-init-v76vr; range_end:; response_count:1; response_revision:5427; }","duration":"114.394158ms","start":"2026-06-13T22:51:34.254937Z","end":"2026-06-13T22:51:34.369331Z","steps":["trace[1233965943] 'agreement among raft nodes before linearized reading' (duration: 113.948071ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:34.369303Z","caller":"traceutil/trace.go:171","msg":"trace[380845393] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"281.61759ms","start":"2026-06-13T22:51:34.087673Z","end":"2026-06-13T22:51:34.369291Z","steps":["trace[380845393] 'process raft request' (duration: 281.0914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:34.677158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.484531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:51:34.677252Z","caller":"traceutil/trace.go:171","msg":"trace[2136579575] linearizableReadLoop","detail":"{readStateIndex:5631; appliedIndex:5630; }","duration":"255.392295ms","start":"2026-06-13T22:51:34.421845Z","end":"2026-06-13T22:51:34.677238Z","steps":["trace[2136579575] 'read index received' (duration: 109.627673ms)","trace[2136579575] 'applied index is now lower than readState.Index' (duration: 145.763522ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:34.677318Z","caller":"traceutil/trace.go:171","msg":"trace[615017175] transaction","detail":"{read_only:false; response_revision:5428; number_of_response:1; }","duration":"297.791257ms","start":"2026-06-13T22:51:34.379519Z","end":"2026-06-13T22:51:34.677311Z","steps":["trace[615017175] 'process raft request' (duration: 152.048186ms)","trace[615017175] 'compare' (duration: 145.281443ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:51:34.677432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.792774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:34.677457Z","caller":"traceutil/trace.go:171","msg":"trace[241559621] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:5428; }","duration":"168.844165ms","start":"2026-06-13T22:51:34.508605Z","end":"2026-06-13T22:51:34.677449Z","steps":["trace[241559621] 'agreement among raft nodes before linearized reading' (duration: 168.799863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:34.677526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.11424ms","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-13T22:51:34.677602Z","caller":"traceutil/trace.go:171","msg":"trace[1413237447] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5428; }","duration":"212.242005ms","start":"2026-06-13T22:51:34.465342Z","end":"2026-06-13T22:51:34.677584Z","steps":["trace[1413237447] 'agreement among raft nodes before linearized reading' (duration: 211.995636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:34.677627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.695695ms","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-13T22:51:34.677644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.798381ms","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-13T22:51:34.677698Z","caller":"traceutil/trace.go:171","msg":"trace[567369333] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5428; }","duration":"255.905265ms","start":"2026-06-13T22:51:34.421779Z","end":"2026-06-13T22:51:34.677684Z","steps":["trace[567369333] 'agreement among raft nodes before linearized reading' (duration: 255.792351ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:34.677675Z","caller":"traceutil/trace.go:171","msg":"trace[1303177044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5428; }","duration":"117.768478ms","start":"2026-06-13T22:51:34.559894Z","end":"2026-06-13T22:51:34.677662Z","steps":["trace[1303177044] 'agreement among raft nodes before linearized reading' (duration: 117.490457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:34.677845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.114729ms","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-13T22:51:34.677938Z","caller":"traceutil/trace.go:171","msg":"trace[672198537] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5428; }","duration":"174.270885ms","start":"2026-06-13T22:51:34.50364Z","end":"2026-06-13T22:51:34.677911Z","steps":["trace[672198537] 'agreement among raft nodes before linearized reading' (duration: 174.062977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:35.513809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.682602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-13T22:51:35.513905Z","caller":"traceutil/trace.go:171","msg":"trace[1498000484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5434; }","duration":"211.852618ms","start":"2026-06-13T22:51:35.302022Z","end":"2026-06-13T22:51:35.513875Z","steps":["trace[1498000484] 'range keys from in-memory index tree' (duration: 211.583247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:35.514539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.241966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-06-13T22:51:35.515094Z","caller":"traceutil/trace.go:171","msg":"trace[147270240] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5434; }","duration":"376.852301ms","start":"2026-06-13T22:51:35.138221Z","end":"2026-06-13T22:51:35.515074Z","steps":["trace[147270240] 'range keys from in-memory index tree' (duration: 376.095262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:35.515192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:35.138198Z","time spent":"376.978615ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":551,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-06-13T22:51:35.894558Z","caller":"traceutil/trace.go:171","msg":"trace[1102192855] transaction","detail":"{read_only:false; response_revision:5436; number_of_response:1; }","duration":"206.509111ms","start":"2026-06-13T22:51:35.688013Z","end":"2026-06-13T22:51:35.894523Z","steps":["trace[1102192855] 'process raft request' (duration: 206.366185ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:51:35.89478Z","caller":"traceutil/trace.go:171","msg":"trace[2044003647] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"375.053741ms","start":"2026-06-13T22:51:35.519695Z","end":"2026-06-13T22:51:35.894748Z","steps":["trace[2044003647] 'process raft request' (duration: 374.493639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:35.89494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-13T22:51:35.519673Z","time spent":"375.182846ms","remote":"127.0.0.1:39436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-13T22:51:35.933398Z","caller":"traceutil/trace.go:171","msg":"trace[250360107] transaction","detail":"{read_only:false; response_revision:5437; number_of_response:1; }","duration":"181.481062ms","start":"2026-06-13T22:51:35.751899Z","end":"2026-06-13T22:51:35.93338Z","steps":["trace[250360107] 'process raft request' (duration: 181.374488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:51:36.805676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.247487ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:51:36.807021Z","caller":"traceutil/trace.go:171","msg":"trace[407004444] transaction","detail":"{read_only:false; response_revision:5441; number_of_response:1; }","duration":"209.303606ms","start":"2026-06-13T22:51:36.597072Z","end":"2026-06-13T22:51:36.806376Z","steps":["trace[407004444] 'process raft request' (duration: 75.153715ms)","trace[407004444] 'compare' (duration: 131.981347ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:51:42.56428Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2847} {"level":"info","ts":"2026-06-13T22:51:42.743093Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2847,"took":"177.658079ms","hash":2495682523,"current-db-size-bytes":52658176,"current-db-size":"53 MB","current-db-size-in-use-bytes":28647424,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-13T22:51:42.743162Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2495682523,"revision":2847,"compact-revision":-1} {"level":"info","ts":"2026-06-13T22:53:13.624337Z","caller":"traceutil/trace.go:171","msg":"trace[403544059] linearizableReadLoop","detail":"{readStateIndex:6266; appliedIndex:6264; }","duration":"103.589013ms","start":"2026-06-13T22:53:13.520725Z","end":"2026-06-13T22:53:13.624314Z","steps":["trace[403544059] 'read index received' (duration: 18.803887ms)","trace[403544059] 'applied index is now lower than readState.Index' (duration: 84.784166ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:53:13.624941Z","caller":"traceutil/trace.go:171","msg":"trace[453120785] transaction","detail":"{read_only:false; response_revision:6042; number_of_response:1; }","duration":"109.242587ms","start":"2026-06-13T22:53:13.515684Z","end":"2026-06-13T22:53:13.624926Z","steps":["trace[453120785] 'process raft request' (duration: 102.203086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:53:13.625889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.107085ms","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-13T22:53:13.627004Z","caller":"traceutil/trace.go:171","msg":"trace[704669209] transaction","detail":"{read_only:false; response_revision:6043; number_of_response:1; }","duration":"104.091373ms","start":"2026-06-13T22:53:13.522868Z","end":"2026-06-13T22:53:13.626959Z","steps":["trace[704669209] 'process raft request' (duration: 101.372511ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:13.626007Z","caller":"traceutil/trace.go:171","msg":"trace[1794853531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6043; }","duration":"105.278853ms","start":"2026-06-13T22:53:13.520703Z","end":"2026-06-13T22:53:13.625982Z","steps":["trace[1794853531] 'agreement among raft nodes before linearized reading' (duration: 104.877696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:53:45.361501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.741077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-13T22:53:45.361604Z","caller":"traceutil/trace.go:171","msg":"trace[693184039] transaction","detail":"{read_only:false; response_revision:6263; number_of_response:1; }","duration":"183.368513ms","start":"2026-06-13T22:53:45.178218Z","end":"2026-06-13T22:53:45.361586Z","steps":["trace[693184039] 'process raft request' (duration: 43.476939ms)","trace[693184039] 'compare' (duration: 139.470476ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:53:45.381354Z","caller":"traceutil/trace.go:171","msg":"trace[1521963190] linearizableReadLoop","detail":"{readStateIndex:6497; appliedIndex:6494; }","duration":"201.95754ms","start":"2026-06-13T22:53:45.179384Z","end":"2026-06-13T22:53:45.381342Z","steps":["trace[1521963190] 'read index received' (duration: 42.392643ms)","trace[1521963190] 'applied index is now lower than readState.Index' (duration: 159.563987ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:53:45.381445Z","caller":"traceutil/trace.go:171","msg":"trace[1500320252] transaction","detail":"{read_only:false; response_revision:6266; number_of_response:1; }","duration":"202.011023ms","start":"2026-06-13T22:53:45.179411Z","end":"2026-06-13T22:53:45.381422Z","steps":["trace[1500320252] 'process raft request' (duration: 201.801604ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:45.381462Z","caller":"traceutil/trace.go:171","msg":"trace[1637427503] transaction","detail":"{read_only:false; response_revision:6268; number_of_response:1; }","duration":"198.791128ms","start":"2026-06-13T22:53:45.182647Z","end":"2026-06-13T22:53:45.381438Z","steps":["trace[1637427503] 'process raft request' (duration: 198.649762ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:45.381309Z","caller":"traceutil/trace.go:171","msg":"trace[1641507523] transaction","detail":"{read_only:false; response_revision:6264; number_of_response:1; }","duration":"201.983362ms","start":"2026-06-13T22:53:45.179277Z","end":"2026-06-13T22:53:45.38126Z","steps":["trace[1641507523] 'process raft request' (duration: 201.865567ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:45.381454Z","caller":"traceutil/trace.go:171","msg":"trace[775401100] transaction","detail":"{read_only:false; response_revision:6265; number_of_response:1; }","duration":"202.042224ms","start":"2026-06-13T22:53:45.179368Z","end":"2026-06-13T22:53:45.381411Z","steps":["trace[775401100] 'process raft request' (duration: 201.822615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:53:45.381619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.219322ms","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:5"} {"level":"info","ts":"2026-06-13T22:53:45.381687Z","caller":"traceutil/trace.go:171","msg":"trace[401902516] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:6268; }","duration":"202.351417ms","start":"2026-06-13T22:53:45.179321Z","end":"2026-06-13T22:53:45.381672Z","steps":["trace[401902516] 'agreement among raft nodes before linearized reading' (duration: 202.224072ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:45.381387Z","caller":"traceutil/trace.go:171","msg":"trace[1554495975] transaction","detail":"{read_only:false; response_revision:6267; number_of_response:1; }","duration":"201.839945ms","start":"2026-06-13T22:53:45.179528Z","end":"2026-06-13T22:53:45.381368Z","steps":["trace[1554495975] 'process raft request' (duration: 201.741061ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:45.506677Z","caller":"traceutil/trace.go:171","msg":"trace[1473202275] transaction","detail":"{read_only:false; response_revision:6271; number_of_response:1; }","duration":"108.593944ms","start":"2026-06-13T22:53:45.39806Z","end":"2026-06-13T22:53:45.506654Z","steps":["trace[1473202275] 'process raft request' (duration: 108.445668ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:53:45.506671Z","caller":"traceutil/trace.go:171","msg":"trace[1804393090] transaction","detail":"{read_only:false; response_revision:6270; number_of_response:1; }","duration":"113.920957ms","start":"2026-06-13T22:53:45.392685Z","end":"2026-06-13T22:53:45.506606Z","steps":["trace[1804393090] 'process raft request' (duration: 83.567106ms)","trace[1804393090] 'compare' (duration: 30.059259ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:53:45.508281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.819673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-13T22:53:45.508482Z","caller":"traceutil/trace.go:171","msg":"trace[1483559594] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:6271; }","duration":"109.114586ms","start":"2026-06-13T22:53:45.39934Z","end":"2026-06-13T22:53:45.508455Z","steps":["trace[1483559594] 'agreement among raft nodes before linearized reading' (duration: 107.338902ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:54:12.015011Z","caller":"traceutil/trace.go:171","msg":"trace[1073000112] transaction","detail":"{read_only:false; response_revision:6532; number_of_response:1; }","duration":"194.021631ms","start":"2026-06-13T22:54:11.820974Z","end":"2026-06-13T22:54:12.014995Z","steps":["trace[1073000112] 'process raft request' (duration: 193.29466ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:54:14.621699Z","caller":"traceutil/trace.go:171","msg":"trace[2011088598] transaction","detail":"{read_only:false; response_revision:6547; number_of_response:1; }","duration":"129.381839ms","start":"2026-06-13T22:54:14.492293Z","end":"2026-06-13T22:54:14.621675Z","steps":["trace[2011088598] 'process raft request' (duration: 129.240733ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:56:42.570886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5496} {"level":"info","ts":"2026-06-13T22:56:42.65864Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5496,"took":"85.783288ms","hash":2663791923,"current-db-size-bytes":52658176,"current-db-size":"53 MB","current-db-size-in-use-bytes":18194432,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-13T22:56:42.658725Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2663791923,"revision":5496,"compact-revision":2847} {"level":"info","ts":"2026-06-13T22:57:35.350248Z","caller":"traceutil/trace.go:171","msg":"trace[1749456397] linearizableReadLoop","detail":"{readStateIndex:7933; appliedIndex:7932; }","duration":"101.387453ms","start":"2026-06-13T22:57:35.248824Z","end":"2026-06-13T22:57:35.350211Z","steps":["trace[1749456397] 'read index received' (duration: 19.008703ms)","trace[1749456397] 'applied index is now lower than readState.Index' (duration: 82.37734ms)"],"step_count":2} {"level":"info","ts":"2026-06-13T22:57:35.350322Z","caller":"traceutil/trace.go:171","msg":"trace[1174279408] transaction","detail":"{read_only:false; response_revision:7647; number_of_response:1; }","duration":"106.893516ms","start":"2026-06-13T22:57:35.243394Z","end":"2026-06-13T22:57:35.350288Z","steps":["trace[1174279408] 'process raft request' (duration: 24.441175ms)","trace[1174279408] 'compare' (duration: 82.207827ms)"],"step_count":2} {"level":"warn","ts":"2026-06-13T22:57:35.350602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.748619ms","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-13T22:57:35.350655Z","caller":"traceutil/trace.go:171","msg":"trace[582267131] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7647; }","duration":"101.871401ms","start":"2026-06-13T22:57:35.248771Z","end":"2026-06-13T22:57:35.350643Z","steps":["trace[582267131] 'agreement among raft nodes before linearized reading' (duration: 101.663898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-13T22:57:35.350726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.275254ms","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-13T22:57:35.350834Z","caller":"traceutil/trace.go:171","msg":"trace[1655724670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7647; }","duration":"100.411856ms","start":"2026-06-13T22:57:35.250399Z","end":"2026-06-13T22:57:35.350811Z","steps":["trace[1655724670] 'agreement among raft nodes before linearized reading' (duration: 100.170962ms)"],"step_count":1} {"level":"info","ts":"2026-06-13T22:57:35.492762Z","caller":"traceutil/trace.go:171","msg":"trace[105995328] transaction","detail":"{read_only:false; response_revision:7649; number_of_response:1; }","duration":"132.850548ms","start":"2026-06-13T22:57:35.359867Z","end":"2026-06-13T22:57:35.492718Z","steps":["trace[105995328] 'process raft request' (duration: 126.769644ms)"],"step_count":1}