{"level":"warn","ts":"2026-06-04T06:24:01.123801Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T06:24:01.123904Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-04T06:24:01.123975Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-04T06:24:01.124024Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-06-04T06:24:01.124049Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-04T06:24:01.124959Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-06-04T06:24:01.125055Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-04T06:24:01.129256Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.955392ms"} {"level":"info","ts":"2026-06-04T06:24:01.135506Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-06-04T06:24:01.13559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-06-04T06:24:01.13564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-06-04T06:24:01.135659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-04T06:24:01.135672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-06-04T06:24:01.135744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-06-04T06:24:01.143584Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-04T06:24:01.144851Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-04T06:24:01.146935Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-04T06:24:01.149221Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-04T06:24:01.150639Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-04T06:24:01.150924Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-04T06:24:01.150973Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-04T06:24:01.150985Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-04T06:24:01.151246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-06-04T06:24:01.151373Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-06-04T06:24:01.155835Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-04T06:24:01.155951Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-06-04T06:24:01.156153Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-06-04T06:24:01.156471Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-04T06:24:01.156545Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-04T06:24:01.636064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-06-04T06:24:01.636149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-04T06:24:01.636184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-06-04T06:24:01.636206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-06-04T06:24:01.636218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-06-04T06:24:01.636234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-06-04T06:24:01.636248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-06-04T06:24:01.637411Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-06-04T06:24:01.638035Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T06:24:01.638181Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-04T06:24:01.638445Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T06:24:01.638599Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-04T06:24:01.638625Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-04T06:24:01.640202Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T06:24:01.64028Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T06:24:01.640299Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-04T06:24:01.640376Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-06-04T06:24:01.641879Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-04T06:24:06.329327Z","caller":"traceutil/trace.go:171","msg":"trace[2137001708] linearizableReadLoop","detail":"{readStateIndex:216; appliedIndex:215; }","duration":"249.360688ms","start":"2026-06-04T06:24:06.079934Z","end":"2026-06-04T06:24:06.329295Z","steps":["trace[2137001708] 'read index received' (duration: 249.171306ms)","trace[2137001708] 'applied index is now lower than readState.Index' (duration: 188.252µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:24:06.329561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.605842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3707"} {"level":"info","ts":"2026-06-04T06:24:06.329518Z","caller":"traceutil/trace.go:171","msg":"trace[693236508] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"256.866281ms","start":"2026-06-04T06:24:06.072616Z","end":"2026-06-04T06:24:06.329482Z","steps":["trace[693236508] 'process raft request' (duration: 256.459115ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:06.329628Z","caller":"traceutil/trace.go:171","msg":"trace[1660500969] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:211; }","duration":"249.728803ms","start":"2026-06-04T06:24:06.079881Z","end":"2026-06-04T06:24:06.32961Z","steps":["trace[1660500969] 'agreement among raft nodes before linearized reading' (duration: 249.53151ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:06.577982Z","caller":"traceutil/trace.go:171","msg":"trace[123317304] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"240.794979ms","start":"2026-06-04T06:24:06.337161Z","end":"2026-06-04T06:24:06.577956Z","steps":["trace[123317304] 'process raft request' (duration: 240.747878ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:06.578078Z","caller":"traceutil/trace.go:171","msg":"trace[201066507] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"241.082593ms","start":"2026-06-04T06:24:06.336927Z","end":"2026-06-04T06:24:06.57801Z","steps":["trace[201066507] 'process raft request' (duration: 240.27745ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.530586Z","caller":"traceutil/trace.go:171","msg":"trace[48227385] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"225.824457ms","start":"2026-06-04T06:24:37.304728Z","end":"2026-06-04T06:24:37.530552Z","steps":["trace[48227385] 'process raft request' (duration: 225.717415ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.530615Z","caller":"traceutil/trace.go:171","msg":"trace[1218293665] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"226.05529ms","start":"2026-06-04T06:24:37.304501Z","end":"2026-06-04T06:24:37.530557Z","steps":["trace[1218293665] 'process raft request' (duration: 153.567296ms)","trace[1218293665] 'compare' (duration: 72.057688ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:24:37.53714Z","caller":"traceutil/trace.go:171","msg":"trace[377075756] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"227.919584ms","start":"2026-06-04T06:24:37.309188Z","end":"2026-06-04T06:24:37.537107Z","steps":["trace[377075756] 'process raft request' (duration: 227.675181ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.537372Z","caller":"traceutil/trace.go:171","msg":"trace[892738748] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"221.215819ms","start":"2026-06-04T06:24:37.316146Z","end":"2026-06-04T06:24:37.537362Z","steps":["trace[892738748] 'process raft request' (duration: 220.935665ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.537382Z","caller":"traceutil/trace.go:171","msg":"trace[1748095717] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"221.274019ms","start":"2026-06-04T06:24:37.316059Z","end":"2026-06-04T06:24:37.537333Z","steps":["trace[1748095717] 'process raft request' (duration: 220.960695ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.537479Z","caller":"traceutil/trace.go:171","msg":"trace[1444612867] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"221.32455ms","start":"2026-06-04T06:24:37.316143Z","end":"2026-06-04T06:24:37.537467Z","steps":["trace[1444612867] 'process raft request' (duration: 221.108857ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.537679Z","caller":"traceutil/trace.go:171","msg":"trace[100398674] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"221.2828ms","start":"2026-06-04T06:24:37.316386Z","end":"2026-06-04T06:24:37.537669Z","steps":["trace[100398674] 'process raft request' (duration: 220.946585ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.537705Z","caller":"traceutil/trace.go:171","msg":"trace[998712675] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:525; }","duration":"141.790287ms","start":"2026-06-04T06:24:37.395885Z","end":"2026-06-04T06:24:37.537675Z","steps":["trace[998712675] 'read index received' (duration: 62.265353ms)","trace[998712675] 'applied index is now lower than readState.Index' (duration: 79.523454ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:24:37.537793Z","caller":"traceutil/trace.go:171","msg":"trace[10010919] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"210.197608ms","start":"2026-06-04T06:24:37.327587Z","end":"2026-06-04T06:24:37.537785Z","steps":["trace[10010919] 'process raft request' (duration: 209.894554ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.53781Z","caller":"traceutil/trace.go:171","msg":"trace[647490638] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"212.71836ms","start":"2026-06-04T06:24:37.325075Z","end":"2026-06-04T06:24:37.537794Z","steps":["trace[647490638] 'process raft request' (duration: 212.322975ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:37.537923Z","caller":"traceutil/trace.go:171","msg":"trace[2141573688] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"126.722765ms","start":"2026-06-04T06:24:37.411193Z","end":"2026-06-04T06:24:37.537915Z","steps":["trace[2141573688] 'process raft request' (duration: 126.3591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:24:37.53799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.09037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-04T06:24:37.538037Z","caller":"traceutil/trace.go:171","msg":"trace[2052367603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:513; }","duration":"142.206112ms","start":"2026-06-04T06:24:37.395819Z","end":"2026-06-04T06:24:37.538025Z","steps":["trace[2052367603] 'agreement among raft nodes before linearized reading' (duration: 141.968679ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:43.559565Z","caller":"traceutil/trace.go:171","msg":"trace[658390043] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"198.713053ms","start":"2026-06-04T06:24:43.360821Z","end":"2026-06-04T06:24:43.559534Z","steps":["trace[658390043] 'process raft request' (duration: 198.565231ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:44.136504Z","caller":"traceutil/trace.go:171","msg":"trace[1932428685] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"137.613285ms","start":"2026-06-04T06:24:43.998855Z","end":"2026-06-04T06:24:44.136468Z","steps":["trace[1932428685] 'process raft request' (duration: 136.912296ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:24:44.842501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.340854ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:24:44.84272Z","caller":"traceutil/trace.go:171","msg":"trace[144306444] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:619; }","duration":"227.583866ms","start":"2026-06-04T06:24:44.615118Z","end":"2026-06-04T06:24:44.842702Z","steps":["trace[144306444] 'read index received' (duration: 218.901158ms)","trace[144306444] 'applied index is now lower than readState.Index' (duration: 8.681708ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:24:44.842816Z","caller":"traceutil/trace.go:171","msg":"trace[457109711] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"645.122948ms","start":"2026-06-04T06:24:44.197683Z","end":"2026-06-04T06:24:44.842806Z","steps":["trace[457109711] 'process raft request' (duration: 644.934656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:24:44.842876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:24:44.197638Z","time spent":"645.21088ms","remote":"127.0.0.1:33740","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-04T06:24:44.842926Z","caller":"traceutil/trace.go:171","msg":"trace[657407072] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"692.085743ms","start":"2026-06-04T06:24:44.150802Z","end":"2026-06-04T06:24:44.842888Z","steps":["trace[657407072] 'process raft request' (duration: 381.684546ms)","trace[657407072] 'compare' (duration: 309.062681ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:24:44.843084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:24:44.150782Z","time spent":"692.205876ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:24:44.843401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.276955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-04T06:24:44.843479Z","caller":"traceutil/trace.go:171","msg":"trace[482137322] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:598; }","duration":"228.389965ms","start":"2026-06-04T06:24:44.615064Z","end":"2026-06-04T06:24:44.843454Z","steps":["trace[482137322] 'agreement among raft nodes before linearized reading' (duration: 228.261354ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:24:59.182745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.809048ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:24:59.182924Z","caller":"traceutil/trace.go:171","msg":"trace[399983054] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:750; }","duration":"143.00793ms","start":"2026-06-04T06:24:59.039892Z","end":"2026-06-04T06:24:59.1829Z","steps":["trace[399983054] 'range keys from in-memory index tree' (duration: 142.792278ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:59.396816Z","caller":"traceutil/trace.go:171","msg":"trace[1367377553] linearizableReadLoop","detail":"{readStateIndex:778; appliedIndex:777; }","duration":"135.773404ms","start":"2026-06-04T06:24:59.261017Z","end":"2026-06-04T06:24:59.39679Z","steps":["trace[1367377553] 'read index received' (duration: 135.533611ms)","trace[1367377553] 'applied index is now lower than readState.Index' (duration: 238.923µs)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:24:59.397022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.990256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-04T06:24:59.397049Z","caller":"traceutil/trace.go:171","msg":"trace[1156965980] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:751; }","duration":"136.067257ms","start":"2026-06-04T06:24:59.260975Z","end":"2026-06-04T06:24:59.397042Z","steps":["trace[1156965980] 'agreement among raft nodes before linearized reading' (duration: 135.900425ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:24:59.397009Z","caller":"traceutil/trace.go:171","msg":"trace[573932336] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"168.74528ms","start":"2026-06-04T06:24:59.228226Z","end":"2026-06-04T06:24:59.396972Z","steps":["trace[573932336] 'process raft request' (duration: 168.422476ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:25:28.362674Z","caller":"traceutil/trace.go:171","msg":"trace[1328519914] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"135.644975ms","start":"2026-06-04T06:25:28.227005Z","end":"2026-06-04T06:25:28.36265Z","steps":["trace[1328519914] 'process raft request' (duration: 135.505321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:18.902991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.580116ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:26:18.903189Z","caller":"traceutil/trace.go:171","msg":"trace[2095423617] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"781.573972ms","start":"2026-06-04T06:26:18.121599Z","end":"2026-06-04T06:26:18.903173Z","steps":["trace[2095423617] 'process raft request' (duration: 781.49317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:18.90326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:26:18.121577Z","time spent":"781.652673ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:26:18.903428Z","caller":"traceutil/trace.go:171","msg":"trace[533260178] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"783.866458ms","start":"2026-06-04T06:26:18.119551Z","end":"2026-06-04T06:26:18.903417Z","steps":["trace[533260178] 'process raft request' (duration: 239.788042ms)","trace[533260178] 'compare' (duration: 543.458553ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:26:18.903492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:26:18.119524Z","time spent":"783.93375ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-04T06:26:18.929371Z","caller":"traceutil/trace.go:171","msg":"trace[1164763196] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1913; }","duration":"344.185232ms","start":"2026-06-04T06:26:18.585158Z","end":"2026-06-04T06:26:18.929344Z","steps":["trace[1164763196] 'read index received' (duration: 223.139157ms)","trace[1164763196] 'applied index is now lower than readState.Index' (duration: 121.045245ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:26:18.929822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.645971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd126fd3-f5d3-498f-94f9-1a3fd6b02144\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-06-04T06:26:18.929907Z","caller":"traceutil/trace.go:171","msg":"trace[591414447] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cd126fd3-f5d3-498f-94f9-1a3fd6b02144; range_end:; response_count:1; response_revision:1846; }","duration":"344.776414ms","start":"2026-06-04T06:26:18.585113Z","end":"2026-06-04T06:26:18.92989Z","steps":["trace[591414447] 'agreement among raft nodes before linearized reading' (duration: 344.506459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:18.929951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:26:18.585101Z","time spent":"344.841245ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd126fd3-f5d3-498f-94f9-1a3fd6b02144\" "} {"level":"warn","ts":"2026-06-04T06:26:18.929875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.172409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd126fd3-f5d3-498f-94f9-1a3fd6b02144\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-06-04T06:26:18.930334Z","caller":"traceutil/trace.go:171","msg":"trace[682639252] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cd126fd3-f5d3-498f-94f9-1a3fd6b02144; range_end:; response_count:1; response_revision:1846; }","duration":"338.66977ms","start":"2026-06-04T06:26:18.59165Z","end":"2026-06-04T06:26:18.93032Z","steps":["trace[682639252] 'agreement among raft nodes before linearized reading' (duration: 338.098508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:18.930557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:26:18.591631Z","time spent":"338.906904ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3648,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd126fd3-f5d3-498f-94f9-1a3fd6b02144\" "} {"level":"info","ts":"2026-06-04T06:26:18.93012Z","caller":"traceutil/trace.go:171","msg":"trace[1342080611] transaction","detail":"{read_only:false; response_revision:1846; number_of_response:1; }","duration":"347.231233ms","start":"2026-06-04T06:26:18.582865Z","end":"2026-06-04T06:26:18.930096Z","steps":["trace[1342080611] 'process raft request' (duration: 346.361996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:18.930766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:26:18.582812Z","time spent":"347.861336ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:26:18.930261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.873176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-04T06:26:18.930867Z","caller":"traceutil/trace.go:171","msg":"trace[543130222] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1846; }","duration":"313.501839ms","start":"2026-06-04T06:26:18.617347Z","end":"2026-06-04T06:26:18.930848Z","steps":["trace[543130222] 'agreement among raft nodes before linearized reading' (duration: 312.819066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:18.930955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:26:18.617331Z","time spent":"313.606181ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T06:26:18.930274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.853543ms","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-06-04T06:26:18.931058Z","caller":"traceutil/trace.go:171","msg":"trace[1777015912] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1846; }","duration":"233.635769ms","start":"2026-06-04T06:26:18.697402Z","end":"2026-06-04T06:26:18.931038Z","steps":["trace[1777015912] 'agreement among raft nodes before linearized reading' (duration: 232.740411ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:19.061077Z","caller":"traceutil/trace.go:171","msg":"trace[286653349] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"121.606391ms","start":"2026-06-04T06:26:18.939435Z","end":"2026-06-04T06:26:19.061042Z","steps":["trace[286653349] 'process raft request' (duration: 115.697952ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:19.490784Z","caller":"traceutil/trace.go:171","msg":"trace[915805750] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"176.888971ms","start":"2026-06-04T06:26:19.313869Z","end":"2026-06-04T06:26:19.490758Z","steps":["trace[915805750] 'process raft request' (duration: 176.729607ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:26.138311Z","caller":"traceutil/trace.go:171","msg":"trace[925547293] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"118.331541ms","start":"2026-06-04T06:26:26.019908Z","end":"2026-06-04T06:26:26.138239Z","steps":["trace[925547293] 'process raft request' (duration: 117.782061ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:41.87497Z","caller":"traceutil/trace.go:171","msg":"trace[1337242627] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"125.259471ms","start":"2026-06-04T06:26:41.749692Z","end":"2026-06-04T06:26:41.874951Z","steps":["trace[1337242627] 'process raft request' (duration: 125.127829ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:48.313943Z","caller":"traceutil/trace.go:171","msg":"trace[894772966] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"101.452536ms","start":"2026-06-04T06:26:48.212465Z","end":"2026-06-04T06:26:48.313918Z","steps":["trace[894772966] 'process raft request' (duration: 100.894506ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:49.382936Z","caller":"traceutil/trace.go:171","msg":"trace[1657905246] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"245.188006ms","start":"2026-06-04T06:26:49.137722Z","end":"2026-06-04T06:26:49.38291Z","steps":["trace[1657905246] 'process raft request' (duration: 245.030543ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:49.400925Z","caller":"traceutil/trace.go:171","msg":"trace[1215063196] linearizableReadLoop","detail":"{readStateIndex:2137; appliedIndex:2135; }","duration":"166.993251ms","start":"2026-06-04T06:26:49.233897Z","end":"2026-06-04T06:26:49.40089Z","steps":["trace[1215063196] 'read index received' (duration: 148.927039ms)","trace[1215063196] 'applied index is now lower than readState.Index' (duration: 18.065092ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:26:49.400983Z","caller":"traceutil/trace.go:171","msg":"trace[390813204] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"250.578952ms","start":"2026-06-04T06:26:49.150376Z","end":"2026-06-04T06:26:49.400955Z","steps":["trace[390813204] 'process raft request' (duration: 249.730087ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:49.4011Z","caller":"traceutil/trace.go:171","msg":"trace[762523325] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"167.089042ms","start":"2026-06-04T06:26:49.233956Z","end":"2026-06-04T06:26:49.401045Z","steps":["trace[762523325] 'process raft request' (duration: 166.880758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:49.401241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.326666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-04T06:26:49.401285Z","caller":"traceutil/trace.go:171","msg":"trace[1243371892] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2062; }","duration":"167.427638ms","start":"2026-06-04T06:26:49.233843Z","end":"2026-06-04T06:26:49.401271Z","steps":["trace[1243371892] 'agreement among raft nodes before linearized reading' (duration: 167.192123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:49.401284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.01548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-04T06:26:49.401332Z","caller":"traceutil/trace.go:171","msg":"trace[1090331564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2062; }","duration":"167.112072ms","start":"2026-06-04T06:26:49.234208Z","end":"2026-06-04T06:26:49.40132Z","steps":["trace[1090331564] 'agreement among raft nodes before linearized reading' (duration: 166.96706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:26:49.599599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.957012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:26:49.599765Z","caller":"traceutil/trace.go:171","msg":"trace[1209499215] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"193.187278ms","start":"2026-06-04T06:26:49.406555Z","end":"2026-06-04T06:26:49.599742Z","steps":["trace[1209499215] 'process raft request' (duration: 64.013773ms)","trace[1209499215] 'compare' (duration: 128.864499ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:26:49.600308Z","caller":"traceutil/trace.go:171","msg":"trace[1727270925] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"193.696516ms","start":"2026-06-04T06:26:49.406589Z","end":"2026-06-04T06:26:49.600286Z","steps":["trace[1727270925] 'process raft request' (duration: 193.112246ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:49.726365Z","caller":"traceutil/trace.go:171","msg":"trace[1701969936] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"121.691752ms","start":"2026-06-04T06:26:49.604634Z","end":"2026-06-04T06:26:49.726326Z","steps":["trace[1701969936] 'process raft request' (duration: 119.298749ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:26:49.733708Z","caller":"traceutil/trace.go:171","msg":"trace[1293717839] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"123.154258ms","start":"2026-06-04T06:26:49.610525Z","end":"2026-06-04T06:26:49.733679Z","steps":["trace[1293717839] 'process raft request' (duration: 122.919844ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:27:55.932042Z","caller":"traceutil/trace.go:171","msg":"trace[425277999] transaction","detail":"{read_only:false; response_revision:2524; number_of_response:1; }","duration":"237.792359ms","start":"2026-06-04T06:27:55.694223Z","end":"2026-06-04T06:27:55.932015Z","steps":["trace[425277999] 'process raft request' (duration: 237.600186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:28:28.627509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.322429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-04T06:28:28.627606Z","caller":"traceutil/trace.go:171","msg":"trace[2106854788] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2706; }","duration":"176.4735ms","start":"2026-06-04T06:28:28.451112Z","end":"2026-06-04T06:28:28.627586Z","steps":["trace[2106854788] 'range keys from in-memory index tree' (duration: 176.074365ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:00.287196Z","caller":"traceutil/trace.go:171","msg":"trace[148348293] transaction","detail":"{read_only:false; response_revision:4424; number_of_response:1; }","duration":"104.45367ms","start":"2026-06-04T06:32:00.182725Z","end":"2026-06-04T06:32:00.287179Z","steps":["trace[148348293] 'process raft request' (duration: 104.344417ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:00.313808Z","caller":"traceutil/trace.go:171","msg":"trace[1329400643] transaction","detail":"{read_only:false; response_revision:4425; number_of_response:1; }","duration":"103.502546ms","start":"2026-06-04T06:32:00.210281Z","end":"2026-06-04T06:32:00.313784Z","steps":["trace[1329400643] 'process raft request' (duration: 103.394203ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:05.544776Z","caller":"traceutil/trace.go:171","msg":"trace[1664175471] linearizableReadLoop","detail":"{readStateIndex:4720; appliedIndex:4719; }","duration":"103.530344ms","start":"2026-06-04T06:32:05.441197Z","end":"2026-06-04T06:32:05.544727Z","steps":["trace[1664175471] 'read index received' (duration: 7.13867ms)","trace[1664175471] 'applied index is now lower than readState.Index' (duration: 96.390604ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:05.544842Z","caller":"traceutil/trace.go:171","msg":"trace[816975573] transaction","detail":"{read_only:false; response_revision:4549; number_of_response:1; }","duration":"108.221963ms","start":"2026-06-04T06:32:05.436602Z","end":"2026-06-04T06:32:05.544824Z","steps":["trace[816975573] 'process raft request' (duration: 11.83219ms)","trace[816975573] 'compare' (duration: 96.170348ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:05.545049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.829662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7580"} {"level":"info","ts":"2026-06-04T06:32:05.545104Z","caller":"traceutil/trace.go:171","msg":"trace[982976024] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4549; }","duration":"103.922974ms","start":"2026-06-04T06:32:05.441165Z","end":"2026-06-04T06:32:05.545088Z","steps":["trace[982976024] 'agreement among raft nodes before linearized reading' (duration: 103.737009ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:10.705422Z","caller":"traceutil/trace.go:171","msg":"trace[735989650] transaction","detail":"{read_only:false; response_revision:4601; number_of_response:1; }","duration":"161.69196ms","start":"2026-06-04T06:32:10.543706Z","end":"2026-06-04T06:32:10.705398Z","steps":["trace[735989650] 'process raft request' (duration: 161.637089ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:10.705455Z","caller":"traceutil/trace.go:171","msg":"trace[1301522285] transaction","detail":"{read_only:false; response_revision:4600; number_of_response:1; }","duration":"162.015899ms","start":"2026-06-04T06:32:10.543393Z","end":"2026-06-04T06:32:10.705409Z","steps":["trace[1301522285] 'process raft request' (duration: 161.915686ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:10.705458Z","caller":"traceutil/trace.go:171","msg":"trace[1541343667] transaction","detail":"{read_only:false; response_revision:4599; number_of_response:1; }","duration":"162.987733ms","start":"2026-06-04T06:32:10.542437Z","end":"2026-06-04T06:32:10.705425Z","steps":["trace[1541343667] 'process raft request' (duration: 107.752379ms)","trace[1541343667] 'compare' (duration: 55.007448ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:10.715389Z","caller":"traceutil/trace.go:171","msg":"trace[681442575] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"136.399977ms","start":"2026-06-04T06:32:10.578964Z","end":"2026-06-04T06:32:10.715364Z","steps":["trace[681442575] 'process raft request' (duration: 136.218672ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:10.715441Z","caller":"traceutil/trace.go:171","msg":"trace[669813120] transaction","detail":"{read_only:false; response_revision:4603; number_of_response:1; }","duration":"123.543194ms","start":"2026-06-04T06:32:10.591879Z","end":"2026-06-04T06:32:10.715422Z","steps":["trace[669813120] 'process raft request' (duration: 123.417261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:11.92444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.20499ms","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-06-04T06:32:11.924499Z","caller":"traceutil/trace.go:171","msg":"trace[875710027] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4654; }","duration":"103.302112ms","start":"2026-06-04T06:32:11.821184Z","end":"2026-06-04T06:32:11.924486Z","steps":["trace[875710027] 'count revisions from in-memory index tree' (duration: 103.135098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:11.924495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.134187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18b5cd18119c9e6a\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-06-04T06:32:11.924811Z","caller":"traceutil/trace.go:171","msg":"trace[1678030014] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18b5cd18119c9e6a; range_end:; response_count:1; response_revision:4654; }","duration":"221.465255ms","start":"2026-06-04T06:32:11.7033Z","end":"2026-06-04T06:32:11.924765Z","steps":["trace[1678030014] 'range keys from in-memory index tree' (duration: 221.010234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:11.924351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.291896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-04T06:32:11.925356Z","caller":"traceutil/trace.go:171","msg":"trace[280896095] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4654; }","duration":"207.350912ms","start":"2026-06-04T06:32:11.717977Z","end":"2026-06-04T06:32:11.925328Z","steps":["trace[280896095] 'range keys from in-memory index tree' (duration: 206.088231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:12.456625Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933266286339463151,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-04T06:32:12.599496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.233157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:32:12.599589Z","caller":"traceutil/trace.go:171","msg":"trace[1415628650] linearizableReadLoop","detail":"{readStateIndex:4828; appliedIndex:4827; }","duration":"643.19985ms","start":"2026-06-04T06:32:11.956376Z","end":"2026-06-04T06:32:12.599576Z","steps":["trace[1415628650] 'read index received' (duration: 528.776148ms)","trace[1415628650] 'applied index is now lower than readState.Index' (duration: 114.422882ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:12.59963Z","caller":"traceutil/trace.go:171","msg":"trace[1392790653] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"670.338898ms","start":"2026-06-04T06:32:11.929285Z","end":"2026-06-04T06:32:12.599624Z","steps":["trace[1392790653] 'process raft request' (duration: 555.921656ms)","trace[1392790653] 'compare' (duration: 113.958711ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:12.599784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:11.929268Z","time spent":"670.38189ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:32:12.599799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.394915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9425"} {"level":"info","ts":"2026-06-04T06:32:12.599864Z","caller":"traceutil/trace.go:171","msg":"trace[226481030] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4656; }","duration":"643.509978ms","start":"2026-06-04T06:32:11.956338Z","end":"2026-06-04T06:32:12.599848Z","steps":["trace[226481030] 'agreement among raft nodes before linearized reading' (duration: 643.310693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:12.599909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:11.956323Z","time spent":"643.576959ms","remote":"127.0.0.1:33670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":9448,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-04T06:32:12.628156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.090466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:32:12.62825Z","caller":"traceutil/trace.go:171","msg":"trace[1972240362] range","detail":"{range_begin:/registry/rabbitmq.com/operatorpolicies/; range_end:/registry/rabbitmq.com/operatorpolicies0; response_count:0; response_revision:4657; }","duration":"653.220079ms","start":"2026-06-04T06:32:11.975008Z","end":"2026-06-04T06:32:12.628228Z","steps":["trace[1972240362] 'agreement among raft nodes before linearized reading' (duration: 653.061885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:12.628323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:11.974998Z","time spent":"653.311942ms","remote":"127.0.0.1:37490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/operatorpolicies/\" range_end:\"/registry/rabbitmq.com/operatorpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-04T06:32:12.628412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.701877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-04T06:32:12.628481Z","caller":"traceutil/trace.go:171","msg":"trace[1678400877] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4657; }","duration":"235.808669ms","start":"2026-06-04T06:32:12.392654Z","end":"2026-06-04T06:32:12.628462Z","steps":["trace[1678400877] 'agreement among raft nodes before linearized reading' (duration: 235.583534ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:12.628484Z","caller":"traceutil/trace.go:171","msg":"trace[1894508699] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"101.142032ms","start":"2026-06-04T06:32:12.527305Z","end":"2026-06-04T06:32:12.628447Z","steps":["trace[1894508699] 'process raft request' (duration: 100.592178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:12.628429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.350785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T06:32:12.628544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.160343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7503ce09-8839-455f-8bd9-d8eb89d4f970\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-04T06:32:12.62859Z","caller":"traceutil/trace.go:171","msg":"trace[552900720] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7503ce09-8839-455f-8bd9-d8eb89d4f970; range_end:; response_count:1; response_revision:4657; }","duration":"648.236304ms","start":"2026-06-04T06:32:11.980344Z","end":"2026-06-04T06:32:12.62858Z","steps":["trace[552900720] 'agreement among raft nodes before linearized reading' (duration: 648.04728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:12.628627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:11.980335Z","time spent":"648.285365ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3667,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7503ce09-8839-455f-8bd9-d8eb89d4f970\" "} {"level":"info","ts":"2026-06-04T06:32:12.628628Z","caller":"traceutil/trace.go:171","msg":"trace[152245718] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:4657; }","duration":"277.56343ms","start":"2026-06-04T06:32:12.351Z","end":"2026-06-04T06:32:12.628563Z","steps":["trace[152245718] 'agreement among raft nodes before linearized reading' (duration: 277.363775ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:12.630272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.022188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12970"} {"level":"info","ts":"2026-06-04T06:32:12.630433Z","caller":"traceutil/trace.go:171","msg":"trace[2055691057] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4657; }","duration":"334.221883ms","start":"2026-06-04T06:32:12.296194Z","end":"2026-06-04T06:32:12.630416Z","steps":["trace[2055691057] 'agreement among raft nodes before linearized reading' (duration: 332.149602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:12.630529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:12.296173Z","time spent":"334.339946ms","remote":"127.0.0.1:33674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12993,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-06-04T06:32:12.761384Z","caller":"traceutil/trace.go:171","msg":"trace[1929646692] linearizableReadLoop","detail":"{readStateIndex:4830; appliedIndex:4829; }","duration":"102.132927ms","start":"2026-06-04T06:32:12.659196Z","end":"2026-06-04T06:32:12.761329Z","steps":["trace[1929646692] 'read index received' (duration: 96.708661ms)","trace[1929646692] 'applied index is now lower than readState.Index' (duration: 5.422876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:12.761511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.28996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:32:12.761544Z","caller":"traceutil/trace.go:171","msg":"trace[190057873] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4658; }","duration":"102.364323ms","start":"2026-06-04T06:32:12.65917Z","end":"2026-06-04T06:32:12.761535Z","steps":["trace[190057873] 'agreement among raft nodes before linearized reading' (duration: 102.284451ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:12.761638Z","caller":"traceutil/trace.go:171","msg":"trace[1776870683] transaction","detail":"{read_only:false; response_revision:4658; number_of_response:1; }","duration":"120.458974ms","start":"2026-06-04T06:32:12.641148Z","end":"2026-06-04T06:32:12.761607Z","steps":["trace[1776870683] 'process raft request' (duration: 114.765301ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.545577Z","caller":"traceutil/trace.go:171","msg":"trace[1028045375] linearizableReadLoop","detail":"{readStateIndex:4838; appliedIndex:4837; }","duration":"388.117116ms","start":"2026-06-04T06:32:13.157439Z","end":"2026-06-04T06:32:13.545556Z","steps":["trace[1028045375] 'read index received' (duration: 308.69222ms)","trace[1028045375] 'applied index is now lower than readState.Index' (duration: 79.424076ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:13.545704Z","caller":"traceutil/trace.go:171","msg":"trace[1159223966] transaction","detail":"{read_only:false; response_revision:4666; number_of_response:1; }","duration":"407.807895ms","start":"2026-06-04T06:32:13.137883Z","end":"2026-06-04T06:32:13.545691Z","steps":["trace[1159223966] 'process raft request' (duration: 328.199134ms)","trace[1159223966] 'compare' (duration: 79.340264ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:13.545799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:13.137855Z","time spent":"407.874217ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-04T06:32:13.546028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.594477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-04T06:32:13.546066Z","caller":"traceutil/trace.go:171","msg":"trace[1849668809] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4667; }","duration":"388.673599ms","start":"2026-06-04T06:32:13.157383Z","end":"2026-06-04T06:32:13.546057Z","steps":["trace[1849668809] 'agreement among raft nodes before linearized reading' (duration: 388.520725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:13.546097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:13.157358Z","time spent":"388.730391ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-04T06:32:13.546243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.423025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-04T06:32:13.546272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.476879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-04T06:32:13.546306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.292622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-04T06:32:13.546331Z","caller":"traceutil/trace.go:171","msg":"trace[977215472] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4667; }","duration":"385.579882ms","start":"2026-06-04T06:32:13.160738Z","end":"2026-06-04T06:32:13.546318Z","steps":["trace[977215472] 'agreement among raft nodes before linearized reading' (duration: 385.302495ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.546329Z","caller":"traceutil/trace.go:171","msg":"trace[23023659] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:4667; }","duration":"327.527928ms","start":"2026-06-04T06:32:13.218767Z","end":"2026-06-04T06:32:13.546295Z","steps":["trace[23023659] 'agreement among raft nodes before linearized reading' (duration: 327.423225ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.546361Z","caller":"traceutil/trace.go:171","msg":"trace[395932333] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4667; }","duration":"204.377494ms","start":"2026-06-04T06:32:13.341966Z","end":"2026-06-04T06:32:13.546344Z","steps":["trace[395932333] 'agreement among raft nodes before linearized reading' (duration: 204.131958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:13.546381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.84088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-04T06:32:13.546383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:13.218751Z","time spent":"327.6206ms","remote":"127.0.0.1:37654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true "} {"level":"info","ts":"2026-06-04T06:32:13.546422Z","caller":"traceutil/trace.go:171","msg":"trace[1289589114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4667; }","duration":"377.901531ms","start":"2026-06-04T06:32:13.168511Z","end":"2026-06-04T06:32:13.546412Z","steps":["trace[1289589114] 'agreement among raft nodes before linearized reading' (duration: 377.702206ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:13.546451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:13.168501Z","time spent":"377.943282ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-04T06:32:13.546369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-04T06:32:13.160718Z","time spent":"385.643154ms","remote":"127.0.0.1:33784","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-04T06:32:13.546819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.120452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-04T06:32:13.5469Z","caller":"traceutil/trace.go:171","msg":"trace[1075800241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4667; }","duration":"293.233505ms","start":"2026-06-04T06:32:13.253646Z","end":"2026-06-04T06:32:13.54688Z","steps":["trace[1075800241] 'agreement among raft nodes before linearized reading' (duration: 292.444215ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.745962Z","caller":"traceutil/trace.go:171","msg":"trace[1220852144] transaction","detail":"{read_only:false; response_revision:4669; number_of_response:1; }","duration":"194.512349ms","start":"2026-06-04T06:32:13.551419Z","end":"2026-06-04T06:32:13.745931Z","steps":["trace[1220852144] 'process raft request' (duration: 115.386461ms)","trace[1220852144] 'compare' (duration: 78.77683ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:13.746012Z","caller":"traceutil/trace.go:171","msg":"trace[1631206849] linearizableReadLoop","detail":"{readStateIndex:4844; appliedIndex:4840; }","duration":"111.792771ms","start":"2026-06-04T06:32:13.634196Z","end":"2026-06-04T06:32:13.745989Z","steps":["trace[1631206849] 'read index received' (duration: 7.728562ms)","trace[1631206849] 'applied index is now lower than readState.Index' (duration: 104.062879ms)"],"step_count":2} {"level":"warn","ts":"2026-06-04T06:32:13.74623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.470368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7503ce09-8839-455f-8bd9-d8eb89d4f970\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-04T06:32:13.746264Z","caller":"traceutil/trace.go:171","msg":"trace[708298594] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7503ce09-8839-455f-8bd9-d8eb89d4f970; range_end:; response_count:1; response_revision:4672; }","duration":"112.52307ms","start":"2026-06-04T06:32:13.633731Z","end":"2026-06-04T06:32:13.746254Z","steps":["trace[708298594] 'agreement among raft nodes before linearized reading' (duration: 112.355535ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.746328Z","caller":"traceutil/trace.go:171","msg":"trace[2027025571] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"194.740405ms","start":"2026-06-04T06:32:13.551565Z","end":"2026-06-04T06:32:13.746305Z","steps":["trace[2027025571] 'process raft request' (duration: 194.241262ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.74636Z","caller":"traceutil/trace.go:171","msg":"trace[2135012032] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"192.587871ms","start":"2026-06-04T06:32:13.55374Z","end":"2026-06-04T06:32:13.746328Z","steps":["trace[2135012032] 'process raft request' (duration: 192.152051ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.74648Z","caller":"traceutil/trace.go:171","msg":"trace[2069340908] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"133.745218ms","start":"2026-06-04T06:32:13.612723Z","end":"2026-06-04T06:32:13.746468Z","steps":["trace[2069340908] 'process raft request' (duration: 133.219975ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:13.840655Z","caller":"traceutil/trace.go:171","msg":"trace[1903946918] transaction","detail":"{read_only:false; response_revision:4673; number_of_response:1; }","duration":"148.197777ms","start":"2026-06-04T06:32:13.692437Z","end":"2026-06-04T06:32:13.840635Z","steps":["trace[1903946918] 'process raft request' (duration: 148.080094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:25.149693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.949118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-04T06:32:25.149793Z","caller":"traceutil/trace.go:171","msg":"trace[496646953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4817; }","duration":"254.108952ms","start":"2026-06-04T06:32:24.895663Z","end":"2026-06-04T06:32:25.149772Z","steps":["trace[496646953] 'range keys from in-memory index tree' (duration: 253.850715ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:32:25.79715Z","caller":"traceutil/trace.go:171","msg":"trace[1114647604] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"101.421937ms","start":"2026-06-04T06:32:25.6957Z","end":"2026-06-04T06:32:25.797122Z","steps":["trace[1114647604] 'process raft request' (duration: 101.255723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-04T06:32:26.021569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.491188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-04T06:32:26.021761Z","caller":"traceutil/trace.go:171","msg":"trace[1399337419] transaction","detail":"{read_only:false; response_revision:4822; number_of_response:1; }","duration":"191.844966ms","start":"2026-06-04T06:32:25.829895Z","end":"2026-06-04T06:32:26.02174Z","steps":["trace[1399337419] 'process raft request' (duration: 71.104602ms)","trace[1399337419] 'compare' (duration: 120.373995ms)"],"step_count":2} {"level":"info","ts":"2026-06-04T06:32:26.021938Z","caller":"traceutil/trace.go:171","msg":"trace[1971035052] transaction","detail":"{read_only:false; response_revision:4823; number_of_response:1; }","duration":"191.701013ms","start":"2026-06-04T06:32:25.830206Z","end":"2026-06-04T06:32:26.021907Z","steps":["trace[1971035052] 'process raft request' (duration: 191.463387ms)"],"step_count":1} {"level":"info","ts":"2026-06-04T06:34:01.672889Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2878} {"level":"info","ts":"2026-06-04T06:34:01.751328Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2878,"took":"76.934714ms","hash":1021476511,"current-db-size-bytes":53956608,"current-db-size":"54 MB","current-db-size-in-use-bytes":29347840,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-04T06:34:01.751403Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1021476511,"revision":2878,"compact-revision":-1} {"level":"info","ts":"2026-06-04T06:39:01.68039Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5596} {"level":"info","ts":"2026-06-04T06:39:01.770603Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5596,"took":"89.082333ms","hash":3233517938,"current-db-size-bytes":53956608,"current-db-size":"54 MB","current-db-size-in-use-bytes":18407424,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-04T06:39:01.770666Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3233517938,"revision":5596,"compact-revision":2878}