{"level":"warn","ts":"2026-09-01T04:13:45.015608Z","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-01T04:13:45.015706Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.79: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.79:2380","--initial-cluster=instance=https://162.253.55.79:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.79:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.79: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-01T04:13:45.015789Z","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-01T04:13:45.015798Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-01T04:13:45.015833Z","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-01T04:13:45.016428Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"]} {"level":"info","ts":"2026-09-01T04:13:45.016522Z","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.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.79: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-01T04:13:45.022037Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.291646ms"} {"level":"info","ts":"2026-09-01T04:13:45.031418Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"401ca643156fc5da","cluster-id":"e9f568c3681bb0d0"} {"level":"info","ts":"2026-09-01T04:13:45.032339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=()"} {"level":"info","ts":"2026-09-01T04:13:45.032386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 0"} {"level":"info","ts":"2026-09-01T04:13:45.032399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 401ca643156fc5da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-01T04:13:45.032422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 1"} {"level":"info","ts":"2026-09-01T04:13:45.03249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"warn","ts":"2026-09-01T04:13:45.039406Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-01T04:13:45.040637Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-01T04:13:45.041774Z","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-01T04:13:45.044051Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"401ca643156fc5da","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-01T04:13:45.044232Z","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-01T04:13:45.044894Z","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-01T04:13:45.044927Z","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-01T04:13:45.044954Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"401ca643156fc5da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-01T04:13:45.046202Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"info","ts":"2026-09-01T04:13:45.046347Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","added-peer-id":"401ca643156fc5da","added-peer-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-01T04:13:45.048543Z","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-01T04:13:45.048773Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-01T04:13:45.04888Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-01T04:13:45.04891Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-01T04:13:45.048847Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"401ca643156fc5da","initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-01T04:13:45.933024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da is starting a new election at term 1"} {"level":"info","ts":"2026-09-01T04:13:45.933087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became pre-candidate at term 1"} {"level":"info","ts":"2026-09-01T04:13:45.933125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgPreVoteResp from 401ca643156fc5da at term 1"} {"level":"info","ts":"2026-09-01T04:13:45.933141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became candidate at term 2"} {"level":"info","ts":"2026-09-01T04:13:45.93315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgVoteResp from 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-01T04:13:45.93316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became leader at term 2"} {"level":"info","ts":"2026-09-01T04:13:45.933171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 401ca643156fc5da elected leader 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-01T04:13:45.934009Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"401ca643156fc5da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.79:2379]}","request-path":"/0/members/401ca643156fc5da/attributes","cluster-id":"e9f568c3681bb0d0","publish-timeout":"7s"} {"level":"info","ts":"2026-09-01T04:13:45.933994Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:13:45.93401Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:13:45.93409Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-01T04:13:45.934207Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-01T04:13:45.934255Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-01T04:13:45.935791Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:13:45.936572Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:13:45.936645Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-01T04:13:45.93829Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.79:2379"} {"level":"info","ts":"2026-09-01T04:13:45.938965Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-01T04:13:54.790064Z","caller":"traceutil/trace.go:171","msg":"trace[663897938] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"169.384449ms","start":"2026-09-01T04:13:54.620659Z","end":"2026-09-01T04:13:54.790044Z","steps":["trace[663897938] 'process raft request' (duration: 143.770589ms)","trace[663897938] 'compare' (duration: 25.523098ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:13:54.804916Z","caller":"traceutil/trace.go:171","msg":"trace[521330183] linearizableReadLoop","detail":"{readStateIndex:364; appliedIndex:362; }","duration":"140.831907ms","start":"2026-09-01T04:13:54.664071Z","end":"2026-09-01T04:13:54.804903Z","steps":["trace[521330183] 'read index received' (duration: 100.36135ms)","trace[521330183] 'applied index is now lower than readState.Index' (duration: 40.470027ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:13:54.805066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.967221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-01T04:13:54.805103Z","caller":"traceutil/trace.go:171","msg":"trace[1410321296] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:354; }","duration":"141.089893ms","start":"2026-09-01T04:13:54.664005Z","end":"2026-09-01T04:13:54.805095Z","steps":["trace[1410321296] 'agreement among raft nodes before linearized reading' (duration: 140.97115ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:54.805052Z","caller":"traceutil/trace.go:171","msg":"trace[567933857] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"180.908063ms","start":"2026-09-01T04:13:54.624087Z","end":"2026-09-01T04:13:54.804995Z","steps":["trace[567933857] 'process raft request' (duration: 180.735349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.181341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.770667ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:13:55.181702Z","caller":"traceutil/trace.go:171","msg":"trace[717367985] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"387.438002ms","start":"2026-09-01T04:13:54.794238Z","end":"2026-09-01T04:13:55.181676Z","steps":["trace[717367985] 'process raft request' (duration: 168.753893ms)","trace[717367985] 'compare' (duration: 217.606533ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:13:55.181857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.860177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-09-01T04:13:55.181897Z","caller":"traceutil/trace.go:171","msg":"trace[882671166] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:355; }","duration":"414.946939ms","start":"2026-09-01T04:13:54.766936Z","end":"2026-09-01T04:13:55.181883Z","steps":["trace[882671166] 'agreement among raft nodes before linearized reading' (duration: 414.815406ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.181871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.794203Z","time spent":"387.555785ms","remote":"127.0.0.1:55764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-01T04:13:55.181914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.766912Z","time spent":"414.998311ms","remote":"127.0.0.1:55764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "} {"level":"info","ts":"2026-09-01T04:13:55.181992Z","caller":"traceutil/trace.go:171","msg":"trace[166446261] linearizableReadLoop","detail":"{readStateIndex:365; appliedIndex:364; }","duration":"376.745559ms","start":"2026-09-01T04:13:54.804954Z","end":"2026-09-01T04:13:55.1817Z","steps":["trace[166446261] 'read index received' (duration: 158.05005ms)","trace[166446261] 'applied index is now lower than readState.Index' (duration: 218.693439ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:13:55.18201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.813991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-09-01T04:13:55.182226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.016141ms","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-01T04:13:55.182253Z","caller":"traceutil/trace.go:171","msg":"trace[678853248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:355; }","duration":"478.046372ms","start":"2026-09-01T04:13:54.704201Z","end":"2026-09-01T04:13:55.182247Z","steps":["trace[678853248] 'agreement among raft nodes before linearized reading' (duration: 477.997031ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.182257Z","caller":"traceutil/trace.go:171","msg":"trace[1911123916] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:355; }","duration":"468.100288ms","start":"2026-09-01T04:13:54.714144Z","end":"2026-09-01T04:13:55.182245Z","steps":["trace[1911123916] 'agreement among raft nodes before linearized reading' (duration: 467.836482ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.182274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.704119Z","time spent":"478.151285ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-01T04:13:55.182291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.714116Z","time spent":"468.16306ms","remote":"127.0.0.1:55764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-09-01T04:13:55.274489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.331144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-09-01T04:13:55.274515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.723961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:13:55.274574Z","caller":"traceutil/trace.go:171","msg":"trace[508169780] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"461.508013ms","start":"2026-09-01T04:13:54.813043Z","end":"2026-09-01T04:13:55.274551Z","steps":["trace[508169780] 'process raft request' (duration: 461.187285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.274599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.442811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-09-01T04:13:55.274607Z","caller":"traceutil/trace.go:171","msg":"trace[31049952] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:356; }","duration":"390.892585ms","start":"2026-09-01T04:13:54.8837Z","end":"2026-09-01T04:13:55.274593Z","steps":["trace[31049952] 'agreement among raft nodes before linearized reading' (duration: 390.68502ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.274621Z","caller":"traceutil/trace.go:171","msg":"trace[1509467634] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:356; }","duration":"461.513524ms","start":"2026-09-01T04:13:54.813101Z","end":"2026-09-01T04:13:55.274615Z","steps":["trace[1509467634] 'agreement among raft nodes before linearized reading' (duration: 461.475713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.274643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.883672Z","time spent":"390.962697ms","remote":"127.0.0.1:55548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-01T04:13:55.274651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.813071Z","time spent":"461.572604ms","remote":"127.0.0.1:55764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-09-01T04:13:55.274688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.813008Z","time spent":"461.621426ms","remote":"127.0.0.1:56044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-01T04:13:55.274557Z","caller":"traceutil/trace.go:171","msg":"trace[1033003465] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:356; }","duration":"410.414956ms","start":"2026-09-01T04:13:54.864126Z","end":"2026-09-01T04:13:55.274541Z","steps":["trace[1033003465] 'agreement among raft nodes before linearized reading' (duration: 410.269212ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.274901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.864063Z","time spent":"410.825365ms","remote":"127.0.0.1:55764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-09-01T04:13:55.275118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.462762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-01T04:13:55.275249Z","caller":"traceutil/trace.go:171","msg":"trace[1636281724] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:356; }","duration":"359.652447ms","start":"2026-09-01T04:13:54.915576Z","end":"2026-09-01T04:13:55.275229Z","steps":["trace[1636281724] 'agreement among raft nodes before linearized reading' (duration: 359.246987ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.27533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:13:54.915559Z","time spent":"359.75648ms","remote":"127.0.0.1:55764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-09-01T04:13:55.438508Z","caller":"traceutil/trace.go:171","msg":"trace[203411700] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:366; }","duration":"164.120369ms","start":"2026-09-01T04:13:55.274358Z","end":"2026-09-01T04:13:55.438479Z","steps":["trace[203411700] 'read index received' (duration: 162.044218ms)","trace[203411700] 'applied index is now lower than readState.Index' (duration: 2.074951ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:13:55.438645Z","caller":"traceutil/trace.go:171","msg":"trace[1862083469] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"249.007116ms","start":"2026-09-01T04:13:55.189605Z","end":"2026-09-01T04:13:55.438612Z","steps":["trace[1862083469] 'process raft request' (duration: 248.819092ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.438774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.329917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:7294"} {"level":"warn","ts":"2026-09-01T04:13:55.438772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.961216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-01T04:13:55.43885Z","caller":"traceutil/trace.go:171","msg":"trace[292918369] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:359; }","duration":"232.446861ms","start":"2026-09-01T04:13:55.20639Z","end":"2026-09-01T04:13:55.438837Z","steps":["trace[292918369] 'agreement among raft nodes before linearized reading' (duration: 232.261806ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.43866Z","caller":"traceutil/trace.go:171","msg":"trace[1533526784] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"249.617101ms","start":"2026-09-01T04:13:55.188923Z","end":"2026-09-01T04:13:55.43854Z","steps":["trace[1533526784] 'process raft request' (duration: 249.441307ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.438889Z","caller":"traceutil/trace.go:171","msg":"trace[574969840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:359; }","duration":"171.15274ms","start":"2026-09-01T04:13:55.267716Z","end":"2026-09-01T04:13:55.438869Z","steps":["trace[574969840] 'agreement among raft nodes before linearized reading' (duration: 170.921985ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.439612Z","caller":"traceutil/trace.go:171","msg":"trace[1253212777] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"252.454681ms","start":"2026-09-01T04:13:55.186313Z","end":"2026-09-01T04:13:55.438768Z","steps":["trace[1253212777] 'process raft request' (duration: 250.190435ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.440293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.248312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-01T04:13:55.440348Z","caller":"traceutil/trace.go:171","msg":"trace[1532899675] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:364; }","duration":"162.355775ms","start":"2026-09-01T04:13:55.277979Z","end":"2026-09-01T04:13:55.440335Z","steps":["trace[1532899675] 'agreement among raft nodes before linearized reading' (duration: 162.225332ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.44055Z","caller":"traceutil/trace.go:171","msg":"trace[1195512490] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"159.046114ms","start":"2026-09-01T04:13:55.281478Z","end":"2026-09-01T04:13:55.440524Z","steps":["trace[1195512490] 'process raft request' (duration: 158.553362ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.440669Z","caller":"traceutil/trace.go:171","msg":"trace[272920171] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"157.20515ms","start":"2026-09-01T04:13:55.283458Z","end":"2026-09-01T04:13:55.440663Z","steps":["trace[272920171] 'process raft request' (duration: 156.688676ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.440783Z","caller":"traceutil/trace.go:171","msg":"trace[1044475374] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"157.405165ms","start":"2026-09-01T04:13:55.283373Z","end":"2026-09-01T04:13:55.440778Z","steps":["trace[1044475374] 'process raft request' (duration: 156.740968ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.440373Z","caller":"traceutil/trace.go:171","msg":"trace[170383434] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"156.988264ms","start":"2026-09-01T04:13:55.283374Z","end":"2026-09-01T04:13:55.440362Z","steps":["trace[170383434] 'process raft request' (duration: 156.706917ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:13:55.440835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.250727ms","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-01T04:13:55.440982Z","caller":"traceutil/trace.go:171","msg":"trace[719817842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:364; }","duration":"134.437621ms","start":"2026-09-01T04:13:55.306533Z","end":"2026-09-01T04:13:55.440971Z","steps":["trace[719817842] 'agreement among raft nodes before linearized reading' (duration: 134.222416ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:13:55.440394Z","caller":"traceutil/trace.go:171","msg":"trace[1168975325] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"159.35579ms","start":"2026-09-01T04:13:55.281034Z","end":"2026-09-01T04:13:55.44039Z","steps":["trace[1168975325] 'process raft request' (duration: 158.905729ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:27.521872Z","caller":"traceutil/trace.go:171","msg":"trace[1922278037] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"100.710579ms","start":"2026-09-01T04:14:27.421142Z","end":"2026-09-01T04:14:27.521852Z","steps":["trace[1922278037] 'process raft request' (duration: 100.456593ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:27.522002Z","caller":"traceutil/trace.go:171","msg":"trace[60988341] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"100.836322ms","start":"2026-09-01T04:14:27.421149Z","end":"2026-09-01T04:14:27.521985Z","steps":["trace[60988341] 'process raft request' (duration: 100.585186ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:27.825609Z","caller":"traceutil/trace.go:171","msg":"trace[1230729534] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"138.978202ms","start":"2026-09-01T04:14:27.686613Z","end":"2026-09-01T04:14:27.825591Z","steps":["trace[1230729534] 'process raft request' (duration: 134.69383ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:27.826397Z","caller":"traceutil/trace.go:171","msg":"trace[1422296541] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"127.738162ms","start":"2026-09-01T04:14:27.698615Z","end":"2026-09-01T04:14:27.826353Z","steps":["trace[1422296541] 'process raft request' (duration: 126.940415ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:27.826292Z","caller":"traceutil/trace.go:171","msg":"trace[30421643] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"127.476947ms","start":"2026-09-01T04:14:27.698657Z","end":"2026-09-01T04:14:27.826134Z","steps":["trace[30421643] 'process raft request' (duration: 127.081729ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:27.82936Z","caller":"traceutil/trace.go:171","msg":"trace[1827188601] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"111.862766ms","start":"2026-09-01T04:14:27.717473Z","end":"2026-09-01T04:14:27.829336Z","steps":["trace[1827188601] 'process raft request' (duration: 109.473585ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:28.585394Z","caller":"traceutil/trace.go:171","msg":"trace[634754518] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"114.82599ms","start":"2026-09-01T04:14:28.470536Z","end":"2026-09-01T04:14:28.585362Z","steps":["trace[634754518] 'process raft request' (duration: 114.649186ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:34.073854Z","caller":"traceutil/trace.go:171","msg":"trace[902780787] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"121.327526ms","start":"2026-09-01T04:14:33.952502Z","end":"2026-09-01T04:14:34.07383Z","steps":["trace[902780787] 'process raft request' (duration: 120.803716ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:14:34.336408Z","caller":"traceutil/trace.go:171","msg":"trace[1638688689] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"204.16243ms","start":"2026-09-01T04:14:34.132199Z","end":"2026-09-01T04:14:34.336362Z","steps":["trace[1638688689] 'process raft request' (duration: 203.999656ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:15:21.098637Z","caller":"traceutil/trace.go:171","msg":"trace[182344964] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"105.89716ms","start":"2026-09-01T04:15:20.992714Z","end":"2026-09-01T04:15:21.098611Z","steps":["trace[182344964] 'process raft request' (duration: 104.722757ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:08.409791Z","caller":"traceutil/trace.go:171","msg":"trace[1584850186] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"287.966008ms","start":"2026-09-01T04:16:08.121807Z","end":"2026-09-01T04:16:08.409773Z","steps":["trace[1584850186] 'process raft request' (duration: 287.816425ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:08.410141Z","caller":"traceutil/trace.go:171","msg":"trace[273728261] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1952; }","duration":"247.112464ms","start":"2026-09-01T04:16:08.163016Z","end":"2026-09-01T04:16:08.410129Z","steps":["trace[273728261] 'read index received' (duration: 247.105564ms)","trace[273728261] 'applied index is now lower than readState.Index' (duration: 5.45µs)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:16:08.410307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.103596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-09-01T04:16:08.410306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.278896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-01T04:16:08.410363Z","caller":"traceutil/trace.go:171","msg":"trace[127804284] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1883; }","duration":"247.378488ms","start":"2026-09-01T04:16:08.162977Z","end":"2026-09-01T04:16:08.410355Z","steps":["trace[127804284] 'agreement among raft nodes before linearized reading' (duration: 247.230765ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:08.410381Z","caller":"traceutil/trace.go:171","msg":"trace[36213121] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1883; }","duration":"246.170237ms","start":"2026-09-01T04:16:08.164181Z","end":"2026-09-01T04:16:08.410352Z","steps":["trace[36213121] 'agreement among raft nodes before linearized reading' (duration: 246.041804ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:16:08.905085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.578671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.79\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-01T04:16:08.90515Z","caller":"traceutil/trace.go:171","msg":"trace[732625216] range","detail":"{range_begin:/registry/masterleases/162.253.55.79; range_end:; response_count:1; response_revision:1886; }","duration":"217.682082ms","start":"2026-09-01T04:16:08.687453Z","end":"2026-09-01T04:16:08.905135Z","steps":["trace[732625216] 'range keys from in-memory index tree' (duration: 217.431949ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:08.905143Z","caller":"traceutil/trace.go:171","msg":"trace[2047638005] transaction","detail":"{read_only:false; response_revision:1887; number_of_response:1; }","duration":"186.24752ms","start":"2026-09-01T04:16:08.718867Z","end":"2026-09-01T04:16:08.905115Z","steps":["trace[2047638005] 'process raft request' (duration: 170.170652ms)","trace[2047638005] 'compare' (duration: 15.59364ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:16:08.905132Z","caller":"traceutil/trace.go:171","msg":"trace[1708895042] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1955; }","duration":"174.994235ms","start":"2026-09-01T04:16:08.730111Z","end":"2026-09-01T04:16:08.905106Z","steps":["trace[1708895042] 'read index received' (duration: 158.984869ms)","trace[1708895042] 'applied index is now lower than readState.Index' (duration: 16.008286ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:16:08.905561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.437972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dfbcbeb9-cde1-41e7-b133-c6f69ad7e5a4\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-01T04:16:08.905603Z","caller":"traceutil/trace.go:171","msg":"trace[1631858617] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dfbcbeb9-cde1-41e7-b133-c6f69ad7e5a4; range_end:; response_count:1; response_revision:1887; }","duration":"175.533784ms","start":"2026-09-01T04:16:08.730059Z","end":"2026-09-01T04:16:08.905592Z","steps":["trace[1631858617] 'agreement among raft nodes before linearized reading' (duration: 175.371841ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:21.871378Z","caller":"traceutil/trace.go:171","msg":"trace[1690333608] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"152.853084ms","start":"2026-09-01T04:16:21.718499Z","end":"2026-09-01T04:16:21.871352Z","steps":["trace[1690333608] 'process raft request' (duration: 152.700772ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:43.770645Z","caller":"traceutil/trace.go:171","msg":"trace[814277201] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"104.262057ms","start":"2026-09-01T04:16:43.666347Z","end":"2026-09-01T04:16:43.77061Z","steps":["trace[814277201] 'process raft request' (duration: 59.745487ms)","trace[814277201] 'compare' (duration: 44.339778ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:16:44.106036Z","caller":"traceutil/trace.go:171","msg":"trace[58743534] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"174.021623ms","start":"2026-09-01T04:16:43.931995Z","end":"2026-09-01T04:16:44.106016Z","steps":["trace[58743534] 'process raft request' (duration: 173.887351ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:44.123793Z","caller":"traceutil/trace.go:171","msg":"trace[1345189229] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"152.406468ms","start":"2026-09-01T04:16:43.971367Z","end":"2026-09-01T04:16:44.123773Z","steps":["trace[1345189229] 'process raft request' (duration: 152.369158ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:44.124052Z","caller":"traceutil/trace.go:171","msg":"trace[1724092450] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"163.280531ms","start":"2026-09-01T04:16:43.960745Z","end":"2026-09-01T04:16:44.124025Z","steps":["trace[1724092450] 'process raft request' (duration: 162.891015ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:44.831508Z","caller":"traceutil/trace.go:171","msg":"trace[1508790834] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"127.690572ms","start":"2026-09-01T04:16:44.703791Z","end":"2026-09-01T04:16:44.831482Z","steps":["trace[1508790834] 'process raft request' (duration: 103.918391ms)","trace[1508790834] 'compare' (duration: 23.461546ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:16:45.029886Z","caller":"traceutil/trace.go:171","msg":"trace[1473595356] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"235.956217ms","start":"2026-09-01T04:16:44.793868Z","end":"2026-09-01T04:16:45.029824Z","steps":["trace[1473595356] 'process raft request' (duration: 235.831925ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:45.029935Z","caller":"traceutil/trace.go:171","msg":"trace[1907498160] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"325.836111ms","start":"2026-09-01T04:16:44.704065Z","end":"2026-09-01T04:16:45.029901Z","steps":["trace[1907498160] 'process raft request' (duration: 277.516026ms)","trace[1907498160] 'compare' (duration: 47.785965ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:16:45.030169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.38832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-01T04:16:45.030238Z","caller":"traceutil/trace.go:171","msg":"trace[1800412449] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2145; }","duration":"253.490962ms","start":"2026-09-01T04:16:44.776728Z","end":"2026-09-01T04:16:45.030219Z","steps":["trace[1800412449] 'agreement among raft nodes before linearized reading' (duration: 253.31959ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:16:45.030325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:16:44.704053Z","time spent":"325.954454ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-01T04:16:45.030392Z","caller":"traceutil/trace.go:171","msg":"trace[1789012398] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"323.97025ms","start":"2026-09-01T04:16:44.70583Z","end":"2026-09-01T04:16:45.0298Z","steps":["trace[1789012398] 'process raft request' (duration: 323.794177ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:16:45.029816Z","caller":"traceutil/trace.go:171","msg":"trace[972490051] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2218; }","duration":"253.016174ms","start":"2026-09-01T04:16:44.776762Z","end":"2026-09-01T04:16:45.029778Z","steps":["trace[972490051] 'read index received' (duration: 30.959051ms)","trace[972490051] 'applied index is now lower than readState.Index' (duration: 222.055493ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:16:45.030703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:16:44.705812Z","time spent":"324.719983ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:16:45.030746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.938629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:16:45.030943Z","caller":"traceutil/trace.go:171","msg":"trace[1303952188] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2145; }","duration":"146.174633ms","start":"2026-09-01T04:16:44.88471Z","end":"2026-09-01T04:16:45.030885Z","steps":["trace[1303952188] 'agreement among raft nodes before linearized reading' (duration: 145.907279ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:17:57.197089Z","caller":"traceutil/trace.go:171","msg":"trace[1584584058] transaction","detail":"{read_only:false; response_revision:2632; number_of_response:1; }","duration":"160.671751ms","start":"2026-09-01T04:17:57.036395Z","end":"2026-09-01T04:17:57.197067Z","steps":["trace[1584584058] 'process raft request' (duration: 160.562747ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:27.527515Z","caller":"traceutil/trace.go:171","msg":"trace[676169928] linearizableReadLoop","detail":"{readStateIndex:2899; appliedIndex:2898; }","duration":"175.777446ms","start":"2026-09-01T04:18:27.351708Z","end":"2026-09-01T04:18:27.527485Z","steps":["trace[676169928] 'read index received' (duration: 175.60742ms)","trace[676169928] 'applied index is now lower than readState.Index' (duration: 168.716µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:18:27.527619Z","caller":"traceutil/trace.go:171","msg":"trace[1411657305] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"178.587454ms","start":"2026-09-01T04:18:27.349004Z","end":"2026-09-01T04:18:27.527592Z","steps":["trace[1411657305] 'process raft request' (duration: 178.069377ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:27.527752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.017925ms","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-01T04:18:27.527813Z","caller":"traceutil/trace.go:171","msg":"trace[1059037660] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2799; }","duration":"176.101747ms","start":"2026-09-01T04:18:27.351692Z","end":"2026-09-01T04:18:27.527794Z","steps":["trace[1059037660] 'agreement among raft nodes before linearized reading' (duration: 175.919601ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:18:27.530964Z","caller":"traceutil/trace.go:171","msg":"trace[1433093424] transaction","detail":"{read_only:false; response_revision:2800; number_of_response:1; }","duration":"117.958485ms","start":"2026-09-01T04:18:27.412987Z","end":"2026-09-01T04:18:27.530945Z","steps":["trace[1433093424] 'process raft request' (duration: 117.847311ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:18:33.083908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.792893ms","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-01T04:18:33.083979Z","caller":"traceutil/trace.go:171","msg":"trace[2011447946] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2830; }","duration":"174.933207ms","start":"2026-09-01T04:18:32.90903Z","end":"2026-09-01T04:18:33.083963Z","steps":["trace[2011447946] 'range keys from in-memory index tree' (duration: 174.619148ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:27.218288Z","caller":"traceutil/trace.go:171","msg":"trace[621071350] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"164.870088ms","start":"2026-09-01T04:22:27.053401Z","end":"2026-09-01T04:22:27.218271Z","steps":["trace[621071350] 'process raft request' (duration: 164.46747ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:29.568715Z","caller":"traceutil/trace.go:171","msg":"trace[252948821] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"193.124968ms","start":"2026-09-01T04:22:29.375569Z","end":"2026-09-01T04:22:29.568694Z","steps":["trace[252948821] 'process raft request' (duration: 174.223581ms)","trace[252948821] 'compare' (duration: 18.413797ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:22:35.450002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.920594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:22:35.450267Z","caller":"traceutil/trace.go:171","msg":"trace[244571077] linearizableReadLoop","detail":"{readStateIndex:5056; appliedIndex:5053; }","duration":"466.287186ms","start":"2026-09-01T04:22:34.983961Z","end":"2026-09-01T04:22:35.450248Z","steps":["trace[244571077] 'read index received' (duration: 206.021804ms)","trace[244571077] 'applied index is now lower than readState.Index' (duration: 260.264472ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:35.450452Z","caller":"traceutil/trace.go:171","msg":"trace[149919419] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"466.507071ms","start":"2026-09-01T04:22:34.983922Z","end":"2026-09-01T04:22:35.450429Z","steps":["trace[149919419] 'process raft request' (duration: 466.288306ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:35.450571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:34.983918Z","time spent":"466.597743ms","remote":"127.0.0.1:55836","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-01T04:22:35.45068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.423187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a6ee8153-9e56-48f5-8f70-2bc9741d4850\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-01T04:22:35.450752Z","caller":"traceutil/trace.go:171","msg":"trace[80133234] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"470.392672ms","start":"2026-09-01T04:22:34.98031Z","end":"2026-09-01T04:22:35.450702Z","steps":["trace[80133234] 'process raft request' (duration: 209.653711ms)","trace[80133234] 'compare' (duration: 259.748081ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:35.450788Z","caller":"traceutil/trace.go:171","msg":"trace[462185414] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"466.851428ms","start":"2026-09-01T04:22:34.98386Z","end":"2026-09-01T04:22:35.450711Z","steps":["trace[462185414] 'process raft request' (duration: 466.245765ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:35.450858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:34.9803Z","time spent":"470.502085ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-01T04:22:35.450884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:34.983841Z","time spent":"466.997451ms","remote":"127.0.0.1:55836","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-09-01T04:22:35.450927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.95617ms","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-09-01T04:22:35.450799Z","caller":"traceutil/trace.go:171","msg":"trace[1142379070] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a6ee8153-9e56-48f5-8f70-2bc9741d4850; range_end:; response_count:1; response_revision:4872; }","duration":"272.581501ms","start":"2026-09-01T04:22:35.178178Z","end":"2026-09-01T04:22:35.45076Z","steps":["trace[1142379070] 'agreement among raft nodes before linearized reading' (duration: 272.321975ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:35.450968Z","caller":"traceutil/trace.go:171","msg":"trace[353562592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4872; }","duration":"467.014252ms","start":"2026-09-01T04:22:34.983942Z","end":"2026-09-01T04:22:35.450956Z","steps":["trace[353562592] 'agreement among raft nodes before linearized reading' (duration: 466.889629ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:35.451007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-01T04:22:34.983935Z","time spent":"467.061123ms","remote":"127.0.0.1:55836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-01T04:22:35.451249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.127265ms","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-01T04:22:35.451292Z","caller":"traceutil/trace.go:171","msg":"trace[2003138893] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4872; }","duration":"155.209596ms","start":"2026-09-01T04:22:35.296069Z","end":"2026-09-01T04:22:35.451279Z","steps":["trace[2003138893] 'agreement among raft nodes before linearized reading' (duration: 155.028233ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:35.994576Z","caller":"traceutil/trace.go:171","msg":"trace[2137233006] linearizableReadLoop","detail":"{readStateIndex:5064; appliedIndex:5063; }","duration":"272.209463ms","start":"2026-09-01T04:22:35.722346Z","end":"2026-09-01T04:22:35.994555Z","steps":["trace[2137233006] 'read index received' (duration: 215.360591ms)","trace[2137233006] 'applied index is now lower than readState.Index' (duration: 56.847942ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:35.994608Z","caller":"traceutil/trace.go:171","msg":"trace[1082412561] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"272.551849ms","start":"2026-09-01T04:22:35.722012Z","end":"2026-09-01T04:22:35.994564Z","steps":["trace[1082412561] 'process raft request' (duration: 215.775028ms)","trace[1082412561] 'compare' (duration: 56.414324ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:22:35.994799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.203125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:22:35.994839Z","caller":"traceutil/trace.go:171","msg":"trace[1858689118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4880; }","duration":"112.287527ms","start":"2026-09-01T04:22:35.882537Z","end":"2026-09-01T04:22:35.994825Z","steps":["trace[1858689118] 'agreement among raft nodes before linearized reading' (duration: 112.153284ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:35.994891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.53324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9984"} {"level":"info","ts":"2026-09-01T04:22:35.994941Z","caller":"traceutil/trace.go:171","msg":"trace[1135413881] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4880; }","duration":"272.596491ms","start":"2026-09-01T04:22:35.722329Z","end":"2026-09-01T04:22:35.994925Z","steps":["trace[1135413881] 'agreement among raft nodes before linearized reading' (duration: 272.297404ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.265583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.915603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:128417"} {"level":"warn","ts":"2026-09-01T04:22:47.265775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.679418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-09-01T04:22:47.265876Z","caller":"traceutil/trace.go:171","msg":"trace[1074726304] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:5022; }","duration":"124.857412ms","start":"2026-09-01T04:22:47.140991Z","end":"2026-09-01T04:22:47.265848Z","steps":["trace[1074726304] 'range keys from in-memory index tree' (duration: 124.545006ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.26596Z","caller":"traceutil/trace.go:171","msg":"trace[1494694651] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5022; }","duration":"124.061506ms","start":"2026-09-01T04:22:47.14162Z","end":"2026-09-01T04:22:47.265682Z","steps":["trace[1494694651] 'range keys from in-memory index tree' (duration: 123.628476ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.713024Z","caller":"traceutil/trace.go:171","msg":"trace[1709301225] linearizableReadLoop","detail":"{readStateIndex:5212; appliedIndex:5211; }","duration":"215.908419ms","start":"2026-09-01T04:22:47.497097Z","end":"2026-09-01T04:22:47.713006Z","steps":["trace[1709301225] 'read index received' (duration: 215.785837ms)","trace[1709301225] 'applied index is now lower than readState.Index' (duration: 121.832µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:47.71314Z","caller":"traceutil/trace.go:171","msg":"trace[438425458] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"235.11374ms","start":"2026-09-01T04:22:47.478011Z","end":"2026-09-01T04:22:47.713125Z","steps":["trace[438425458] 'process raft request' (duration: 234.873955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.713328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.253076ms","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-01T04:22:47.713369Z","caller":"traceutil/trace.go:171","msg":"trace[599204354] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5023; }","duration":"216.345248ms","start":"2026-09-01T04:22:47.497013Z","end":"2026-09-01T04:22:47.713358Z","steps":["trace[599204354] 'agreement among raft nodes before linearized reading' (duration: 216.105263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.734633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.642393ms","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-01T04:22:47.734688Z","caller":"traceutil/trace.go:171","msg":"trace[1223628339] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5025; }","duration":"202.789926ms","start":"2026-09-01T04:22:47.531886Z","end":"2026-09-01T04:22:47.734676Z","steps":["trace[1223628339] 'agreement among raft nodes before linearized reading' (duration: 202.652503ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.73482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.649383ms","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-09-01T04:22:47.734844Z","caller":"traceutil/trace.go:171","msg":"trace[145365629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5025; }","duration":"141.710533ms","start":"2026-09-01T04:22:47.593127Z","end":"2026-09-01T04:22:47.734838Z","steps":["trace[145365629] 'agreement among raft nodes before linearized reading' (duration: 141.648272ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.734821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.347575ms","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-01T04:22:47.734968Z","caller":"traceutil/trace.go:171","msg":"trace[1892489154] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5025; }","duration":"140.663072ms","start":"2026-09-01T04:22:47.594284Z","end":"2026-09-01T04:22:47.734947Z","steps":["trace[1892489154] 'agreement among raft nodes before linearized reading' (duration: 140.266083ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.735035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.52769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-09-01T04:22:47.735116Z","caller":"traceutil/trace.go:171","msg":"trace[1454684512] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5025; }","duration":"202.673534ms","start":"2026-09-01T04:22:47.532418Z","end":"2026-09-01T04:22:47.735092Z","steps":["trace[1454684512] 'agreement among raft nodes before linearized reading' (duration: 202.49076ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.73516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.548639ms","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-09-01T04:22:47.735199Z","caller":"traceutil/trace.go:171","msg":"trace[1471284119] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5025; }","duration":"200.611461ms","start":"2026-09-01T04:22:47.534576Z","end":"2026-09-01T04:22:47.735187Z","steps":["trace[1471284119] 'agreement among raft nodes before linearized reading' (duration: 200.517179ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.856773Z","caller":"traceutil/trace.go:171","msg":"trace[1864262730] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"139.959937ms","start":"2026-09-01T04:22:47.716778Z","end":"2026-09-01T04:22:47.856738Z","steps":["trace[1864262730] 'process raft request' (duration: 69.777344ms)","trace[1864262730] 'compare' (duration: 69.986739ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:47.856843Z","caller":"traceutil/trace.go:171","msg":"trace[502430323] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"138.387184ms","start":"2026-09-01T04:22:47.718426Z","end":"2026-09-01T04:22:47.856814Z","steps":["trace[502430323] 'process raft request' (duration: 138.227621ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.856859Z","caller":"traceutil/trace.go:171","msg":"trace[1683410824] linearizableReadLoop","detail":"{readStateIndex:5219; appliedIndex:5214; }","duration":"117.636561ms","start":"2026-09-01T04:22:47.739207Z","end":"2026-09-01T04:22:47.856844Z","steps":["trace[1683410824] 'read index received' (duration: 47.390007ms)","trace[1683410824] 'applied index is now lower than readState.Index' (duration: 70.245804ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:47.85713Z","caller":"traceutil/trace.go:171","msg":"trace[2079608515] transaction","detail":"{read_only:false; response_revision:5030; number_of_response:1; }","duration":"137.398524ms","start":"2026-09-01T04:22:47.71972Z","end":"2026-09-01T04:22:47.857118Z","steps":["trace[2079608515] 'process raft request' (duration: 137.074917ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.857136Z","caller":"traceutil/trace.go:171","msg":"trace[4759094] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"138.62366ms","start":"2026-09-01T04:22:47.718493Z","end":"2026-09-01T04:22:47.857116Z","steps":["trace[4759094] 'process raft request' (duration: 138.219201ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.857162Z","caller":"traceutil/trace.go:171","msg":"trace[1439846536] transaction","detail":"{read_only:false; response_revision:5029; number_of_response:1; }","duration":"137.860903ms","start":"2026-09-01T04:22:47.71925Z","end":"2026-09-01T04:22:47.857111Z","steps":["trace[1439846536] 'process raft request' (duration: 137.502155ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.857436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.212593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-a6ee8153-9e56-48f5-8f70-2bc9741d4850\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-09-01T04:22:47.857478Z","caller":"traceutil/trace.go:171","msg":"trace[186712937] range","detail":"{range_begin:/registry/persistentvolumes/pvc-a6ee8153-9e56-48f5-8f70-2bc9741d4850; range_end:; response_count:1; response_revision:5030; }","duration":"118.298595ms","start":"2026-09-01T04:22:47.739169Z","end":"2026-09-01T04:22:47.857468Z","steps":["trace[186712937] 'agreement among raft nodes before linearized reading' (duration: 118.133761ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.903177Z","caller":"traceutil/trace.go:171","msg":"trace[1020583966] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"162.542967ms","start":"2026-09-01T04:22:47.740617Z","end":"2026-09-01T04:22:47.90316Z","steps":["trace[1020583966] 'process raft request' (duration: 162.520146ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.903449Z","caller":"traceutil/trace.go:171","msg":"trace[1288527821] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"164.046518ms","start":"2026-09-01T04:22:47.739396Z","end":"2026-09-01T04:22:47.903443Z","steps":["trace[1288527821] 'process raft request' (duration: 163.581358ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.903513Z","caller":"traceutil/trace.go:171","msg":"trace[682914235] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"164.117119ms","start":"2026-09-01T04:22:47.739391Z","end":"2026-09-01T04:22:47.903509Z","steps":["trace[682914235] 'process raft request' (duration: 163.70451ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:47.903584Z","caller":"traceutil/trace.go:171","msg":"trace[1775071875] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"163.800092ms","start":"2026-09-01T04:22:47.73978Z","end":"2026-09-01T04:22:47.90358Z","steps":["trace[1775071875] 'process raft request' (duration: 163.340663ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.903798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.296343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:1 size:1267"} {"level":"info","ts":"2026-09-01T04:22:47.903826Z","caller":"traceutil/trace.go:171","msg":"trace[1132226543] range","detail":"{range_begin:/registry/ingress/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:1; response_revision:5034; }","duration":"164.351664ms","start":"2026-09-01T04:22:47.739469Z","end":"2026-09-01T04:22:47.90382Z","steps":["trace[1132226543] 'agreement among raft nodes before linearized reading' (duration: 164.251012ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.903865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.629789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:1459"} {"level":"info","ts":"2026-09-01T04:22:47.903934Z","caller":"traceutil/trace.go:171","msg":"trace[1918351278] range","detail":"{range_begin:/registry/ingress/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5034; }","duration":"163.758192ms","start":"2026-09-01T04:22:47.740155Z","end":"2026-09-01T04:22:47.903913Z","steps":["trace[1918351278] 'agreement among raft nodes before linearized reading' (duration: 163.562368ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:47.903944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.412656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1475"} {"level":"info","ts":"2026-09-01T04:22:47.90423Z","caller":"traceutil/trace.go:171","msg":"trace[1399097292] range","detail":"{range_begin:/registry/ingress/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5034; }","duration":"164.727893ms","start":"2026-09-01T04:22:47.739495Z","end":"2026-09-01T04:22:47.904223Z","steps":["trace[1399097292] 'agreement among raft nodes before linearized reading' (duration: 164.409605ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:48.055605Z","caller":"traceutil/trace.go:171","msg":"trace[1700320580] linearizableReadLoop","detail":"{readStateIndex:5226; appliedIndex:5224; }","duration":"133.279737ms","start":"2026-09-01T04:22:47.922297Z","end":"2026-09-01T04:22:48.055576Z","steps":["trace[1700320580] 'read index received' (duration: 89.023995ms)","trace[1700320580] 'applied index is now lower than readState.Index' (duration: 44.254822ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:48.055623Z","caller":"traceutil/trace.go:171","msg":"trace[1376224435] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"148.174417ms","start":"2026-09-01T04:22:47.907419Z","end":"2026-09-01T04:22:48.055594Z","steps":["trace[1376224435] 'process raft request' (duration: 103.847624ms)","trace[1376224435] 'compare' (duration: 44.076047ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:48.055899Z","caller":"traceutil/trace.go:171","msg":"trace[585168029] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"147.303199ms","start":"2026-09-01T04:22:47.90857Z","end":"2026-09-01T04:22:48.055874Z","steps":["trace[585168029] 'process raft request' (duration: 146.956302ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:48.056164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.842948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana.18d117a8492f3623\" ","response":"range_response_count:1 size:736"} {"level":"info","ts":"2026-09-01T04:22:48.056257Z","caller":"traceutil/trace.go:171","msg":"trace[1617022110] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana.18d117a8492f3623; range_end:; response_count:1; response_revision:5037; }","duration":"133.978492ms","start":"2026-09-01T04:22:47.922264Z","end":"2026-09-01T04:22:48.056242Z","steps":["trace[1617022110] 'agreement among raft nodes before linearized reading' (duration: 133.672115ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:59.634816Z","caller":"traceutil/trace.go:171","msg":"trace[76126214] transaction","detail":"{read_only:false; response_revision:5127; number_of_response:1; }","duration":"112.172882ms","start":"2026-09-01T04:22:59.522617Z","end":"2026-09-01T04:22:59.63479Z","steps":["trace[76126214] 'process raft request' (duration: 47.796729ms)","trace[76126214] 'compare' (duration: 64.22473ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:59.637511Z","caller":"traceutil/trace.go:171","msg":"trace[1922672067] linearizableReadLoop","detail":"{readStateIndex:5322; appliedIndex:5318; }","duration":"102.933231ms","start":"2026-09-01T04:22:59.534564Z","end":"2026-09-01T04:22:59.637498Z","steps":["trace[1922672067] 'read index received' (duration: 35.856782ms)","trace[1922672067] 'applied index is now lower than readState.Index' (duration: 67.075769ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:22:59.637598Z","caller":"traceutil/trace.go:171","msg":"trace[1547032128] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"114.678614ms","start":"2026-09-01T04:22:59.522907Z","end":"2026-09-01T04:22:59.637585Z","steps":["trace[1547032128] 'process raft request' (duration: 114.45837ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:59.637764Z","caller":"traceutil/trace.go:171","msg":"trace[2106759175] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"110.691601ms","start":"2026-09-01T04:22:59.527049Z","end":"2026-09-01T04:22:59.637741Z","steps":["trace[2106759175] 'process raft request' (duration: 110.412466ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:22:59.637943Z","caller":"traceutil/trace.go:171","msg":"trace[622348823] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"114.615653ms","start":"2026-09-01T04:22:59.52292Z","end":"2026-09-01T04:22:59.637535Z","steps":["trace[622348823] 'process raft request' (duration: 114.512821ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:22:59.638054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.483442ms","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-09-01T04:22:59.638178Z","caller":"traceutil/trace.go:171","msg":"trace[178780002] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5130; }","duration":"103.659456ms","start":"2026-09-01T04:22:59.534504Z","end":"2026-09-01T04:22:59.638163Z","steps":["trace[178780002] 'agreement among raft nodes before linearized reading' (duration: 103.049983ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:23:45.963943Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2901} {"level":"info","ts":"2026-09-01T04:23:46.071275Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2901,"took":"106.249916ms","hash":2370593924,"current-db-size-bytes":54034432,"current-db-size":"54 MB","current-db-size-in-use-bytes":29151232,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-01T04:23:46.071325Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2370593924,"revision":2901,"compact-revision":-1} {"level":"info","ts":"2026-09-01T04:26:24.087098Z","caller":"traceutil/trace.go:171","msg":"trace[1913517609] transaction","detail":"{read_only:false; response_revision:6620; number_of_response:1; }","duration":"118.121847ms","start":"2026-09-01T04:26:23.968933Z","end":"2026-09-01T04:26:24.087055Z","steps":["trace[1913517609] 'process raft request' (duration: 117.808094ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:26:24.910053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.385421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-db-sync-hstjh\" ","response":"range_response_count:1 size:6465"} {"level":"info","ts":"2026-09-01T04:26:24.910105Z","caller":"traceutil/trace.go:171","msg":"trace[669863623] range","detail":"{range_begin:/registry/pods/openstack/horizon-db-sync-hstjh; range_end:; response_count:1; response_revision:6625; }","duration":"196.474686ms","start":"2026-09-01T04:26:24.713619Z","end":"2026-09-01T04:26:24.910094Z","steps":["trace[669863623] 'range keys from in-memory index tree' (duration: 196.226556ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:48.3587Z","caller":"traceutil/trace.go:171","msg":"trace[932257973] linearizableReadLoop","detail":"{readStateIndex:7054; appliedIndex:7053; }","duration":"127.236657ms","start":"2026-09-01T04:26:48.231444Z","end":"2026-09-01T04:26:48.35868Z","steps":["trace[932257973] 'read index received' (duration: 127.068061ms)","trace[932257973] 'applied index is now lower than readState.Index' (duration: 168.076µs)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:26:48.359327Z","caller":"traceutil/trace.go:171","msg":"trace[129167957] transaction","detail":"{read_only:false; response_revision:6805; number_of_response:1; }","duration":"178.354213ms","start":"2026-09-01T04:26:48.180936Z","end":"2026-09-01T04:26:48.35929Z","steps":["trace[129167957] 'process raft request' (duration: 177.631206ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:26:48.359613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.149481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-01T04:26:48.359653Z","caller":"traceutil/trace.go:171","msg":"trace[815290361] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:6805; }","duration":"128.229373ms","start":"2026-09-01T04:26:48.231413Z","end":"2026-09-01T04:26:48.359643Z","steps":["trace[815290361] 'agreement among raft nodes before linearized reading' (duration: 128.111529ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:26:48.66525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.901373ms","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:107271"} {"level":"info","ts":"2026-09-01T04:26:48.665315Z","caller":"traceutil/trace.go:171","msg":"trace[766506980] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:6805; }","duration":"264.004707ms","start":"2026-09-01T04:26:48.401295Z","end":"2026-09-01T04:26:48.6653Z","steps":["trace[766506980] 'range keys from in-memory index tree' (duration: 263.735507ms)"],"step_count":1} {"level":"warn","ts":"2026-09-01T04:26:48.666709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.844834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-01T04:26:48.666786Z","caller":"traceutil/trace.go:171","msg":"trace[1563465304] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:6805; }","duration":"211.951458ms","start":"2026-09-01T04:26:48.454823Z","end":"2026-09-01T04:26:48.666775Z","steps":["trace[1563465304] 'count revisions from in-memory index tree' (duration: 211.760481ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:48.667337Z","caller":"traceutil/trace.go:171","msg":"trace[20101419] transaction","detail":"{read_only:false; response_revision:6806; number_of_response:1; }","duration":"183.94679ms","start":"2026-09-01T04:26:48.483373Z","end":"2026-09-01T04:26:48.667319Z","steps":["trace[20101419] 'process raft request' (duration: 86.505137ms)","trace[20101419] 'compare' (duration: 97.35307ms)"],"step_count":2} {"level":"warn","ts":"2026-09-01T04:26:48.917737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.882333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-01T04:26:48.918105Z","caller":"traceutil/trace.go:171","msg":"trace[571026786] transaction","detail":"{read_only:false; response_revision:6808; number_of_response:1; }","duration":"172.228554ms","start":"2026-09-01T04:26:48.745864Z","end":"2026-09-01T04:26:48.918093Z","steps":["trace[571026786] 'process raft request' (duration: 171.949774ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:26:48.918134Z","caller":"traceutil/trace.go:171","msg":"trace[1500677841] transaction","detail":"{read_only:false; response_revision:6807; number_of_response:1; }","duration":"177.593224ms","start":"2026-09-01T04:26:48.740516Z","end":"2026-09-01T04:26:48.918109Z","steps":["trace[1500677841] 'process raft request' (duration: 67.260944ms)","trace[1500677841] 'compare' (duration: 109.431597ms)"],"step_count":2} {"level":"info","ts":"2026-09-01T04:26:48.918204Z","caller":"traceutil/trace.go:171","msg":"trace[4918162] transaction","detail":"{read_only:false; response_revision:6809; number_of_response:1; }","duration":"154.318321ms","start":"2026-09-01T04:26:48.763879Z","end":"2026-09-01T04:26:48.918197Z","steps":["trace[4918162] 'process raft request' (duration: 153.976618ms)"],"step_count":1} {"level":"info","ts":"2026-09-01T04:28:45.976033Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5538} {"level":"info","ts":"2026-09-01T04:28:46.124359Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5538,"took":"145.855954ms","hash":3812133064,"current-db-size-bytes":54034432,"current-db-size":"54 MB","current-db-size-in-use-bytes":18661376,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-01T04:28:46.12441Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3812133064,"revision":5538,"compact-revision":2901}