{"level":"warn","ts":"2026-10-15T23:57:54.453467Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T23:57:54.453621Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.140: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.140:2380","--initial-cluster=instance=https://162.253.55.140:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.140:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.140: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-10-15T23:57:54.453736Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T23:57:54.453752Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-10-15T23:57:54.453792Z","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-10-15T23:57:54.455973Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"]} {"level":"info","ts":"2026-10-15T23:57:54.456143Z","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.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.140: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-10-15T23:57:54.463512Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.966926ms"} {"level":"info","ts":"2026-10-15T23:57:54.473782Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf809824ab95ac81","cluster-id":"6f89f5fbef18dc61"} {"level":"info","ts":"2026-10-15T23:57:54.473886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T23:57:54.473914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 0"} {"level":"info","ts":"2026-10-15T23:57:54.473934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf809824ab95ac81 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T23:57:54.473946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became follower at term 1"} {"level":"info","ts":"2026-10-15T23:57:54.473998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"warn","ts":"2026-10-15T23:57:54.485801Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T23:57:54.493372Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T23:57:54.499481Z","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-10-15T23:57:54.506423Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf809824ab95ac81","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T23:57:54.508651Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf809824ab95ac81","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T23:57:54.50883Z","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-10-15T23:57:54.508918Z","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-10-15T23:57:54.508925Z","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-10-15T23:57:54.509632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 switched to configuration voters=(14952118046135004289)"} {"level":"info","ts":"2026-10-15T23:57:54.509736Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","added-peer-id":"cf809824ab95ac81","added-peer-peer-urls":["https://162.253.55.140:2380"]} {"level":"info","ts":"2026-10-15T23:57:54.509738Z","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-10-15T23:57:54.509923Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf809824ab95ac81","initial-advertise-peer-urls":["https://162.253.55.140:2380"],"listen-peer-urls":["https://162.253.55.140:2380"],"advertise-client-urls":["https://162.253.55.140:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.140:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T23:57:54.509957Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T23:57:54.510391Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-10-15T23:57:54.510419Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.140:2380"} {"level":"info","ts":"2026-10-15T23:57:55.174867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T23:57:55.174987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T23:57:55.175028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgPreVoteResp from cf809824ab95ac81 at term 1"} {"level":"info","ts":"2026-10-15T23:57:55.17506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became candidate at term 2"} {"level":"info","ts":"2026-10-15T23:57:55.175075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 received MsgVoteResp from cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-10-15T23:57:55.175116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf809824ab95ac81 became leader at term 2"} {"level":"info","ts":"2026-10-15T23:57:55.175137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf809824ab95ac81 elected leader cf809824ab95ac81 at term 2"} {"level":"info","ts":"2026-10-15T23:57:55.176666Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T23:57:55.17753Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf809824ab95ac81","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.140:2379]}","request-path":"/0/members/cf809824ab95ac81/attributes","cluster-id":"6f89f5fbef18dc61","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T23:57:55.17785Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T23:57:55.178263Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T23:57:55.178251Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6f89f5fbef18dc61","local-member-id":"cf809824ab95ac81","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T23:57:55.178453Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T23:57:55.178472Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T23:57:55.178475Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T23:57:55.178517Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T23:57:55.180405Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.140:2379"} {"level":"info","ts":"2026-10-15T23:57:55.180764Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-15T23:57:58.066231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.344936ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-15T23:57:58.066357Z","caller":"traceutil/trace.go:171","msg":"trace[1304470731] transaction","detail":"{read_only:false; response_revision:114; number_of_response:1; }","duration":"159.059993ms","start":"2026-10-15T23:57:57.90728Z","end":"2026-10-15T23:57:58.06634Z","steps":["trace[1304470731] 'process raft request' (duration: 14.110668ms)","trace[1304470731] 'compare' (duration: 144.213924ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T23:57:58.805996Z","caller":"traceutil/trace.go:171","msg":"trace[594587721] linearizableReadLoop","detail":"{readStateIndex:121; appliedIndex:120; }","duration":"289.178217ms","start":"2026-10-15T23:57:58.516789Z","end":"2026-10-15T23:57:58.805968Z","steps":["trace[594587721] 'read index received' (duration: 288.937805ms)","trace[594587721] 'applied index is now lower than readState.Index' (duration: 239.292µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T23:57:58.806146Z","caller":"traceutil/trace.go:171","msg":"trace[6627512] transaction","detail":"{read_only:false; response_revision:117; number_of_response:1; }","duration":"669.894775ms","start":"2026-10-15T23:57:58.136212Z","end":"2026-10-15T23:57:58.806107Z","steps":["trace[6627512] 'process raft request' (duration: 669.583702ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T23:57:58.806258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.444431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-15T23:57:58.806321Z","caller":"traceutil/trace.go:171","msg":"trace[1994379706] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:117; }","duration":"289.567963ms","start":"2026-10-15T23:57:58.516732Z","end":"2026-10-15T23:57:58.8063Z","steps":["trace[1994379706] 'agreement among raft nodes before linearized reading' (duration: 289.404921ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T23:57:58.806431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T23:57:58.1362Z","time spent":"670.096559ms","remote":"127.0.0.1:43436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":767,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T23:57:59.071588Z","caller":"traceutil/trace.go:171","msg":"trace[1253191584] transaction","detail":"{read_only:false; response_revision:119; number_of_response:1; }","duration":"261.774029ms","start":"2026-10-15T23:57:58.809775Z","end":"2026-10-15T23:57:59.071549Z","steps":["trace[1253191584] 'process raft request' (duration: 261.710838ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:57:59.071639Z","caller":"traceutil/trace.go:171","msg":"trace[673131110] transaction","detail":"{read_only:false; response_revision:118; number_of_response:1; }","duration":"261.84509ms","start":"2026-10-15T23:57:58.809768Z","end":"2026-10-15T23:57:59.071613Z","steps":["trace[673131110] 'process raft request' (duration: 261.602446ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:57:59.077683Z","caller":"traceutil/trace.go:171","msg":"trace[661415889] transaction","detail":"{read_only:false; response_revision:121; number_of_response:1; }","duration":"189.673051ms","start":"2026-10-15T23:57:58.887988Z","end":"2026-10-15T23:57:59.077661Z","steps":["trace[661415889] 'process raft request' (duration: 189.61112ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:57:59.077927Z","caller":"traceutil/trace.go:171","msg":"trace[1594165530] transaction","detail":"{read_only:false; response_revision:120; number_of_response:1; }","duration":"266.223182ms","start":"2026-10-15T23:57:58.811644Z","end":"2026-10-15T23:57:59.077867Z","steps":["trace[1594165530] 'process raft request' (duration: 265.868817ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:58:45.933703Z","caller":"traceutil/trace.go:171","msg":"trace[866045039] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"121.759364ms","start":"2026-10-15T23:58:45.811911Z","end":"2026-10-15T23:58:45.93367Z","steps":["trace[866045039] 'process raft request' (duration: 121.534851ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T23:58:46.375958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.249761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-xbl5z\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-15T23:58:46.376044Z","caller":"traceutil/trace.go:171","msg":"trace[131208831] range","detail":"{range_begin:/registry/pods/kube-system/cilium-xbl5z; range_end:; response_count:1; response_revision:611; }","duration":"119.428643ms","start":"2026-10-15T23:58:46.256594Z","end":"2026-10-15T23:58:46.376022Z","steps":["trace[131208831] 'range keys from in-memory index tree' (duration: 119.12195ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:58:47.073154Z","caller":"traceutil/trace.go:171","msg":"trace[186691258] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"625.866728ms","start":"2026-10-15T23:58:46.447223Z","end":"2026-10-15T23:58:47.07309Z","steps":["trace[186691258] 'process raft request' (duration: 625.705026ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:58:47.07326Z","caller":"traceutil/trace.go:171","msg":"trace[1203142917] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"679.204296ms","start":"2026-10-15T23:58:46.393888Z","end":"2026-10-15T23:58:47.073092Z","steps":["trace[1203142917] 'process raft request' (duration: 614.741152ms)","trace[1203142917] 'compare' (duration: 63.413413ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T23:58:47.073343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T23:58:46.447198Z","time spent":"626.050129ms","remote":"127.0.0.1:43342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-15T23:58:47.073586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T23:58:46.393858Z","time spent":"679.464639ms","remote":"127.0.0.1:43286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T23:58:48.595936Z","caller":"traceutil/trace.go:171","msg":"trace[1949263107] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"142.559284ms","start":"2026-10-15T23:58:48.453349Z","end":"2026-10-15T23:58:48.595908Z","steps":["trace[1949263107] 'process raft request' (duration: 137.182467ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:58:48.602153Z","caller":"traceutil/trace.go:171","msg":"trace[151297078] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"146.837929ms","start":"2026-10-15T23:58:48.4553Z","end":"2026-10-15T23:58:48.602138Z","steps":["trace[151297078] 'process raft request' (duration: 146.803198ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:58:48.602276Z","caller":"traceutil/trace.go:171","msg":"trace[864161641] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"148.212314ms","start":"2026-10-15T23:58:48.454055Z","end":"2026-10-15T23:58:48.602267Z","steps":["trace[864161641] 'process raft request' (duration: 147.982082ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:58:59.489318Z","caller":"traceutil/trace.go:171","msg":"trace[797562063] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"113.223113ms","start":"2026-10-15T23:58:59.376069Z","end":"2026-10-15T23:58:59.489292Z","steps":["trace[797562063] 'process raft request' (duration: 31.397584ms)","trace[797562063] 'compare' (duration: 81.702627ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T23:58:59.499473Z","caller":"traceutil/trace.go:171","msg":"trace[1923549552] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"121.235542ms","start":"2026-10-15T23:58:59.378216Z","end":"2026-10-15T23:58:59.499452Z","steps":["trace[1923549552] 'process raft request' (duration: 121.173031ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:58:59.499536Z","caller":"traceutil/trace.go:171","msg":"trace[179379049] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"123.462415ms","start":"2026-10-15T23:58:59.376026Z","end":"2026-10-15T23:58:59.499488Z","steps":["trace[179379049] 'process raft request' (duration: 123.238933ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:59:02.29275Z","caller":"traceutil/trace.go:171","msg":"trace[609521292] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"201.432518ms","start":"2026-10-15T23:59:02.091293Z","end":"2026-10-15T23:59:02.292726Z","steps":["trace[609521292] 'process raft request' (duration: 201.269137ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T23:59:32.12202Z","caller":"traceutil/trace.go:171","msg":"trace[1821006965] linearizableReadLoop","detail":"{readStateIndex:1214; appliedIndex:1213; }","duration":"113.360182ms","start":"2026-10-15T23:59:32.008638Z","end":"2026-10-15T23:59:32.121998Z","steps":["trace[1821006965] 'read index received' (duration: 113.12434ms)","trace[1821006965] 'applied index is now lower than readState.Index' (duration: 234.892µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T23:59:32.122087Z","caller":"traceutil/trace.go:171","msg":"trace[1683302055] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"149.376492ms","start":"2026-10-15T23:59:31.972682Z","end":"2026-10-15T23:59:32.122059Z","steps":["trace[1683302055] 'process raft request' (duration: 149.169ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T23:59:32.122203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.556744ms","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-10-15T23:59:32.122242Z","caller":"traceutil/trace.go:171","msg":"trace[1387434668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1177; }","duration":"113.654934ms","start":"2026-10-15T23:59:32.008578Z","end":"2026-10-15T23:59:32.122233Z","steps":["trace[1387434668] 'agreement among raft nodes before linearized reading' (duration: 113.522433ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:00:22.799544Z","caller":"traceutil/trace.go:171","msg":"trace[1167292997] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"101.567504ms","start":"2026-10-16T00:00:22.697929Z","end":"2026-10-16T00:00:22.799496Z","steps":["trace[1167292997] 'process raft request' (duration: 101.082128ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:00:23.186518Z","caller":"traceutil/trace.go:171","msg":"trace[1240486807] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"378.166365ms","start":"2026-10-16T00:00:22.808317Z","end":"2026-10-16T00:00:23.186483Z","steps":["trace[1240486807] 'process raft request' (duration: 377.983357ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:00:23.18677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:00:22.8083Z","time spent":"378.31129ms","remote":"127.0.0.1:43286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:00:23.241758Z","caller":"traceutil/trace.go:171","msg":"trace[383750072] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"333.118917ms","start":"2026-10-16T00:00:22.908612Z","end":"2026-10-16T00:00:23.241731Z","steps":["trace[383750072] 'process raft request' (duration: 332.925539ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:00:23.241944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:00:22.908583Z","time spent":"333.258132ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-16T00:00:23.241988Z","caller":"traceutil/trace.go:171","msg":"trace[1015316931] linearizableReadLoop","detail":"{readStateIndex:1926; appliedIndex:1924; }","duration":"259.071791ms","start":"2026-10-16T00:00:22.982859Z","end":"2026-10-16T00:00:23.241931Z","steps":["trace[1015316931] 'read index received' (duration: 203.479447ms)","trace[1015316931] 'applied index is now lower than readState.Index' (duration: 55.577083ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:00:23.24203Z","caller":"traceutil/trace.go:171","msg":"trace[1201391724] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"175.683595ms","start":"2026-10-16T00:00:23.066323Z","end":"2026-10-16T00:00:23.242007Z","steps":["trace[1201391724] 'process raft request' (duration: 175.337721ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:00:23.242242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.174819ms","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-10-16T00:00:23.242279Z","caller":"traceutil/trace.go:171","msg":"trace[337073090] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1854; }","duration":"236.237492ms","start":"2026-10-16T00:00:23.00603Z","end":"2026-10-16T00:00:23.242267Z","steps":["trace[337073090] 'agreement among raft nodes before linearized reading' (duration: 236.110856ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:00:23.242272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.390444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-16T00:00:23.242327Z","caller":"traceutil/trace.go:171","msg":"trace[1430161356] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1854; }","duration":"259.459216ms","start":"2026-10-16T00:00:22.98285Z","end":"2026-10-16T00:00:23.24231Z","steps":["trace[1430161356] 'agreement among raft nodes before linearized reading' (duration: 259.271489ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:00:23.459502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.781612ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:00:23.459701Z","caller":"traceutil/trace.go:171","msg":"trace[130368457] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1927; }","duration":"158.269135ms","start":"2026-10-16T00:00:23.301414Z","end":"2026-10-16T00:00:23.459683Z","steps":["trace[130368457] 'read index received' (duration: 48.218974ms)","trace[130368457] 'applied index is now lower than readState.Index' (duration: 110.049331ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:00:23.459701Z","caller":"traceutil/trace.go:171","msg":"trace[908129617] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"212.470313ms","start":"2026-10-16T00:00:23.24721Z","end":"2026-10-16T00:00:23.459681Z","steps":["trace[908129617] 'process raft request' (duration: 102.414571ms)","trace[908129617] 'compare' (duration: 109.669807ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:00:23.459872Z","caller":"traceutil/trace.go:171","msg":"trace[25555909] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"212.265625ms","start":"2026-10-16T00:00:23.247588Z","end":"2026-10-16T00:00:23.459854Z","steps":["trace[25555909] 'process raft request' (duration: 212.027245ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:00:23.460106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.686492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6a3c65c8-86db-43f3-a5e8-2472674c992b\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-10-16T00:00:23.460143Z","caller":"traceutil/trace.go:171","msg":"trace[1064415639] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6a3c65c8-86db-43f3-a5e8-2472674c992b; range_end:; response_count:1; response_revision:1856; }","duration":"158.752976ms","start":"2026-10-16T00:00:23.301378Z","end":"2026-10-16T00:00:23.460131Z","steps":["trace[1064415639] 'agreement among raft nodes before linearized reading' (duration: 158.629691ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:00:23.461636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.095289ms","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-10-16T00:00:23.461773Z","caller":"traceutil/trace.go:171","msg":"trace[2108748250] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1856; }","duration":"131.205484ms","start":"2026-10-16T00:00:23.33049Z","end":"2026-10-16T00:00:23.461696Z","steps":["trace[2108748250] 'agreement among raft nodes before linearized reading' (duration: 130.047896ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:00:23.752475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.054672ms","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-10-16T00:00:23.752571Z","caller":"traceutil/trace.go:171","msg":"trace[353565569] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1857; }","duration":"110.203489ms","start":"2026-10-16T00:00:23.642347Z","end":"2026-10-16T00:00:23.752551Z","steps":["trace[353565569] 'range keys from in-memory index tree' (duration: 109.871555ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:01:02.999409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.086757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:01:02.999487Z","caller":"traceutil/trace.go:171","msg":"trace[1967352020] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2127; }","duration":"201.207721ms","start":"2026-10-16T00:01:02.798263Z","end":"2026-10-16T00:01:02.99947Z","steps":["trace[1967352020] 'count revisions from in-memory index tree' (duration: 201.008135ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:01:03.926073Z","caller":"traceutil/trace.go:171","msg":"trace[446011191] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"120.821989ms","start":"2026-10-16T00:01:03.805223Z","end":"2026-10-16T00:01:03.926045Z","steps":["trace[446011191] 'read index received' (duration: 120.687114ms)","trace[446011191] 'applied index is now lower than readState.Index' (duration: 133.725µs)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:01:03.926291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.041477ms","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-10-16T00:01:03.926339Z","caller":"traceutil/trace.go:171","msg":"trace[21442553] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2130; }","duration":"121.108149ms","start":"2026-10-16T00:01:03.805217Z","end":"2026-10-16T00:01:03.926325Z","steps":["trace[21442553] 'agreement among raft nodes before linearized reading' (duration: 120.924263ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:01:03.92668Z","caller":"traceutil/trace.go:171","msg":"trace[200807719] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"122.083161ms","start":"2026-10-16T00:01:03.804579Z","end":"2026-10-16T00:01:03.926662Z","steps":["trace[200807719] 'process raft request' (duration: 121.320446ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:01:04.394863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.878579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:01:04.394967Z","caller":"traceutil/trace.go:171","msg":"trace[718380621] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"342.399303ms","start":"2026-10-16T00:01:04.052548Z","end":"2026-10-16T00:01:04.394947Z","steps":["trace[718380621] 'process raft request' (duration: 214.350909ms)","trace[718380621] 'compare' (duration: 127.777616ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:01:04.395362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:01:04.052486Z","time spent":"342.834837ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:02:06.560419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.980589ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:02:06.5606Z","caller":"traceutil/trace.go:171","msg":"trace[951117156] transaction","detail":"{read_only:false; response_revision:2569; number_of_response:1; }","duration":"302.875452ms","start":"2026-10-16T00:02:06.2577Z","end":"2026-10-16T00:02:06.560576Z","steps":["trace[951117156] 'process raft request' (duration: 10.638087ms)","trace[951117156] 'compare' (duration: 291.758734ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:02:06.56064Z","caller":"traceutil/trace.go:171","msg":"trace[1767578757] transaction","detail":"{read_only:false; response_revision:2570; number_of_response:1; }","duration":"206.167054ms","start":"2026-10-16T00:02:06.354459Z","end":"2026-10-16T00:02:06.560626Z","steps":["trace[1767578757] 'process raft request' (duration: 206.110462ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:02:06.560637Z","caller":"traceutil/trace.go:171","msg":"trace[2103251018] linearizableReadLoop","detail":"{readStateIndex:2667; appliedIndex:2666; }","duration":"296.956409ms","start":"2026-10-16T00:02:06.263658Z","end":"2026-10-16T00:02:06.560615Z","steps":["trace[2103251018] 'read index received' (duration: 4.627622ms)","trace[2103251018] 'applied index is now lower than readState.Index' (duration: 292.326847ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:02:06.56072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:02:06.257687Z","time spent":"302.965764ms","remote":"127.0.0.1:43360","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-16T00:02:06.560848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.187475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-16T00:02:06.56088Z","caller":"traceutil/trace.go:171","msg":"trace[1760672578] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2570; }","duration":"297.264936ms","start":"2026-10-16T00:02:06.263603Z","end":"2026-10-16T00:02:06.560868Z","steps":["trace[1760672578] 'agreement among raft nodes before linearized reading' (duration: 297.105373ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:02:06.560883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.58385ms","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-10-16T00:02:06.560907Z","caller":"traceutil/trace.go:171","msg":"trace[631633493] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2570; }","duration":"260.667592ms","start":"2026-10-16T00:02:06.300232Z","end":"2026-10-16T00:02:06.5609Z","steps":["trace[631633493] 'agreement among raft nodes before linearized reading' (duration: 260.57671ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:02:43.68889Z","caller":"traceutil/trace.go:171","msg":"trace[1996916652] transaction","detail":"{read_only:false; response_revision:2777; number_of_response:1; }","duration":"127.377463ms","start":"2026-10-16T00:02:43.561489Z","end":"2026-10-16T00:02:43.688866Z","steps":["trace[1996916652] 'process raft request' (duration: 127.2465ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:03.099552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.543352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:03.099698Z","caller":"traceutil/trace.go:171","msg":"trace[453797011] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:0; response_revision:4320; }","duration":"105.731915ms","start":"2026-10-16T00:07:02.993935Z","end":"2026-10-16T00:07:03.099667Z","steps":["trace[453797011] 'range keys from in-memory index tree' (duration: 105.37575ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:13.278038Z","caller":"traceutil/trace.go:171","msg":"trace[1291307021] linearizableReadLoop","detail":"{readStateIndex:4986; appliedIndex:4984; }","duration":"104.431759ms","start":"2026-10-16T00:07:13.173578Z","end":"2026-10-16T00:07:13.27801Z","steps":["trace[1291307021] 'read index received' (duration: 43.587185ms)","trace[1291307021] 'applied index is now lower than readState.Index' (duration: 60.842784ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:13.278128Z","caller":"traceutil/trace.go:171","msg":"trace[1747596500] transaction","detail":"{read_only:false; response_revision:4801; number_of_response:1; }","duration":"135.280942ms","start":"2026-10-16T00:07:13.142815Z","end":"2026-10-16T00:07:13.278095Z","steps":["trace[1747596500] 'process raft request' (duration: 134.427661ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:13.278572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.945555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-16T00:07:13.278662Z","caller":"traceutil/trace.go:171","msg":"trace[1768294194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4801; }","duration":"105.141707ms","start":"2026-10-16T00:07:13.173507Z","end":"2026-10-16T00:07:13.278648Z","steps":["trace[1768294194] 'agreement among raft nodes before linearized reading' (duration: 104.812313ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:13.310245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.447798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-10-16T00:07:13.310318Z","caller":"traceutil/trace.go:171","msg":"trace[2100157925] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4802; }","duration":"133.56826ms","start":"2026-10-16T00:07:13.176731Z","end":"2026-10-16T00:07:13.3103Z","steps":["trace[2100157925] 'agreement among raft nodes before linearized reading' (duration: 133.112255ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:17.252577Z","caller":"traceutil/trace.go:171","msg":"trace[1357302356] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"142.394811ms","start":"2026-10-16T00:07:17.110091Z","end":"2026-10-16T00:07:17.252486Z","steps":["trace[1357302356] 'process raft request' (duration: 43.160908ms)","trace[1357302356] 'compare' (duration: 99.063251ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:17.287912Z","caller":"traceutil/trace.go:171","msg":"trace[980079538] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4881; }","duration":"176.697354ms","start":"2026-10-16T00:07:17.111177Z","end":"2026-10-16T00:07:17.287875Z","steps":["trace[980079538] 'process raft request' (duration: 176.444451ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:17.28794Z","caller":"traceutil/trace.go:171","msg":"trace[879991496] linearizableReadLoop","detail":"{readStateIndex:5071; appliedIndex:5068; }","duration":"172.601755ms","start":"2026-10-16T00:07:17.11531Z","end":"2026-10-16T00:07:17.287912Z","steps":["trace[879991496] 'read index received' (duration: 37.982266ms)","trace[879991496] 'applied index is now lower than readState.Index' (duration: 134.618199ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:17.288425Z","caller":"traceutil/trace.go:171","msg":"trace[2038944423] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"177.089339ms","start":"2026-10-16T00:07:17.111323Z","end":"2026-10-16T00:07:17.288413Z","steps":["trace[2038944423] 'process raft request' (duration: 176.443341ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:17.288604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.175012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:07:17.288641Z","caller":"traceutil/trace.go:171","msg":"trace[157670138] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:4882; }","duration":"173.353174ms","start":"2026-10-16T00:07:17.115279Z","end":"2026-10-16T00:07:17.288632Z","steps":["trace[157670138] 'agreement among raft nodes before linearized reading' (duration: 173.133611ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:17.341034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.736342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-10-16T00:07:17.34112Z","caller":"traceutil/trace.go:171","msg":"trace[1589854903] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4883; }","duration":"160.884083ms","start":"2026-10-16T00:07:17.180213Z","end":"2026-10-16T00:07:17.341097Z","steps":["trace[1589854903] 'agreement among raft nodes before linearized reading' (duration: 160.670031ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:17.341086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.794534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-10-16T00:07:17.341214Z","caller":"traceutil/trace.go:171","msg":"trace[661523336] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4883; }","duration":"220.956766ms","start":"2026-10-16T00:07:17.120243Z","end":"2026-10-16T00:07:17.341199Z","steps":["trace[661523336] 'agreement among raft nodes before linearized reading' (duration: 220.679532ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:17.439364Z","caller":"traceutil/trace.go:171","msg":"trace[2041594086] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"138.468365ms","start":"2026-10-16T00:07:17.300878Z","end":"2026-10-16T00:07:17.439346Z","steps":["trace[2041594086] 'process raft request' (duration: 138.396424ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:17.440008Z","caller":"traceutil/trace.go:171","msg":"trace[909975039] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"142.944788ms","start":"2026-10-16T00:07:17.297037Z","end":"2026-10-16T00:07:17.439982Z","steps":["trace[909975039] 'process raft request' (duration: 142.070908ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:17.439763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.590373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-16T00:07:17.440235Z","caller":"traceutil/trace.go:171","msg":"trace[1249724219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4885; }","duration":"113.08653ms","start":"2026-10-16T00:07:17.327132Z","end":"2026-10-16T00:07:17.440218Z","steps":["trace[1249724219] 'agreement among raft nodes before linearized reading' (duration: 112.497183ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:17.441289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.605105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-10-16T00:07:17.441381Z","caller":"traceutil/trace.go:171","msg":"trace[2138808697] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4885; }","duration":"148.733997ms","start":"2026-10-16T00:07:17.29263Z","end":"2026-10-16T00:07:17.441364Z","steps":["trace[2138808697] 'agreement among raft nodes before linearized reading' (duration: 146.852095ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:17.455883Z","caller":"traceutil/trace.go:171","msg":"trace[1482589174] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4886; }","duration":"112.707834ms","start":"2026-10-16T00:07:17.343156Z","end":"2026-10-16T00:07:17.455864Z","steps":["trace[1482589174] 'process raft request' (duration: 112.087736ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:17.45605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.380273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"warn","ts":"2026-10-16T00:07:17.455819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.866349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-10-16T00:07:17.457086Z","caller":"traceutil/trace.go:171","msg":"trace[116775267] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4887; }","duration":"109.992473ms","start":"2026-10-16T00:07:17.34692Z","end":"2026-10-16T00:07:17.456913Z","steps":["trace[116775267] 'agreement among raft nodes before linearized reading' (duration: 108.769388ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:17.460831Z","caller":"traceutil/trace.go:171","msg":"trace[1809758046] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4887; }","duration":"118.16099ms","start":"2026-10-16T00:07:17.342631Z","end":"2026-10-16T00:07:17.460792Z","steps":["trace[1809758046] 'agreement among raft nodes before linearized reading' (duration: 113.20129ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:18.930568Z","caller":"traceutil/trace.go:171","msg":"trace[1186139569] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"174.454215ms","start":"2026-10-16T00:07:18.756084Z","end":"2026-10-16T00:07:18.930538Z","steps":["trace[1186139569] 'process raft request' (duration: 167.528573ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:24.284428Z","caller":"traceutil/trace.go:171","msg":"trace[133147442] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"233.458062ms","start":"2026-10-16T00:07:24.050939Z","end":"2026-10-16T00:07:24.284397Z","steps":["trace[133147442] 'process raft request' (duration: 233.392211ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:24.284735Z","caller":"traceutil/trace.go:171","msg":"trace[558584460] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"265.970331ms","start":"2026-10-16T00:07:24.018696Z","end":"2026-10-16T00:07:24.284667Z","steps":["trace[558584460] 'process raft request' (duration: 265.322253ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:24.284877Z","caller":"traceutil/trace.go:171","msg":"trace[124622598] linearizableReadLoop","detail":"{readStateIndex:5196; appliedIndex:5196; }","duration":"212.207008ms","start":"2026-10-16T00:07:24.072589Z","end":"2026-10-16T00:07:24.284796Z","steps":["trace[124622598] 'read index received' (duration: 212.189727ms)","trace[124622598] 'applied index is now lower than readState.Index' (duration: 14.651µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:24.284789Z","caller":"traceutil/trace.go:171","msg":"trace[362245222] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"259.923948ms","start":"2026-10-16T00:07:24.02485Z","end":"2026-10-16T00:07:24.284774Z","steps":["trace[362245222] 'process raft request' (duration: 259.406352ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:24.285289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.222224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-4dfea358-c061-455e-8eac-70a6a798542f\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-10-16T00:07:24.285359Z","caller":"traceutil/trace.go:171","msg":"trace[1588805938] range","detail":"{range_begin:/registry/persistentvolumes/pvc-4dfea358-c061-455e-8eac-70a6a798542f; range_end:; response_count:1; response_revision:5005; }","duration":"210.345565ms","start":"2026-10-16T00:07:24.074998Z","end":"2026-10-16T00:07:24.285343Z","steps":["trace[1588805938] 'agreement among raft nodes before linearized reading' (duration: 210.071222ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:24.285717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.45039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-16T00:07:24.285782Z","caller":"traceutil/trace.go:171","msg":"trace[488514658] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5005; }","duration":"181.555092ms","start":"2026-10-16T00:07:24.104209Z","end":"2026-10-16T00:07:24.285764Z","steps":["trace[488514658] 'agreement among raft nodes before linearized reading' (duration: 181.225628ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:24.286225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.02022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-10-16T00:07:24.28632Z","caller":"traceutil/trace.go:171","msg":"trace[407319369] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5005; }","duration":"230.177822ms","start":"2026-10-16T00:07:24.056125Z","end":"2026-10-16T00:07:24.286303Z","steps":["trace[407319369] 'agreement among raft nodes before linearized reading' (duration: 228.946928ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:24.529273Z","caller":"traceutil/trace.go:171","msg":"trace[1100437738] linearizableReadLoop","detail":"{readStateIndex:5200; appliedIndex:5196; }","duration":"194.664709ms","start":"2026-10-16T00:07:24.33458Z","end":"2026-10-16T00:07:24.529245Z","steps":["trace[1100437738] 'read index received' (duration: 126.561594ms)","trace[1100437738] 'applied index is now lower than readState.Index' (duration: 68.101565ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:24.529443Z","caller":"traceutil/trace.go:171","msg":"trace[2079353913] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"231.805373ms","start":"2026-10-16T00:07:24.297624Z","end":"2026-10-16T00:07:24.52943Z","steps":["trace[2079353913] 'process raft request' (duration: 231.427368ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:24.529527Z","caller":"traceutil/trace.go:171","msg":"trace[1031215940] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"232.831154ms","start":"2026-10-16T00:07:24.296645Z","end":"2026-10-16T00:07:24.529476Z","steps":["trace[1031215940] 'process raft request' (duration: 164.334335ms)","trace[1031215940] 'compare' (duration: 67.918962ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:24.529611Z","caller":"traceutil/trace.go:171","msg":"trace[996404598] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"231.689701ms","start":"2026-10-16T00:07:24.29791Z","end":"2026-10-16T00:07:24.5296Z","steps":["trace[996404598] 'process raft request' (duration: 231.214456ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:24.529693Z","caller":"traceutil/trace.go:171","msg":"trace[764496426] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"231.489148ms","start":"2026-10-16T00:07:24.298195Z","end":"2026-10-16T00:07:24.529684Z","steps":["trace[764496426] 'process raft request' (duration: 230.977303ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:24.530109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.499698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-10-16T00:07:24.530174Z","caller":"traceutil/trace.go:171","msg":"trace[1902046142] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5009; }","duration":"195.619279ms","start":"2026-10-16T00:07:24.334515Z","end":"2026-10-16T00:07:24.530135Z","steps":["trace[1902046142] 'agreement among raft nodes before linearized reading' (duration: 195.479468ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:24.929425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.493722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:07:24.929649Z","caller":"traceutil/trace.go:171","msg":"trace[1783310078] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"132.17632ms","start":"2026-10-16T00:07:24.797434Z","end":"2026-10-16T00:07:24.92961Z","steps":["trace[1783310078] 'process raft request' (duration: 31.387235ms)","trace[1783310078] 'compare' (duration: 100.232878ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:07:38.554809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.10853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-16T00:07:38.554894Z","caller":"traceutil/trace.go:171","msg":"trace[1129905686] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5184; }","duration":"292.233212ms","start":"2026-10-16T00:07:38.262639Z","end":"2026-10-16T00:07:38.554872Z","steps":["trace[1129905686] 'range keys from in-memory index tree' (duration: 291.928968ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:38.555041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.159491ms","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-10-16T00:07:38.555109Z","caller":"traceutil/trace.go:171","msg":"trace[1395376117] linearizableReadLoop","detail":"{readStateIndex:5381; appliedIndex:5380; }","duration":"109.912412ms","start":"2026-10-16T00:07:38.44518Z","end":"2026-10-16T00:07:38.555093Z","steps":["trace[1395376117] 'read index received' (duration: 86.607646ms)","trace[1395376117] 'applied index is now lower than readState.Index' (duration: 23.303706ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:07:38.555094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.652558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10395"} {"level":"info","ts":"2026-10-16T00:07:38.555183Z","caller":"traceutil/trace.go:171","msg":"trace[304825160] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5184; }","duration":"358.804329ms","start":"2026-10-16T00:07:38.196359Z","end":"2026-10-16T00:07:38.555163Z","steps":["trace[304825160] 'range keys from in-memory index tree' (duration: 358.387645ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:38.555223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.044323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-16T00:07:38.555231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-16T00:07:38.196342Z","time spent":"358.879949ms","remote":"127.0.0.1:43286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10418,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-10-16T00:07:38.555251Z","caller":"traceutil/trace.go:171","msg":"trace[2042247577] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:5185; }","duration":"110.080554ms","start":"2026-10-16T00:07:38.445161Z","end":"2026-10-16T00:07:38.555241Z","steps":["trace[2042247577] 'agreement among raft nodes before linearized reading' (duration: 109.995993ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.55535Z","caller":"traceutil/trace.go:171","msg":"trace[802237382] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"217.528076ms","start":"2026-10-16T00:07:38.33777Z","end":"2026-10-16T00:07:38.555298Z","steps":["trace[802237382] 'process raft request' (duration: 194.012148ms)","trace[802237382] 'compare' (duration: 23.012723ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:38.555329Z","caller":"traceutil/trace.go:171","msg":"trace[1882410444] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5184; }","duration":"292.289662ms","start":"2026-10-16T00:07:38.26284Z","end":"2026-10-16T00:07:38.55513Z","steps":["trace[1882410444] 'range keys from in-memory index tree' (duration: 291.846157ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.805123Z","caller":"traceutil/trace.go:171","msg":"trace[2146775742] linearizableReadLoop","detail":"{readStateIndex:5382; appliedIndex:5382; }","duration":"235.56755ms","start":"2026-10-16T00:07:38.569531Z","end":"2026-10-16T00:07:38.805098Z","steps":["trace[2146775742] 'read index received' (duration: 235.55843ms)","trace[2146775742] 'applied index is now lower than readState.Index' (duration: 7.65µs)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:38.805122Z","caller":"traceutil/trace.go:171","msg":"trace[1217498332] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"236.539641ms","start":"2026-10-16T00:07:38.568562Z","end":"2026-10-16T00:07:38.805102Z","steps":["trace[1217498332] 'process raft request' (duration: 236.323229ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:38.80541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.852764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-10-16T00:07:38.805478Z","caller":"traceutil/trace.go:171","msg":"trace[33022906] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:5186; }","duration":"235.956395ms","start":"2026-10-16T00:07:38.569507Z","end":"2026-10-16T00:07:38.805464Z","steps":["trace[33022906] 'agreement among raft nodes before linearized reading' (duration: 235.721392ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.912457Z","caller":"traceutil/trace.go:171","msg":"trace[1493205231] linearizableReadLoop","detail":"{readStateIndex:5384; appliedIndex:5382; }","duration":"107.21423ms","start":"2026-10-16T00:07:38.805201Z","end":"2026-10-16T00:07:38.912415Z","steps":["trace[1493205231] 'read index received' (duration: 86.94826ms)","trace[1493205231] 'applied index is now lower than readState.Index' (duration: 20.26406ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:38.912641Z","caller":"traceutil/trace.go:171","msg":"trace[808598026] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"130.808039ms","start":"2026-10-16T00:07:38.781801Z","end":"2026-10-16T00:07:38.912609Z","steps":["trace[808598026] 'process raft request' (duration: 110.319646ms)","trace[808598026] 'compare' (duration: 20.034918ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:07:38.912683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.69062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:38.912737Z","caller":"traceutil/trace.go:171","msg":"trace[1038061926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5188; }","duration":"196.785032ms","start":"2026-10-16T00:07:38.715936Z","end":"2026-10-16T00:07:38.912721Z","steps":["trace[1038061926] 'agreement among raft nodes before linearized reading' (duration: 196.68425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:38.912734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.159104ms","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-10-16T00:07:38.912803Z","caller":"traceutil/trace.go:171","msg":"trace[1583133155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5188; }","duration":"126.276335ms","start":"2026-10-16T00:07:38.786511Z","end":"2026-10-16T00:07:38.912787Z","steps":["trace[1583133155] 'agreement among raft nodes before linearized reading' (duration: 126.056403ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.912798Z","caller":"traceutil/trace.go:171","msg":"trace[1253030260] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"109.130303ms","start":"2026-10-16T00:07:38.80354Z","end":"2026-10-16T00:07:38.912671Z","steps":["trace[1253030260] 'process raft request' (duration: 108.765609ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:38.913068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.415784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-10-16T00:07:38.913143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.001535ms","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-10-16T00:07:38.913229Z","caller":"traceutil/trace.go:171","msg":"trace[1644981035] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5188; }","duration":"219.123496ms","start":"2026-10-16T00:07:38.694086Z","end":"2026-10-16T00:07:38.91321Z","steps":["trace[1644981035] 'agreement among raft nodes before linearized reading' (duration: 218.901213ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.91324Z","caller":"traceutil/trace.go:171","msg":"trace[1676383063] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5188; }","duration":"124.89661ms","start":"2026-10-16T00:07:38.788292Z","end":"2026-10-16T00:07:38.913188Z","steps":["trace[1676383063] 'agreement among raft nodes before linearized reading' (duration: 124.173842ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.934919Z","caller":"traceutil/trace.go:171","msg":"trace[348178867] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"119.550936ms","start":"2026-10-16T00:07:38.815351Z","end":"2026-10-16T00:07:38.934902Z","steps":["trace[348178867] 'process raft request' (duration: 119.392214ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.93523Z","caller":"traceutil/trace.go:171","msg":"trace[1220513356] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"119.722498ms","start":"2026-10-16T00:07:38.815486Z","end":"2026-10-16T00:07:38.935208Z","steps":["trace[1220513356] 'process raft request' (duration: 119.380914ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.935819Z","caller":"traceutil/trace.go:171","msg":"trace[776403572] transaction","detail":"{read_only:false; response_revision:5191; number_of_response:1; }","duration":"120.086783ms","start":"2026-10-16T00:07:38.81572Z","end":"2026-10-16T00:07:38.935806Z","steps":["trace[776403572] 'process raft request' (duration: 119.423405ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:38.936076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.159861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:38.938095Z","caller":"traceutil/trace.go:171","msg":"trace[1316156892] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:5192; }","duration":"110.179756ms","start":"2026-10-16T00:07:38.827894Z","end":"2026-10-16T00:07:38.938074Z","steps":["trace[1316156892] 'agreement among raft nodes before linearized reading' (duration: 108.115791ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.936214Z","caller":"traceutil/trace.go:171","msg":"trace[827251329] transaction","detail":"{read_only:false; response_revision:5192; number_of_response:1; }","duration":"120.421686ms","start":"2026-10-16T00:07:38.815781Z","end":"2026-10-16T00:07:38.936203Z","steps":["trace[827251329] 'process raft request' (duration: 119.799869ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:38.93644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.781341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1453"} {"level":"warn","ts":"2026-10-16T00:07:38.936565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.036204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18ded9dcae2fe11c\" ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-10-16T00:07:38.938424Z","caller":"traceutil/trace.go:171","msg":"trace[1919303922] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18ded9dcae2fe11c; range_end:; response_count:1; response_revision:5192; }","duration":"122.920156ms","start":"2026-10-16T00:07:38.815476Z","end":"2026-10-16T00:07:38.938397Z","steps":["trace[1919303922] 'agreement among raft nodes before linearized reading' (duration: 120.999662ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:38.938695Z","caller":"traceutil/trace.go:171","msg":"trace[756914257] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5192; }","duration":"123.074457ms","start":"2026-10-16T00:07:38.815609Z","end":"2026-10-16T00:07:38.938683Z","steps":["trace[756914257] 'agreement among raft nodes before linearized reading' (duration: 120.72865ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:39.495084Z","caller":"traceutil/trace.go:171","msg":"trace[1520050173] linearizableReadLoop","detail":"{readStateIndex:5399; appliedIndex:5397; }","duration":"161.455462ms","start":"2026-10-16T00:07:39.3336Z","end":"2026-10-16T00:07:39.495055Z","steps":["trace[1520050173] 'read index received' (duration: 20.501024ms)","trace[1520050173] 'applied index is now lower than readState.Index' (duration: 140.953318ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:39.4952Z","caller":"traceutil/trace.go:171","msg":"trace[736179332] transaction","detail":"{read_only:false; response_revision:5203; number_of_response:1; }","duration":"200.872009ms","start":"2026-10-16T00:07:39.29429Z","end":"2026-10-16T00:07:39.495162Z","steps":["trace[736179332] 'process raft request' (duration: 128.676444ms)","trace[736179332] 'compare' (duration: 71.872361ms)"],"step_count":2} {"level":"warn","ts":"2026-10-16T00:07:39.495453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.605594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-16T00:07:39.495503Z","caller":"traceutil/trace.go:171","msg":"trace[1652876705] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:5203; }","duration":"161.945108ms","start":"2026-10-16T00:07:39.333544Z","end":"2026-10-16T00:07:39.495489Z","steps":["trace[1652876705] 'agreement among raft nodes before linearized reading' (duration: 161.608904ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:39.860695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.584773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.140\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-16T00:07:39.860857Z","caller":"traceutil/trace.go:171","msg":"trace[777381644] range","detail":"{range_begin:/registry/masterleases/162.253.55.140; range_end:; response_count:1; response_revision:5203; }","duration":"210.817836ms","start":"2026-10-16T00:07:39.650017Z","end":"2026-10-16T00:07:39.860835Z","steps":["trace[777381644] 'range keys from in-memory index tree' (duration: 210.282379ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:39.860718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.548175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-10-16T00:07:39.861064Z","caller":"traceutil/trace.go:171","msg":"trace[179178391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5203; }","duration":"206.947419ms","start":"2026-10-16T00:07:39.654094Z","end":"2026-10-16T00:07:39.861041Z","steps":["trace[179178391] 'range keys from in-memory index tree' (duration: 206.335842ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:40.114788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.815923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-16T00:07:40.115055Z","caller":"traceutil/trace.go:171","msg":"trace[755804465] linearizableReadLoop","detail":"{readStateIndex:5402; appliedIndex:5400; }","duration":"233.991999ms","start":"2026-10-16T00:07:39.881046Z","end":"2026-10-16T00:07:40.115038Z","steps":["trace[755804465] 'read index received' (duration: 83.853692ms)","trace[755804465] 'applied index is now lower than readState.Index' (duration: 150.137307ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:40.115106Z","caller":"traceutil/trace.go:171","msg":"trace[1505986351] transaction","detail":"{read_only:false; response_revision:5204; number_of_response:1; }","duration":"248.934486ms","start":"2026-10-16T00:07:39.866123Z","end":"2026-10-16T00:07:40.115058Z","steps":["trace[1505986351] 'process raft request' (duration: 98.760529ms)","trace[1505986351] 'compare' (duration: 148.967773ms)"],"step_count":2} {"level":"info","ts":"2026-10-16T00:07:40.115096Z","caller":"traceutil/trace.go:171","msg":"trace[1451239142] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"234.398034ms","start":"2026-10-16T00:07:39.880672Z","end":"2026-10-16T00:07:40.11507Z","steps":["trace[1451239142] 'process raft request' (duration: 234.296673ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:40.115379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.285072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11324"} {"level":"info","ts":"2026-10-16T00:07:40.115458Z","caller":"traceutil/trace.go:171","msg":"trace[860562816] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5205; }","duration":"234.425094ms","start":"2026-10-16T00:07:39.881013Z","end":"2026-10-16T00:07:40.115438Z","steps":["trace[860562816] 'agreement among raft nodes before linearized reading' (duration: 234.08579ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:40.158231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.211485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-16T00:07:40.158314Z","caller":"traceutil/trace.go:171","msg":"trace[109345388] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5206; }","duration":"241.329446ms","start":"2026-10-16T00:07:39.916965Z","end":"2026-10-16T00:07:40.158294Z","steps":["trace[109345388] 'agreement among raft nodes before linearized reading' (duration: 241.201974ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:40.158202Z","caller":"traceutil/trace.go:171","msg":"trace[1708271438] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"174.828458ms","start":"2026-10-16T00:07:39.983338Z","end":"2026-10-16T00:07:40.158167Z","steps":["trace[1708271438] 'process raft request' (duration: 174.595885ms)"],"step_count":1} {"level":"warn","ts":"2026-10-16T00:07:40.332172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.204303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17231"} {"level":"info","ts":"2026-10-16T00:07:40.33226Z","caller":"traceutil/trace.go:171","msg":"trace[482400626] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5206; }","duration":"104.341905ms","start":"2026-10-16T00:07:40.2279Z","end":"2026-10-16T00:07:40.332242Z","steps":["trace[482400626] 'range keys from in-memory index tree' (duration: 103.96224ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:07:55.207527Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2838} {"level":"info","ts":"2026-10-16T00:07:55.288648Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2838,"took":"79.4382ms","hash":288304744,"current-db-size-bytes":52195328,"current-db-size":"52 MB","current-db-size-in-use-bytes":27471872,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-16T00:07:55.288716Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":288304744,"revision":2838,"compact-revision":-1} {"level":"warn","ts":"2026-10-16T00:08:26.392192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.628637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-10-16T00:08:26.39228Z","caller":"traceutil/trace.go:171","msg":"trace[1202685152] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5578; }","duration":"130.759138ms","start":"2026-10-16T00:08:26.261502Z","end":"2026-10-16T00:08:26.392261Z","steps":["trace[1202685152] 'range keys from in-memory index tree' (duration: 129.379202ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:08:26.865541Z","caller":"traceutil/trace.go:171","msg":"trace[1631254650] transaction","detail":"{read_only:false; response_revision:5581; number_of_response:1; }","duration":"218.41121ms","start":"2026-10-16T00:08:26.647101Z","end":"2026-10-16T00:08:26.865513Z","steps":["trace[1631254650] 'process raft request' (duration: 218.193927ms)"],"step_count":1} {"level":"info","ts":"2026-10-16T00:12:55.216394Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5302} {"level":"info","ts":"2026-10-16T00:12:55.304669Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5302,"took":"85.760432ms","hash":2430383230,"current-db-size-bytes":52195328,"current-db-size":"52 MB","current-db-size-in-use-bytes":18608128,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-16T00:12:55.304888Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2430383230,"revision":5302,"compact-revision":2838}