{"level":"warn","ts":"2026-09-07T08:35:30.349746Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T08:35:30.34984Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.69: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://162.253.55.69:2380","--initial-cluster=instance=https://162.253.55.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.69: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-09-07T08:35:30.349912Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T08:35:30.349924Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.69:2380"]} {"level":"info","ts":"2026-09-07T08:35:30.349944Z","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-09-07T08:35:30.350809Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"]} {"level":"info","ts":"2026-09-07T08:35:30.350888Z","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://162.253.55.69:2380"],"listen-peer-urls":["https://162.253.55.69:2380"],"advertise-client-urls":["https://162.253.55.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.69: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-09-07T08:35:30.35538Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.223966ms"} {"level":"info","ts":"2026-09-07T08:35:30.363409Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"905ccde8a677f143","cluster-id":"6fd07fe3af558460"} {"level":"info","ts":"2026-09-07T08:35:30.36348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T08:35:30.363497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became follower at term 0"} {"level":"info","ts":"2026-09-07T08:35:30.363509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 905ccde8a677f143 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T08:35:30.363521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became follower at term 1"} {"level":"info","ts":"2026-09-07T08:35:30.363566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=(10402415638427988291)"} {"level":"warn","ts":"2026-09-07T08:35:30.376444Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T08:35:30.379225Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T08:35:30.380375Z","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-09-07T08:35:30.382124Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"905ccde8a677f143","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T08:35:30.383081Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"905ccde8a677f143","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T08:35:30.385318Z","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-09-07T08:35:30.385386Z","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-09-07T08:35:30.385395Z","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-09-07T08:35:30.386971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 switched to configuration voters=(10402415638427988291)"} {"level":"info","ts":"2026-09-07T08:35:30.387064Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6fd07fe3af558460","local-member-id":"905ccde8a677f143","added-peer-id":"905ccde8a677f143","added-peer-peer-urls":["https://162.253.55.69:2380"]} {"level":"info","ts":"2026-09-07T08:35:30.388079Z","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-09-07T08:35:30.388353Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"905ccde8a677f143","initial-advertise-peer-urls":["https://162.253.55.69:2380"],"listen-peer-urls":["https://162.253.55.69:2380"],"advertise-client-urls":["https://162.253.55.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T08:35:30.388392Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T08:35:30.388522Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.69:2380"} {"level":"info","ts":"2026-09-07T08:35:30.38855Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.69:2380"} {"level":"info","ts":"2026-09-07T08:35:30.463923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T08:35:30.463956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T08:35:30.464028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 received MsgPreVoteResp from 905ccde8a677f143 at term 1"} {"level":"info","ts":"2026-09-07T08:35:30.464056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became candidate at term 2"} {"level":"info","ts":"2026-09-07T08:35:30.464069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 received MsgVoteResp from 905ccde8a677f143 at term 2"} {"level":"info","ts":"2026-09-07T08:35:30.46408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"905ccde8a677f143 became leader at term 2"} {"level":"info","ts":"2026-09-07T08:35:30.46409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 905ccde8a677f143 elected leader 905ccde8a677f143 at term 2"} {"level":"info","ts":"2026-09-07T08:35:30.468697Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"905ccde8a677f143","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.69:2379]}","request-path":"/0/members/905ccde8a677f143/attributes","cluster-id":"6fd07fe3af558460","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T08:35:30.46882Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T08:35:30.468969Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:35:30.471235Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T08:35:30.472701Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T08:35:30.472812Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T08:35:30.475869Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T08:35:30.476014Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6fd07fe3af558460","local-member-id":"905ccde8a677f143","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:35:30.47611Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:35:30.476155Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T08:35:30.483386Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.69:2379"} {"level":"info","ts":"2026-09-07T08:35:32.495904Z","caller":"traceutil/trace.go:171","msg":"trace[40056918] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"113.393789ms","start":"2026-09-07T08:35:32.382473Z","end":"2026-09-07T08:35:32.495867Z","steps":["trace[40056918] 'process raft request' (duration: 113.249035ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:35:32.496103Z","caller":"traceutil/trace.go:171","msg":"trace[833554817] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"113.526224ms","start":"2026-09-07T08:35:32.382554Z","end":"2026-09-07T08:35:32.49608Z","steps":["trace[833554817] 'process raft request' (duration: 113.209824ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:35:32.495965Z","caller":"traceutil/trace.go:171","msg":"trace[756756396] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"115.525511ms","start":"2026-09-07T08:35:32.380333Z","end":"2026-09-07T08:35:32.495859Z","steps":["trace[756756396] 'process raft request' (duration: 62.753133ms)","trace[756756396] 'compare' (duration: 52.502791ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:35:32.496271Z","caller":"traceutil/trace.go:171","msg":"trace[1475553748] transaction","detail":"{read_only:false; response_revision:28; number_of_response:1; }","duration":"113.612496ms","start":"2026-09-07T08:35:32.382652Z","end":"2026-09-07T08:35:32.496264Z","steps":["trace[1475553748] 'process raft request' (duration: 113.194213ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:35:32.496383Z","caller":"traceutil/trace.go:171","msg":"trace[1095292368] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"113.708188ms","start":"2026-09-07T08:35:32.382665Z","end":"2026-09-07T08:35:32.496374Z","steps":["trace[1095292368] 'process raft request' (duration: 113.202623ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:35:32.496216Z","caller":"traceutil/trace.go:171","msg":"trace[1389084675] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"113.634146ms","start":"2026-09-07T08:35:32.382572Z","end":"2026-09-07T08:35:32.496207Z","steps":["trace[1389084675] 'process raft request' (duration: 113.222214ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:35:32.496247Z","caller":"traceutil/trace.go:171","msg":"trace[680983512] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"113.615726ms","start":"2026-09-07T08:35:32.382621Z","end":"2026-09-07T08:35:32.496236Z","steps":["trace[680983512] 'process raft request' (duration: 113.204483ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:35:33.574392Z","caller":"traceutil/trace.go:171","msg":"trace[149473031] transaction","detail":"{read_only:false; response_revision:136; number_of_response:1; }","duration":"267.249935ms","start":"2026-09-07T08:35:33.307116Z","end":"2026-09-07T08:35:33.574366Z","steps":["trace[149473031] 'process raft request' (duration: 170.528379ms)","trace[149473031] 'compare' (duration: 96.599282ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:35:35.165109Z","caller":"traceutil/trace.go:171","msg":"trace[2137933057] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:263; }","duration":"102.546339ms","start":"2026-09-07T08:35:35.062542Z","end":"2026-09-07T08:35:35.165088Z","steps":["trace[2137933057] 'read index received' (duration: 102.345903ms)","trace[2137933057] 'applied index is now lower than readState.Index' (duration: 199.666µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:35:35.165184Z","caller":"traceutil/trace.go:171","msg":"trace[1286753478] transaction","detail":"{read_only:false; response_revision:259; number_of_response:1; }","duration":"161.107172ms","start":"2026-09-07T08:35:35.004056Z","end":"2026-09-07T08:35:35.165163Z","steps":["trace[1286753478] 'process raft request' (duration: 160.900766ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:35:35.165408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.811288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-09-07T08:35:35.165496Z","caller":"traceutil/trace.go:171","msg":"trace[229152666] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:259; }","duration":"102.985763ms","start":"2026-09-07T08:35:35.062489Z","end":"2026-09-07T08:35:35.165475Z","steps":["trace[229152666] 'agreement among raft nodes before linearized reading' (duration: 102.739875ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:35:35.650402Z","caller":"traceutil/trace.go:171","msg":"trace[1508868557] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"476.600672ms","start":"2026-09-07T08:35:35.173775Z","end":"2026-09-07T08:35:35.650376Z","steps":["trace[1508868557] 'process raft request' (duration: 476.402776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:35:35.651117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:35:35.173763Z","time spent":"476.722407ms","remote":"127.0.0.1:48562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3694,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:35:35.667325Z","caller":"traceutil/trace.go:171","msg":"trace[1739006202] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"491.441167ms","start":"2026-09-07T08:35:35.175859Z","end":"2026-09-07T08:35:35.6673Z","steps":["trace[1739006202] 'process raft request' (duration: 486.539709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:35:35.66744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:35:35.175843Z","time spent":"491.54468ms","remote":"127.0.0.1:48584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T08:36:09.093553Z","caller":"traceutil/trace.go:171","msg":"trace[436587205] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"129.541347ms","start":"2026-09-07T08:36:08.963997Z","end":"2026-09-07T08:36:09.093538Z","steps":["trace[436587205] 'process raft request' (duration: 129.277242ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:36:09.838422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.957196ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:36:09.838498Z","caller":"traceutil/trace.go:171","msg":"trace[476302945] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"329.167219ms","start":"2026-09-07T08:36:09.509321Z","end":"2026-09-07T08:36:09.838488Z","steps":["trace[476302945] 'read index received' (duration: 31.968529ms)","trace[476302945] 'applied index is now lower than readState.Index' (duration: 297.19793ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:36:09.838587Z","caller":"traceutil/trace.go:171","msg":"trace[417951192] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"347.772592ms","start":"2026-09-07T08:36:09.490808Z","end":"2026-09-07T08:36:09.838581Z","steps":["trace[417951192] 'process raft request' (duration: 50.526229ms)","trace[417951192] 'compare' (duration: 296.785437ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:36:09.838612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:36:09.490186Z","time spent":"348.414266ms","remote":"127.0.0.1:48480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1749,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T08:36:09.838758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.37026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:36:09.838841Z","caller":"traceutil/trace.go:171","msg":"trace[1892978756] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:640; }","duration":"329.454215ms","start":"2026-09-07T08:36:09.509347Z","end":"2026-09-07T08:36:09.838801Z","steps":["trace[1892978756] 'agreement among raft nodes before linearized reading' (duration: 329.342579ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:36:09.838864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.539809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-07T08:36:09.83882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.292732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:36:09.838879Z","caller":"traceutil/trace.go:171","msg":"trace[1915303348] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:640; }","duration":"329.603384ms","start":"2026-09-07T08:36:09.509271Z","end":"2026-09-07T08:36:09.838874Z","steps":["trace[1915303348] 'agreement among raft nodes before linearized reading' (duration: 329.578423ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:36:09.838894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:36:09.509251Z","time spent":"329.638886ms","remote":"127.0.0.1:59136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-09-07T08:36:09.838944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:36:09.509328Z","time spent":"329.535139ms","remote":"127.0.0.1:59136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-09-07T08:36:09.839037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.597949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:36:09.839073Z","caller":"traceutil/trace.go:171","msg":"trace[1541438694] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:640; }","duration":"124.633541ms","start":"2026-09-07T08:36:09.714428Z","end":"2026-09-07T08:36:09.839062Z","steps":["trace[1541438694] 'agreement among raft nodes before linearized reading' (duration: 124.562217ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:36:09.83914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.638662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:36:09.83917Z","caller":"traceutil/trace.go:171","msg":"trace[1340193427] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:640; }","duration":"124.687194ms","start":"2026-09-07T08:36:09.714476Z","end":"2026-09-07T08:36:09.839163Z","steps":["trace[1340193427] 'agreement among raft nodes before linearized reading' (duration: 124.636722ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:36:09.838895Z","caller":"traceutil/trace.go:171","msg":"trace[687783882] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:640; }","duration":"124.381438ms","start":"2026-09-07T08:36:09.714504Z","end":"2026-09-07T08:36:09.838886Z","steps":["trace[687783882] 'agreement among raft nodes before linearized reading' (duration: 124.285412ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:36:09.839341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.201969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:36:09.839414Z","caller":"traceutil/trace.go:171","msg":"trace[214079648] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:640; }","duration":"231.270852ms","start":"2026-09-07T08:36:09.608091Z","end":"2026-09-07T08:36:09.839362Z","steps":["trace[214079648] 'agreement among raft nodes before linearized reading' (duration: 231.164016ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:36:16.418682Z","caller":"traceutil/trace.go:171","msg":"trace[414706517] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:715; }","duration":"310.132918ms","start":"2026-09-07T08:36:16.10853Z","end":"2026-09-07T08:36:16.418663Z","steps":["trace[414706517] 'read index received' (duration: 309.946877ms)","trace[414706517] 'applied index is now lower than readState.Index' (duration: 183.351µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:36:16.418734Z","caller":"traceutil/trace.go:171","msg":"trace[2123477306] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"552.398217ms","start":"2026-09-07T08:36:15.866308Z","end":"2026-09-07T08:36:16.418706Z","steps":["trace[2123477306] 'process raft request' (duration: 552.217606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:36:16.418857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.316849ms","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":"warn","ts":"2026-09-07T08:36:16.418864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:36:15.866277Z","time spent":"552.529023ms","remote":"127.0.0.1:48572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:36:16.418891Z","caller":"traceutil/trace.go:171","msg":"trace[1457203100] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:695; }","duration":"310.397703ms","start":"2026-09-07T08:36:16.108477Z","end":"2026-09-07T08:36:16.418875Z","steps":["trace[1457203100] 'agreement among raft nodes before linearized reading' (duration: 310.272726ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:36:16.418918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:36:16.108456Z","time spent":"310.456206ms","remote":"127.0.0.1:48638","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-09-07T08:37:01.474825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.235781ms","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-09-07T08:37:01.474928Z","caller":"traceutil/trace.go:171","msg":"trace[2001922614] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1211; }","duration":"130.379473ms","start":"2026-09-07T08:37:01.344532Z","end":"2026-09-07T08:37:01.474912Z","steps":["trace[2001922614] 'range keys from in-memory index tree' (duration: 130.087209ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:37:12.90673Z","caller":"traceutil/trace.go:171","msg":"trace[1850285018] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"135.110303ms","start":"2026-09-07T08:37:12.771603Z","end":"2026-09-07T08:37:12.906713Z","steps":["trace[1850285018] 'process raft request' (duration: 107.618979ms)","trace[1850285018] 'compare' (duration: 27.17092ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:37:20.949131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.780644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/ingress-nginx-admission\" ","response":"range_response_count:1 size:1659"} {"level":"info","ts":"2026-09-07T08:37:20.949217Z","caller":"traceutil/trace.go:171","msg":"trace[431395855] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/ingress-nginx-admission; range_end:; response_count:1; response_revision:1455; }","duration":"111.890902ms","start":"2026-09-07T08:37:20.837306Z","end":"2026-09-07T08:37:20.949197Z","steps":["trace[431395855] 'range keys from in-memory index tree' (duration: 111.622712ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.495523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.714041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:37:47.49562Z","caller":"traceutil/trace.go:171","msg":"trace[109675871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1867; }","duration":"281.844161ms","start":"2026-09-07T08:37:47.21375Z","end":"2026-09-07T08:37:47.495595Z","steps":["trace[109675871] 'range keys from in-memory index tree' (duration: 281.620784ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.495652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.16866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-09-07T08:37:47.495663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.142673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-271e92e1-077d-4a3d-91ed-05a4b10a4295\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-07T08:37:47.495709Z","caller":"traceutil/trace.go:171","msg":"trace[597510428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1867; }","duration":"409.240745ms","start":"2026-09-07T08:37:47.086446Z","end":"2026-09-07T08:37:47.495687Z","steps":["trace[597510428] 'range keys from in-memory index tree' (duration: 409.033298ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:37:47.495772Z","caller":"traceutil/trace.go:171","msg":"trace[1264871322] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-271e92e1-077d-4a3d-91ed-05a4b10a4295; range_end:; response_count:1; response_revision:1867; }","duration":"243.281634ms","start":"2026-09-07T08:37:47.252462Z","end":"2026-09-07T08:37:47.495744Z","steps":["trace[1264871322] 'range keys from in-memory index tree' (duration: 242.970228ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.49577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:37:47.086429Z","time spent":"409.329812ms","remote":"127.0.0.1:48638","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-09-07T08:37:47.495531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.815672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-271e92e1-077d-4a3d-91ed-05a4b10a4295\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-07T08:37:47.495863Z","caller":"traceutil/trace.go:171","msg":"trace[1448362865] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-271e92e1-077d-4a3d-91ed-05a4b10a4295; range_end:; response_count:1; response_revision:1867; }","duration":"307.199633ms","start":"2026-09-07T08:37:47.188646Z","end":"2026-09-07T08:37:47.495845Z","steps":["trace[1448362865] 'range keys from in-memory index tree' (duration: 306.606296ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.495897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:37:47.188629Z","time spent":"307.258638ms","remote":"127.0.0.1:48572","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-271e92e1-077d-4a3d-91ed-05a4b10a4295\" "} {"level":"warn","ts":"2026-09-07T08:37:47.495941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.910107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-09-07T08:37:47.495986Z","caller":"traceutil/trace.go:171","msg":"trace[2033030126] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1867; }","duration":"281.964492ms","start":"2026-09-07T08:37:47.214011Z","end":"2026-09-07T08:37:47.495975Z","steps":["trace[2033030126] 'range keys from in-memory index tree' (duration: 281.776017ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.496174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.662753ms","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-09-07T08:37:47.496215Z","caller":"traceutil/trace.go:171","msg":"trace[856397814] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1867; }","duration":"187.75141ms","start":"2026-09-07T08:37:47.308454Z","end":"2026-09-07T08:37:47.496205Z","steps":["trace[856397814] 'range keys from in-memory index tree' (duration: 187.525691ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:37:47.620816Z","caller":"traceutil/trace.go:171","msg":"trace[218474486] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"120.859974ms","start":"2026-09-07T08:37:47.499934Z","end":"2026-09-07T08:37:47.620794Z","steps":["trace[218474486] 'process raft request' (duration: 120.729204ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:37:47.804906Z","caller":"traceutil/trace.go:171","msg":"trace[1132534411] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"304.729196ms","start":"2026-09-07T08:37:47.500123Z","end":"2026-09-07T08:37:47.804853Z","steps":["trace[1132534411] 'process raft request' (duration: 251.531207ms)","trace[1132534411] 'compare' (duration: 52.910946ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:37:47.805001Z","caller":"traceutil/trace.go:171","msg":"trace[379377918] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"303.834156ms","start":"2026-09-07T08:37:47.501146Z","end":"2026-09-07T08:37:47.804981Z","steps":["trace[379377918] 'process raft request' (duration: 303.709246ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.805043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:37:47.500118Z","time spent":"304.853835ms","remote":"127.0.0.1:48638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:37:47.805139Z","caller":"traceutil/trace.go:171","msg":"trace[1044042854] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"301.826087ms","start":"2026-09-07T08:37:47.503293Z","end":"2026-09-07T08:37:47.805119Z","steps":["trace[1044042854] 'process raft request' (duration: 301.61964ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.805148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:37:47.501137Z","time spent":"303.925033ms","remote":"127.0.0.1:48638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T08:37:47.805179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.277716ms","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-09-07T08:37:47.805224Z","caller":"traceutil/trace.go:171","msg":"trace[1054256601] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1872; }","duration":"282.346652ms","start":"2026-09-07T08:37:47.522864Z","end":"2026-09-07T08:37:47.80521Z","steps":["trace[1054256601] 'agreement among raft nodes before linearized reading' (duration: 282.183298ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.805241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:37:47.503259Z","time spent":"301.925795ms","remote":"127.0.0.1:48572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T08:37:47.805018Z","caller":"traceutil/trace.go:171","msg":"trace[1575653339] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1938; }","duration":"282.098851ms","start":"2026-09-07T08:37:47.522901Z","end":"2026-09-07T08:37:47.805Z","steps":["trace[1575653339] 'read index received' (duration: 97.774384ms)","trace[1575653339] 'applied index is now lower than readState.Index' (duration: 184.323557ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:37:47.804975Z","caller":"traceutil/trace.go:171","msg":"trace[673751151] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"304.732206ms","start":"2026-09-07T08:37:47.500181Z","end":"2026-09-07T08:37:47.804913Z","steps":["trace[673751151] 'process raft request' (duration: 304.588574ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:37:47.805503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:37:47.500168Z","time spent":"305.246267ms","remote":"127.0.0.1:48638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T08:37:48.100161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.722025ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:37:48.100364Z","caller":"traceutil/trace.go:171","msg":"trace[325358288] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"154.164937ms","start":"2026-09-07T08:37:47.946185Z","end":"2026-09-07T08:37:48.10035Z","steps":["trace[325358288] 'read index received' (duration: 42.794µs)","trace[325358288] 'applied index is now lower than readState.Index' (duration: 154.120802ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:37:48.100463Z","caller":"traceutil/trace.go:171","msg":"trace[2127780723] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"290.048442ms","start":"2026-09-07T08:37:47.810387Z","end":"2026-09-07T08:37:48.100435Z","steps":["trace[2127780723] 'process raft request' (duration: 97.97738ms)","trace[2127780723] 'compare' (duration: 191.599735ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:37:48.100495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.307387ms","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-09-07T08:37:48.100567Z","caller":"traceutil/trace.go:171","msg":"trace[15895086] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1874; }","duration":"154.415037ms","start":"2026-09-07T08:37:47.946143Z","end":"2026-09-07T08:37:48.100558Z","steps":["trace[15895086] 'agreement among raft nodes before linearized reading' (duration: 154.258484ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:20.770799Z","caller":"traceutil/trace.go:171","msg":"trace[1289148561] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"107.222148ms","start":"2026-09-07T08:38:20.66353Z","end":"2026-09-07T08:38:20.770752Z","steps":["trace[1289148561] 'process raft request' (duration: 107.037773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:21.698385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.683937ms","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-09-07T08:38:21.698473Z","caller":"traceutil/trace.go:171","msg":"trace[1805103897] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2110; }","duration":"384.825167ms","start":"2026-09-07T08:38:21.313626Z","end":"2026-09-07T08:38:21.698451Z","steps":["trace[1805103897] 'range keys from in-memory index tree' (duration: 384.475248ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:21.698517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:21.313604Z","time spent":"384.902044ms","remote":"127.0.0.1:60734","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-07T08:38:21.698491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.80191ms","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-09-07T08:38:21.698569Z","caller":"traceutil/trace.go:171","msg":"trace[1865876968] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2110; }","duration":"121.889688ms","start":"2026-09-07T08:38:21.576672Z","end":"2026-09-07T08:38:21.698562Z","steps":["trace[1865876968] 'range keys from in-memory index tree' (duration: 121.79495ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:21.69913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.873197ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:38:21.699258Z","caller":"traceutil/trace.go:171","msg":"trace[1055446363] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"202.022467ms","start":"2026-09-07T08:38:21.49721Z","end":"2026-09-07T08:38:21.699232Z","steps":["trace[1055446363] 'process raft request' (duration: 79.964225ms)","trace[1055446363] 'compare' (duration: 121.05843ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:38:21.942528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.791679ms","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-09-07T08:38:21.942583Z","caller":"traceutil/trace.go:171","msg":"trace[1578023950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2111; }","duration":"120.893568ms","start":"2026-09-07T08:38:21.821676Z","end":"2026-09-07T08:38:21.942569Z","steps":["trace[1578023950] 'range keys from in-memory index tree' (duration: 120.641196ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:22.338289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.089379ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:38:22.338418Z","caller":"traceutil/trace.go:171","msg":"trace[2096810659] linearizableReadLoop","detail":"{readStateIndex:2192; appliedIndex:2190; }","duration":"350.215037ms","start":"2026-09-07T08:38:21.988181Z","end":"2026-09-07T08:38:22.338396Z","steps":["trace[2096810659] 'read index received' (duration: 10.221219ms)","trace[2096810659] 'applied index is now lower than readState.Index' (duration: 339.992098ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:38:22.338652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.815117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:38:22.33866Z","caller":"traceutil/trace.go:171","msg":"trace[1052398347] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"392.196454ms","start":"2026-09-07T08:38:21.946313Z","end":"2026-09-07T08:38:22.33851Z","steps":["trace[1052398347] 'process raft request' (duration: 100.790349ms)","trace[1052398347] 'compare' (duration: 290.96848ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:38:22.338696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.964228ms","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-09-07T08:38:22.338715Z","caller":"traceutil/trace.go:171","msg":"trace[894050164] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2113; }","duration":"125.916397ms","start":"2026-09-07T08:38:22.212782Z","end":"2026-09-07T08:38:22.338699Z","steps":["trace[894050164] 'agreement among raft nodes before linearized reading' (duration: 125.819268ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:38:22.338778Z","caller":"traceutil/trace.go:171","msg":"trace[1006477070] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2113; }","duration":"346.075758ms","start":"2026-09-07T08:38:21.992686Z","end":"2026-09-07T08:38:22.338761Z","steps":["trace[1006477070] 'agreement among raft nodes before linearized reading' (duration: 345.853539ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:22.338762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:21.946295Z","time spent":"392.418293ms","remote":"127.0.0.1:48638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T08:38:22.338912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.62175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-07T08:38:22.338819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:21.992673Z","time spent":"346.137703ms","remote":"127.0.0.1:48638","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":"info","ts":"2026-09-07T08:38:22.338958Z","caller":"traceutil/trace.go:171","msg":"trace[465368766] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2113; }","duration":"345.708547ms","start":"2026-09-07T08:38:21.993238Z","end":"2026-09-07T08:38:22.338947Z","steps":["trace[465368766] 'agreement among raft nodes before linearized reading' (duration: 345.602108ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:22.338984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:21.993215Z","time spent":"345.761421ms","remote":"127.0.0.1:48638","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-09-07T08:38:22.339055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.823777ms","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-09-07T08:38:22.339191Z","caller":"traceutil/trace.go:171","msg":"trace[1730204773] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2113; }","duration":"351.007163ms","start":"2026-09-07T08:38:21.988123Z","end":"2026-09-07T08:38:22.33913Z","steps":["trace[1730204773] 'agreement among raft nodes before linearized reading' (duration: 350.733891ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:38:22.339294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T08:38:21.988102Z","time spent":"351.133202ms","remote":"127.0.0.1:48638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-07T08:39:26.592645Z","caller":"traceutil/trace.go:171","msg":"trace[213456928] linearizableReadLoop","detail":"{readStateIndex:2658; appliedIndex:2657; }","duration":"127.991947ms","start":"2026-09-07T08:39:26.464632Z","end":"2026-09-07T08:39:26.592624Z","steps":["trace[213456928] 'read index received' (duration: 113.426301ms)","trace[213456928] 'applied index is now lower than readState.Index' (duration: 14.564556ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:39:26.592845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.198626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-09-07T08:39:26.592845Z","caller":"traceutil/trace.go:171","msg":"trace[940398212] transaction","detail":"{read_only:false; response_revision:2564; number_of_response:1; }","duration":"190.226863ms","start":"2026-09-07T08:39:26.402583Z","end":"2026-09-07T08:39:26.59281Z","steps":["trace[940398212] 'process raft request' (duration: 175.557668ms)","trace[940398212] 'compare' (duration: 14.150939ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:39:26.592872Z","caller":"traceutil/trace.go:171","msg":"trace[63458445] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2564; }","duration":"128.273754ms","start":"2026-09-07T08:39:26.464592Z","end":"2026-09-07T08:39:26.592865Z","steps":["trace[63458445] 'agreement among raft nodes before linearized reading' (duration: 128.105006ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:39:59.230305Z","caller":"traceutil/trace.go:171","msg":"trace[583704189] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"164.995358ms","start":"2026-09-07T08:39:59.065287Z","end":"2026-09-07T08:39:59.230282Z","steps":["trace[583704189] 'process raft request' (duration: 164.821276ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:39:59.243453Z","caller":"traceutil/trace.go:171","msg":"trace[1207266625] transaction","detail":"{read_only:false; response_revision:2748; number_of_response:1; }","duration":"158.83199ms","start":"2026-09-07T08:39:59.084604Z","end":"2026-09-07T08:39:59.243436Z","steps":["trace[1207266625] 'process raft request' (duration: 158.732529ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:09.126354Z","caller":"traceutil/trace.go:171","msg":"trace[1300596831] linearizableReadLoop","detail":"{readStateIndex:4854; appliedIndex:4853; }","duration":"214.321757ms","start":"2026-09-07T08:44:08.912012Z","end":"2026-09-07T08:44:09.126333Z","steps":["trace[1300596831] 'read index received' (duration: 214.172288ms)","trace[1300596831] 'applied index is now lower than readState.Index' (duration: 148.579µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:44:09.126471Z","caller":"traceutil/trace.go:171","msg":"trace[808715310] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"219.621273ms","start":"2026-09-07T08:44:08.90684Z","end":"2026-09-07T08:44:09.126462Z","steps":["trace[808715310] 'process raft request' (duration: 219.365466ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:09.126647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.660136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-07T08:44:09.126713Z","caller":"traceutil/trace.go:171","msg":"trace[720575836] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4679; }","duration":"190.761302ms","start":"2026-09-07T08:44:08.935936Z","end":"2026-09-07T08:44:09.126697Z","steps":["trace[720575836] 'agreement among raft nodes before linearized reading' (duration: 190.601202ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:09.126696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.49727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0.18d2fd6d620e62ba\" ","response":"range_response_count:1 size:1179"} {"level":"info","ts":"2026-09-07T08:44:09.126755Z","caller":"traceutil/trace.go:171","msg":"trace[549700048] range","detail":"{range_begin:/registry/events/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0.18d2fd6d620e62ba; range_end:; response_count:1; response_revision:4679; }","duration":"140.599457ms","start":"2026-09-07T08:44:08.986141Z","end":"2026-09-07T08:44:09.126741Z","steps":["trace[549700048] 'agreement among raft nodes before linearized reading' (duration: 140.413155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:09.126836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.880215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-07T08:44:09.126906Z","caller":"traceutil/trace.go:171","msg":"trace[1553818115] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4679; }","duration":"149.989112ms","start":"2026-09-07T08:44:08.9769Z","end":"2026-09-07T08:44:09.126889Z","steps":["trace[1553818115] 'agreement among raft nodes before linearized reading' (duration: 149.813551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:09.127458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.439349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-07T08:44:09.1275Z","caller":"traceutil/trace.go:171","msg":"trace[51396458] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4679; }","duration":"215.513273ms","start":"2026-09-07T08:44:08.911975Z","end":"2026-09-07T08:44:09.127488Z","steps":["trace[51396458] 'agreement among raft nodes before linearized reading' (duration: 214.688701ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:11.27884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.557971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-07T08:44:11.278922Z","caller":"traceutil/trace.go:171","msg":"trace[746798205] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4729; }","duration":"134.683069ms","start":"2026-09-07T08:44:11.144222Z","end":"2026-09-07T08:44:11.278905Z","steps":["trace[746798205] 'range keys from in-memory index tree' (duration: 134.394421ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:17.127674Z","caller":"traceutil/trace.go:171","msg":"trace[520455424] linearizableReadLoop","detail":"{readStateIndex:5046; appliedIndex:5045; }","duration":"123.129101ms","start":"2026-09-07T08:44:17.004515Z","end":"2026-09-07T08:44:17.127644Z","steps":["trace[520455424] 'read index received' (duration: 122.959391ms)","trace[520455424] 'applied index is now lower than readState.Index' (duration: 167.79µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:44:17.127853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.309962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:44:17.128437Z","caller":"traceutil/trace.go:171","msg":"trace[369366018] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:4865; }","duration":"123.936982ms","start":"2026-09-07T08:44:17.004478Z","end":"2026-09-07T08:44:17.128415Z","steps":["trace[369366018] 'agreement among raft nodes before linearized reading' (duration: 123.27579ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:17.172154Z","caller":"traceutil/trace.go:171","msg":"trace[2106132423] transaction","detail":"{read_only:false; response_revision:4866; number_of_response:1; }","duration":"165.53859ms","start":"2026-09-07T08:44:17.006598Z","end":"2026-09-07T08:44:17.172137Z","steps":["trace[2106132423] 'process raft request' (duration: 165.368479ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:17.343417Z","caller":"traceutil/trace.go:171","msg":"trace[560714919] transaction","detail":"{read_only:false; response_revision:4867; number_of_response:1; }","duration":"214.779074ms","start":"2026-09-07T08:44:17.128618Z","end":"2026-09-07T08:44:17.343397Z","steps":["trace[560714919] 'process raft request' (duration: 214.620844ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:20.296826Z","caller":"traceutil/trace.go:171","msg":"trace[1634648920] linearizableReadLoop","detail":"{readStateIndex:5094; appliedIndex:5093; }","duration":"148.27369ms","start":"2026-09-07T08:44:20.148531Z","end":"2026-09-07T08:44:20.296804Z","steps":["trace[1634648920] 'read index received' (duration: 148.079838ms)","trace[1634648920] 'applied index is now lower than readState.Index' (duration: 192.742µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:44:20.296924Z","caller":"traceutil/trace.go:171","msg":"trace[1992458696] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"151.2201ms","start":"2026-09-07T08:44:20.145681Z","end":"2026-09-07T08:44:20.296901Z","steps":["trace[1992458696] 'process raft request' (duration: 150.972754ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:20.297075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.527497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-09-07T08:44:20.29712Z","caller":"traceutil/trace.go:171","msg":"trace[1891027475] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4912; }","duration":"148.602212ms","start":"2026-09-07T08:44:20.148503Z","end":"2026-09-07T08:44:20.297105Z","steps":["trace[1891027475] 'agreement among raft nodes before linearized reading' (duration: 148.456652ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:20.297565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.563551ms","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-09-07T08:44:20.297646Z","caller":"traceutil/trace.go:171","msg":"trace[2146824243] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4912; }","duration":"139.661177ms","start":"2026-09-07T08:44:20.157969Z","end":"2026-09-07T08:44:20.29763Z","steps":["trace[2146824243] 'agreement among raft nodes before linearized reading' (duration: 139.512757ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:20.297951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.748881ms","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-09-07T08:44:20.298004Z","caller":"traceutil/trace.go:171","msg":"trace[1629509372] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4912; }","duration":"148.815896ms","start":"2026-09-07T08:44:20.149172Z","end":"2026-09-07T08:44:20.297988Z","steps":["trace[1629509372] 'agreement among raft nodes before linearized reading' (duration: 147.95006ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:25.502701Z","caller":"traceutil/trace.go:171","msg":"trace[1240963231] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"132.274252ms","start":"2026-09-07T08:44:25.3704Z","end":"2026-09-07T08:44:25.502674Z","steps":["trace[1240963231] 'process raft request' (duration: 131.385465ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:29.563121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.597826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:44:29.563217Z","caller":"traceutil/trace.go:171","msg":"trace[547494367] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:5043; }","duration":"224.724846ms","start":"2026-09-07T08:44:29.338459Z","end":"2026-09-07T08:44:29.563184Z","steps":["trace[547494367] 'count revisions from in-memory index tree' (duration: 224.526333ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:29.640183Z","caller":"traceutil/trace.go:171","msg":"trace[2092578868] linearizableReadLoop","detail":"{readStateIndex:5232; appliedIndex:5230; }","duration":"106.130438ms","start":"2026-09-07T08:44:29.534026Z","end":"2026-09-07T08:44:29.640156Z","steps":["trace[2092578868] 'read index received' (duration: 33.344331ms)","trace[2092578868] 'applied index is now lower than readState.Index' (duration: 72.784597ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:44:29.640702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.645502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-07T08:44:29.640853Z","caller":"traceutil/trace.go:171","msg":"trace[1444861651] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5044; }","duration":"106.852226ms","start":"2026-09-07T08:44:29.533975Z","end":"2026-09-07T08:44:29.640827Z","steps":["trace[1444861651] 'agreement among raft nodes before linearized reading' (duration: 106.437939ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:30.524743Z","caller":"traceutil/trace.go:171","msg":"trace[10668629] linearizableReadLoop","detail":"{readStateIndex:5238; appliedIndex:5237; }","duration":"183.242258ms","start":"2026-09-07T08:44:30.341477Z","end":"2026-09-07T08:44:30.524719Z","steps":["trace[10668629] 'read index received' (duration: 182.982201ms)","trace[10668629] 'applied index is now lower than readState.Index' (duration: 258.887µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:44:30.525152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.909136ms","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-09-07T08:44:30.525224Z","caller":"traceutil/trace.go:171","msg":"trace[378809024] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5050; }","duration":"172.997262ms","start":"2026-09-07T08:44:30.352206Z","end":"2026-09-07T08:44:30.525204Z","steps":["trace[378809024] 'agreement among raft nodes before linearized reading' (duration: 172.837862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:30.525277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.758621ms","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-09-07T08:44:30.525278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.448051ms","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-09-07T08:44:30.525269Z","caller":"traceutil/trace.go:171","msg":"trace[11761688] transaction","detail":"{read_only:false; response_revision:5050; number_of_response:1; }","duration":"188.512498ms","start":"2026-09-07T08:44:30.336685Z","end":"2026-09-07T08:44:30.525198Z","steps":["trace[11761688] 'process raft request' (duration: 187.854906ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:30.525337Z","caller":"traceutil/trace.go:171","msg":"trace[1913411789] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5050; }","duration":"183.900159ms","start":"2026-09-07T08:44:30.341423Z","end":"2026-09-07T08:44:30.525324Z","steps":["trace[1913411789] 'agreement among raft nodes before linearized reading' (duration: 183.707427ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:44:30.525355Z","caller":"traceutil/trace.go:171","msg":"trace[594737925] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5050; }","duration":"179.609071ms","start":"2026-09-07T08:44:30.345727Z","end":"2026-09-07T08:44:30.525336Z","steps":["trace[594737925] 'agreement among raft nodes before linearized reading' (duration: 179.364636ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:44:30.525813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.909611ms","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-09-07T08:44:30.525866Z","caller":"traceutil/trace.go:171","msg":"trace[2131956032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5050; }","duration":"183.974505ms","start":"2026-09-07T08:44:30.341878Z","end":"2026-09-07T08:44:30.525852Z","steps":["trace[2131956032] 'agreement among raft nodes before linearized reading' (duration: 183.088398ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:45:30.781823Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2910} {"level":"info","ts":"2026-09-07T08:45:30.865783Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2910,"took":"82.888105ms","hash":3105020514,"current-db-size-bytes":53563392,"current-db-size":"54 MB","current-db-size-in-use-bytes":29028352,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-07T08:45:30.865832Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3105020514,"revision":2910,"compact-revision":-1} {"level":"info","ts":"2026-09-07T08:46:35.517414Z","caller":"traceutil/trace.go:171","msg":"trace[117555396] transaction","detail":"{read_only:false; response_revision:5962; number_of_response:1; }","duration":"112.955483ms","start":"2026-09-07T08:46:35.404408Z","end":"2026-09-07T08:46:35.517364Z","steps":["trace[117555396] 'process raft request' (duration: 36.160391ms)","trace[117555396] 'compare' (duration: 76.536844ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:36.284903Z","caller":"traceutil/trace.go:171","msg":"trace[879470649] transaction","detail":"{read_only:false; response_revision:5964; number_of_response:1; }","duration":"120.466947ms","start":"2026-09-07T08:46:36.164398Z","end":"2026-09-07T08:46:36.284865Z","steps":["trace[879470649] 'process raft request' (duration: 120.282173ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:36.741002Z","caller":"traceutil/trace.go:171","msg":"trace[1339185738] transaction","detail":"{read_only:false; response_revision:5966; number_of_response:1; }","duration":"104.845723ms","start":"2026-09-07T08:46:36.636112Z","end":"2026-09-07T08:46:36.740958Z","steps":["trace[1339185738] 'process raft request' (duration: 55.518296ms)","trace[1339185738] 'compare' (duration: 49.160365ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:39.592172Z","caller":"traceutil/trace.go:171","msg":"trace[849901531] transaction","detail":"{read_only:false; response_revision:5981; number_of_response:1; }","duration":"123.341665ms","start":"2026-09-07T08:46:39.468786Z","end":"2026-09-07T08:46:39.592127Z","steps":["trace[849901531] 'process raft request' (duration: 83.308422ms)","trace[849901531] 'compare' (duration: 39.743352ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:39.71648Z","caller":"traceutil/trace.go:171","msg":"trace[480698909] linearizableReadLoop","detail":"{readStateIndex:6198; appliedIndex:6197; }","duration":"106.413209ms","start":"2026-09-07T08:46:39.610046Z","end":"2026-09-07T08:46:39.71646Z","steps":["trace[480698909] 'read index received' (duration: 93.436587ms)","trace[480698909] 'applied index is now lower than readState.Index' (duration: 12.974692ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:39.716476Z","caller":"traceutil/trace.go:171","msg":"trace[1827414664] transaction","detail":"{read_only:false; response_revision:5982; number_of_response:1; }","duration":"120.485906ms","start":"2026-09-07T08:46:39.595942Z","end":"2026-09-07T08:46:39.716427Z","steps":["trace[1827414664] 'process raft request' (duration: 107.480072ms)","trace[1827414664] 'compare' (duration: 12.838423ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:46:39.725291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.194839ms","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-09-07T08:46:39.725391Z","caller":"traceutil/trace.go:171","msg":"trace[1742366304] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5982; }","duration":"115.35304ms","start":"2026-09-07T08:46:39.610009Z","end":"2026-09-07T08:46:39.725362Z","steps":["trace[1742366304] 'agreement among raft nodes before linearized reading' (duration: 106.548397ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:40.957016Z","caller":"traceutil/trace.go:171","msg":"trace[759945880] transaction","detail":"{read_only:false; response_revision:5987; number_of_response:1; }","duration":"120.054489ms","start":"2026-09-07T08:46:40.836935Z","end":"2026-09-07T08:46:40.95699Z","steps":["trace[759945880] 'process raft request' (duration: 119.940191ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:41.81776Z","caller":"traceutil/trace.go:171","msg":"trace[990338779] transaction","detail":"{read_only:false; response_revision:5992; number_of_response:1; }","duration":"132.689881ms","start":"2026-09-07T08:46:41.685048Z","end":"2026-09-07T08:46:41.817738Z","steps":["trace[990338779] 'process raft request' (duration: 132.53127ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:43.069001Z","caller":"traceutil/trace.go:171","msg":"trace[761854275] transaction","detail":"{read_only:false; response_revision:5998; number_of_response:1; }","duration":"107.570816ms","start":"2026-09-07T08:46:42.9614Z","end":"2026-09-07T08:46:43.068971Z","steps":["trace[761854275] 'process raft request' (duration: 107.292486ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:43.206033Z","caller":"traceutil/trace.go:171","msg":"trace[731298334] transaction","detail":"{read_only:false; response_revision:5999; number_of_response:1; }","duration":"132.228944ms","start":"2026-09-07T08:46:43.073785Z","end":"2026-09-07T08:46:43.206014Z","steps":["trace[731298334] 'process raft request' (duration: 59.303927ms)","trace[731298334] 'compare' (duration: 72.763565ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:44.004486Z","caller":"traceutil/trace.go:171","msg":"trace[700708640] transaction","detail":"{read_only:false; response_revision:6004; number_of_response:1; }","duration":"107.487862ms","start":"2026-09-07T08:46:43.896963Z","end":"2026-09-07T08:46:44.004451Z","steps":["trace[700708640] 'process raft request' (duration: 68.021145ms)","trace[700708640] 'compare' (duration: 39.286355ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:45.414302Z","caller":"traceutil/trace.go:171","msg":"trace[750798355] transaction","detail":"{read_only:false; response_revision:6010; number_of_response:1; }","duration":"140.26643ms","start":"2026-09-07T08:46:45.274013Z","end":"2026-09-07T08:46:45.41428Z","steps":["trace[750798355] 'process raft request' (duration: 101.549023ms)","trace[750798355] 'compare' (duration: 38.602809ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:46.572606Z","caller":"traceutil/trace.go:171","msg":"trace[355519749] transaction","detail":"{read_only:false; response_revision:6015; number_of_response:1; }","duration":"157.657374ms","start":"2026-09-07T08:46:46.414928Z","end":"2026-09-07T08:46:46.572585Z","steps":["trace[355519749] 'process raft request' (duration: 157.533575ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:47.616762Z","caller":"traceutil/trace.go:171","msg":"trace[1919467321] linearizableReadLoop","detail":"{readStateIndex:6238; appliedIndex:6237; }","duration":"144.442447ms","start":"2026-09-07T08:46:47.4723Z","end":"2026-09-07T08:46:47.616743Z","steps":["trace[1919467321] 'read index received' (duration: 120.100359ms)","trace[1919467321] 'applied index is now lower than readState.Index' (duration: 24.341118ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:47.616782Z","caller":"traceutil/trace.go:171","msg":"trace[1983816676] transaction","detail":"{read_only:false; response_revision:6020; number_of_response:1; }","duration":"197.624372ms","start":"2026-09-07T08:46:47.419127Z","end":"2026-09-07T08:46:47.616751Z","steps":["trace[1983816676] 'process raft request' (duration: 173.364151ms)","trace[1983816676] 'compare' (duration: 24.163454ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:46:47.617457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.574445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T08:46:47.618046Z","caller":"traceutil/trace.go:171","msg":"trace[1884686891] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:6020; }","duration":"145.79234ms","start":"2026-09-07T08:46:47.472237Z","end":"2026-09-07T08:46:47.618029Z","steps":["trace[1884686891] 'agreement among raft nodes before linearized reading' (duration: 144.592007ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:48.873027Z","caller":"traceutil/trace.go:171","msg":"trace[1251915762] transaction","detail":"{read_only:false; response_revision:6026; number_of_response:1; }","duration":"125.393851ms","start":"2026-09-07T08:46:48.747601Z","end":"2026-09-07T08:46:48.872995Z","steps":["trace[1251915762] 'process raft request' (duration: 125.23377ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:49.742663Z","caller":"traceutil/trace.go:171","msg":"trace[915477290] transaction","detail":"{read_only:false; response_revision:6030; number_of_response:1; }","duration":"120.992937ms","start":"2026-09-07T08:46:49.621637Z","end":"2026-09-07T08:46:49.74263Z","steps":["trace[915477290] 'process raft request' (duration: 56.595817ms)","trace[915477290] 'compare' (duration: 64.231558ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:46:51.949373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.053827ms","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-09-07T08:46:51.949467Z","caller":"traceutil/trace.go:171","msg":"trace[1976290560] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6039; }","duration":"112.197577ms","start":"2026-09-07T08:46:51.837247Z","end":"2026-09-07T08:46:51.949445Z","steps":["trace[1976290560] 'range keys from in-memory index tree' (duration: 111.866394ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:52.254415Z","caller":"traceutil/trace.go:171","msg":"trace[499391126] transaction","detail":"{read_only:false; response_revision:6043; number_of_response:1; }","duration":"190.132517ms","start":"2026-09-07T08:46:52.064252Z","end":"2026-09-07T08:46:52.254385Z","steps":["trace[499391126] 'process raft request' (duration: 190.095345ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:52.254443Z","caller":"traceutil/trace.go:171","msg":"trace[283392710] linearizableReadLoop","detail":"{readStateIndex:6261; appliedIndex:6260; }","duration":"205.619159ms","start":"2026-09-07T08:46:52.048801Z","end":"2026-09-07T08:46:52.25442Z","steps":["trace[283392710] 'read index received' (duration: 118.514801ms)","trace[283392710] 'applied index is now lower than readState.Index' (duration: 87.102328ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:46:52.254625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.803181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:46:52.25467Z","caller":"traceutil/trace.go:171","msg":"trace[404820735] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:6043; }","duration":"205.895708ms","start":"2026-09-07T08:46:52.048765Z","end":"2026-09-07T08:46:52.254661Z","steps":["trace[404820735] 'agreement among raft nodes before linearized reading' (duration: 205.769819ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:52.255109Z","caller":"traceutil/trace.go:171","msg":"trace[1488612391] transaction","detail":"{read_only:false; response_revision:6042; number_of_response:1; }","duration":"207.93391ms","start":"2026-09-07T08:46:52.047152Z","end":"2026-09-07T08:46:52.255086Z","steps":["trace[1488612391] 'process raft request' (duration: 120.22753ms)","trace[1488612391] 'compare' (duration: 86.852921ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:46:54.472368Z","caller":"traceutil/trace.go:171","msg":"trace[1393323916] transaction","detail":"{read_only:false; response_revision:6054; number_of_response:1; }","duration":"147.428774ms","start":"2026-09-07T08:46:54.324915Z","end":"2026-09-07T08:46:54.472344Z","steps":["trace[1393323916] 'process raft request' (duration: 147.272613ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:54.501761Z","caller":"traceutil/trace.go:171","msg":"trace[489028829] transaction","detail":"{read_only:false; response_revision:6055; number_of_response:1; }","duration":"176.770351ms","start":"2026-09-07T08:46:54.324969Z","end":"2026-09-07T08:46:54.501739Z","steps":["trace[489028829] 'process raft request' (duration: 176.590319ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:46:55.473509Z","caller":"traceutil/trace.go:171","msg":"trace[1051596211] transaction","detail":"{read_only:false; response_revision:6059; number_of_response:1; }","duration":"121.076056ms","start":"2026-09-07T08:46:55.352387Z","end":"2026-09-07T08:46:55.473463Z","steps":["trace[1051596211] 'process raft request' (duration: 117.145091ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:48:04.905674Z","caller":"traceutil/trace.go:171","msg":"trace[1938156326] transaction","detail":"{read_only:false; response_revision:6615; number_of_response:1; }","duration":"184.236386ms","start":"2026-09-07T08:48:04.721414Z","end":"2026-09-07T08:48:04.905651Z","steps":["trace[1938156326] 'process raft request' (duration: 170.900102ms)","trace[1938156326] 'compare' (duration: 12.829149ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:48:04.90573Z","caller":"traceutil/trace.go:171","msg":"trace[302381125] linearizableReadLoop","detail":"{readStateIndex:6854; appliedIndex:6853; }","duration":"167.355394ms","start":"2026-09-07T08:48:04.738355Z","end":"2026-09-07T08:48:04.90571Z","steps":["trace[302381125] 'read index received' (duration: 153.861082ms)","trace[302381125] 'applied index is now lower than readState.Index' (duration: 13.492332ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:48:04.90586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.869754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:48:04.905881Z","caller":"traceutil/trace.go:171","msg":"trace[150372740] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:6616; }","duration":"123.937534ms","start":"2026-09-07T08:48:04.781937Z","end":"2026-09-07T08:48:04.905875Z","steps":["trace[150372740] 'agreement among raft nodes before linearized reading' (duration: 123.873464ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:48:04.905901Z","caller":"traceutil/trace.go:171","msg":"trace[1569493964] transaction","detail":"{read_only:false; response_revision:6616; number_of_response:1; }","duration":"156.759227ms","start":"2026-09-07T08:48:04.749132Z","end":"2026-09-07T08:48:04.905891Z","steps":["trace[1569493964] 'process raft request' (duration: 156.36116ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:48:04.905899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.539723ms","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-09-07T08:48:04.905956Z","caller":"traceutil/trace.go:171","msg":"trace[266334028] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6616; }","duration":"167.604352ms","start":"2026-09-07T08:48:04.738325Z","end":"2026-09-07T08:48:04.905929Z","steps":["trace[266334028] 'agreement among raft nodes before linearized reading' (duration: 167.458774ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:48:09.34552Z","caller":"traceutil/trace.go:171","msg":"trace[1913010662] transaction","detail":"{read_only:false; response_revision:6651; number_of_response:1; }","duration":"100.955453ms","start":"2026-09-07T08:48:09.244539Z","end":"2026-09-07T08:48:09.345494Z","steps":["trace[1913010662] 'process raft request' (duration: 100.407787ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:48:09.363299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.431568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T08:48:09.36338Z","caller":"traceutil/trace.go:171","msg":"trace[323006806] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:6651; }","duration":"104.566626ms","start":"2026-09-07T08:48:09.2588Z","end":"2026-09-07T08:48:09.363367Z","steps":["trace[323006806] 'agreement among raft nodes before linearized reading' (duration: 104.334368ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:48:22.683014Z","caller":"traceutil/trace.go:171","msg":"trace[1885092069] linearizableReadLoop","detail":"{readStateIndex:7004; appliedIndex:7003; }","duration":"140.78146ms","start":"2026-09-07T08:48:22.542179Z","end":"2026-09-07T08:48:22.682961Z","steps":["trace[1885092069] 'read index received' (duration: 140.472742ms)","trace[1885092069] 'applied index is now lower than readState.Index' (duration: 308.068µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:48:22.683141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.943329ms","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-09-07T08:48:22.683164Z","caller":"traceutil/trace.go:171","msg":"trace[1655683605] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:6758; }","duration":"141.038678ms","start":"2026-09-07T08:48:22.542119Z","end":"2026-09-07T08:48:22.683157Z","steps":["trace[1655683605] 'agreement among raft nodes before linearized reading' (duration: 140.957049ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:48:22.68375Z","caller":"traceutil/trace.go:171","msg":"trace[891756857] transaction","detail":"{read_only:false; response_revision:6758; number_of_response:1; }","duration":"180.357982ms","start":"2026-09-07T08:48:22.503382Z","end":"2026-09-07T08:48:22.68374Z","steps":["trace[891756857] 'process raft request' (duration: 179.434346ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:48:23.003322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.894784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-07T08:48:23.003411Z","caller":"traceutil/trace.go:171","msg":"trace[1058476914] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:6758; }","duration":"218.021203ms","start":"2026-09-07T08:48:22.78537Z","end":"2026-09-07T08:48:23.003391Z","steps":["trace[1058476914] 'range keys from in-memory index tree' (duration: 217.697034ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:48:23.003638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.056006ms","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-09-07T08:48:23.003765Z","caller":"traceutil/trace.go:171","msg":"trace[1626600055] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6758; }","duration":"197.237456ms","start":"2026-09-07T08:48:22.8065Z","end":"2026-09-07T08:48:23.003738Z","steps":["trace[1626600055] 'range keys from in-memory index tree' (duration: 196.521648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:48:23.265711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.839579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T08:48:23.265813Z","caller":"traceutil/trace.go:171","msg":"trace[894917573] linearizableReadLoop","detail":"{readStateIndex:7007; appliedIndex:7006; }","duration":"139.60182ms","start":"2026-09-07T08:48:23.126196Z","end":"2026-09-07T08:48:23.265798Z","steps":["trace[894917573] 'read index received' (duration: 18.497951ms)","trace[894917573] 'applied index is now lower than readState.Index' (duration: 121.102929ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T08:48:23.265976Z","caller":"traceutil/trace.go:171","msg":"trace[1976009785] transaction","detail":"{read_only:false; response_revision:6761; number_of_response:1; }","duration":"159.338447ms","start":"2026-09-07T08:48:23.106628Z","end":"2026-09-07T08:48:23.265966Z","steps":["trace[1976009785] 'process raft request' (duration: 38.133498ms)","trace[1976009785] 'compare' (duration: 120.551731ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T08:48:23.266253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.056009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107255"} {"level":"info","ts":"2026-09-07T08:48:23.266273Z","caller":"traceutil/trace.go:171","msg":"trace[805189515] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:6761; }","duration":"140.123518ms","start":"2026-09-07T08:48:23.126143Z","end":"2026-09-07T08:48:23.266266Z","steps":["trace[805189515] 'agreement among raft nodes before linearized reading' (duration: 139.978369ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T08:48:23.266421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.673745ms","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-09-07T08:48:23.266468Z","caller":"traceutil/trace.go:171","msg":"trace[1314522838] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6761; }","duration":"127.738905ms","start":"2026-09-07T08:48:23.138723Z","end":"2026-09-07T08:48:23.266462Z","steps":["trace[1314522838] 'agreement among raft nodes before linearized reading' (duration: 127.647775ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:48:23.751946Z","caller":"traceutil/trace.go:171","msg":"trace[1318352315] transaction","detail":"{read_only:false; response_revision:6764; number_of_response:1; }","duration":"117.730662ms","start":"2026-09-07T08:48:23.634181Z","end":"2026-09-07T08:48:23.751911Z","steps":["trace[1318352315] 'process raft request' (duration: 117.510141ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:48:57.69325Z","caller":"traceutil/trace.go:171","msg":"trace[152817354] transaction","detail":"{read_only:false; response_revision:6951; number_of_response:1; }","duration":"122.2268ms","start":"2026-09-07T08:48:57.570977Z","end":"2026-09-07T08:48:57.693204Z","steps":["trace[152817354] 'process raft request' (duration: 122.044278ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T08:50:30.789285Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5577} {"level":"info","ts":"2026-09-07T08:50:30.869866Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5577,"took":"78.898593ms","hash":2569760428,"current-db-size-bytes":53563392,"current-db-size":"54 MB","current-db-size-in-use-bytes":18636800,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-07T08:50:30.869916Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2569760428,"revision":5577,"compact-revision":2910}