{"level":"warn","ts":"2026-04-20T04:50:04.464484Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T04:50:04.464584Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-04-20T04:50:04.464669Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T04:50:04.464684Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-20T04:50:04.464709Z","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-04-20T04:50:04.465369Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-04-20T04:50:04.467096Z","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":16,"max-cpu-available":16,"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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-04-20T04:50:04.475618Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.127441ms"} {"level":"info","ts":"2026-04-20T04:50:04.48145Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-04-20T04:50:04.481496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T04:50:04.481512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-04-20T04:50:04.481526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T04:50:04.481535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-04-20T04:50:04.481574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-04-20T04:50:04.48621Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T04:50:04.49303Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T04:50:04.508893Z","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-04-20T04:50:04.513914Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T04:50:04.514243Z","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-04-20T04:50:04.51429Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T04:50:04.514391Z","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-04-20T04:50:04.514411Z","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-04-20T04:50:04.515431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-04-20T04:50:04.515707Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-20T04:50:04.518721Z","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-04-20T04:50:04.518882Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-20T04:50:04.518972Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-20T04:50:04.51926Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T04:50:04.519311Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T04:50:04.982627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T04:50:04.982735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T04:50:04.982763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-04-20T04:50:04.982782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-04-20T04:50:04.982792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-20T04:50:04.982811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-04-20T04:50:04.982827Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-20T04:50:04.984456Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T04:50:04.984479Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:50:04.984453Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:50:04.984496Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:50:04.984797Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T04:50:04.98491Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T04:50:04.986474Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:50:04.986601Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:50:04.98664Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:50:04.987797Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-04-20T04:50:04.988749Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T04:50:23.476106Z","caller":"traceutil/trace.go:171","msg":"trace[684515085] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"139.303825ms","start":"2026-04-20T04:50:23.336771Z","end":"2026-04-20T04:50:23.476075Z","steps":["trace[684515085] 'process raft request' (duration: 139.113801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:58.658891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.695587ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:50:58.659351Z","caller":"traceutil/trace.go:171","msg":"trace[1610298653] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"329.664525ms","start":"2026-04-20T04:50:58.329642Z","end":"2026-04-20T04:50:58.659307Z","steps":["trace[1610298653] 'process raft request' (duration: 175.35811ms)","trace[1610298653] 'compare' (duration: 152.515451ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:50:58.659545Z","caller":"traceutil/trace.go:171","msg":"trace[36305885] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"297.887789ms","start":"2026-04-20T04:50:58.361626Z","end":"2026-04-20T04:50:58.659514Z","steps":["trace[36305885] 'process raft request' (duration: 297.63057ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:58.659512Z","caller":"traceutil/trace.go:171","msg":"trace[423054156] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"314.007331ms","start":"2026-04-20T04:50:58.345456Z","end":"2026-04-20T04:50:58.659463Z","steps":["trace[423054156] 'process raft request' (duration: 313.624697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:58.659568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:50:58.328919Z","time spent":"330.541386ms","remote":"127.0.0.1:35228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:50:58.659716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:50:58.345413Z","time spent":"314.228579ms","remote":"127.0.0.1:35228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T04:50:58.659769Z","caller":"traceutil/trace.go:171","msg":"trace[1109778026] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"295.745664ms","start":"2026-04-20T04:50:58.364008Z","end":"2026-04-20T04:50:58.659753Z","steps":["trace[1109778026] 'process raft request' (duration: 295.417492ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:59.194598Z","caller":"traceutil/trace.go:171","msg":"trace[1740973123] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"106.600435ms","start":"2026-04-20T04:50:59.087962Z","end":"2026-04-20T04:50:59.194562Z","steps":["trace[1740973123] 'process raft request' (duration: 64.302117ms)","trace[1740973123] 'compare' (duration: 42.092861ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:51:05.40991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.367754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:51:05.410078Z","caller":"traceutil/trace.go:171","msg":"trace[672803765] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"269.856178ms","start":"2026-04-20T04:51:05.140192Z","end":"2026-04-20T04:51:05.410048Z","steps":["trace[672803765] 'process raft request' (duration: 99.243485ms)","trace[672803765] 'compare' (duration: 170.084344ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:51:05.832313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.819971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:51:05.832413Z","caller":"traceutil/trace.go:171","msg":"trace[1318237153] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"248.972537ms","start":"2026-04-20T04:51:05.583413Z","end":"2026-04-20T04:51:05.832386Z","steps":["trace[1318237153] 'range keys from in-memory index tree' (duration: 248.728758ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:05.832984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.627544ms","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-04-20T04:51:05.834236Z","caller":"traceutil/trace.go:171","msg":"trace[948681148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:639; }","duration":"111.351744ms","start":"2026-04-20T04:51:05.722831Z","end":"2026-04-20T04:51:05.834183Z","steps":["trace[948681148] 'range keys from in-memory index tree' (duration: 109.355254ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:21.85579Z","caller":"traceutil/trace.go:171","msg":"trace[2084309947] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"160.628475ms","start":"2026-04-20T04:51:21.695132Z","end":"2026-04-20T04:51:21.85576Z","steps":["trace[2084309947] 'process raft request' (duration: 150.173203ms)","trace[2084309947] 'compare' (duration: 10.265778ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:16.360036Z","caller":"traceutil/trace.go:171","msg":"trace[1093524869] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"103.978799ms","start":"2026-04-20T04:52:16.256018Z","end":"2026-04-20T04:52:16.359997Z","steps":["trace[1093524869] 'process raft request' (duration: 85.275626ms)","trace[1093524869] 'compare' (duration: 18.273701ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:52:43.819473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.58886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:52:43.819603Z","caller":"traceutil/trace.go:171","msg":"trace[1986545130] linearizableReadLoop","detail":"{readStateIndex:1975; appliedIndex:1974; }","duration":"236.540541ms","start":"2026-04-20T04:52:43.583045Z","end":"2026-04-20T04:52:43.819586Z","steps":["trace[1986545130] 'read index received' (duration: 7.792607ms)","trace[1986545130] 'applied index is now lower than readState.Index' (duration: 228.746624ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:43.819697Z","caller":"traceutil/trace.go:171","msg":"trace[608794806] transaction","detail":"{read_only:false; response_revision:1899; number_of_response:1; }","duration":"275.956127ms","start":"2026-04-20T04:52:43.543727Z","end":"2026-04-20T04:52:43.819684Z","steps":["trace[608794806] 'process raft request' (duration: 47.06589ms)","trace[608794806] 'compare' (duration: 228.356424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:52:43.819903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.481845ms","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-04-20T04:52:43.819975Z","caller":"traceutil/trace.go:171","msg":"trace[38788395] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1899; }","duration":"137.605369ms","start":"2026-04-20T04:52:43.682356Z","end":"2026-04-20T04:52:43.819961Z","steps":["trace[38788395] 'agreement among raft nodes before linearized reading' (duration: 137.445385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:43.820023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.979291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:52:43.820344Z","caller":"traceutil/trace.go:171","msg":"trace[1717668586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1899; }","duration":"237.35595ms","start":"2026-04-20T04:52:43.582976Z","end":"2026-04-20T04:52:43.820332Z","steps":["trace[1717668586] 'agreement among raft nodes before linearized reading' (duration: 236.828437ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:56.505936Z","caller":"traceutil/trace.go:171","msg":"trace[479825980] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"101.896907ms","start":"2026-04-20T04:52:56.404009Z","end":"2026-04-20T04:52:56.505905Z","steps":["trace[479825980] 'process raft request' (duration: 66.886154ms)","trace[479825980] 'compare' (duration: 34.8766ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:00.035804Z","caller":"traceutil/trace.go:171","msg":"trace[329997971] linearizableReadLoop","detail":"{readStateIndex:2111; appliedIndex:2110; }","duration":"110.392683ms","start":"2026-04-20T04:52:59.925381Z","end":"2026-04-20T04:53:00.035774Z","steps":["trace[329997971] 'read index received' (duration: 110.196078ms)","trace[329997971] 'applied index is now lower than readState.Index' (duration: 195.435µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:00.035896Z","caller":"traceutil/trace.go:171","msg":"trace[1310756643] transaction","detail":"{read_only:false; response_revision:2031; number_of_response:1; }","duration":"153.756568ms","start":"2026-04-20T04:52:59.882111Z","end":"2026-04-20T04:53:00.035867Z","steps":["trace[1310756643] 'process raft request' (duration: 153.43178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:00.03612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.6982ms","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-04-20T04:53:00.036235Z","caller":"traceutil/trace.go:171","msg":"trace[1699487040] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2031; }","duration":"110.857964ms","start":"2026-04-20T04:52:59.925358Z","end":"2026-04-20T04:53:00.036216Z","steps":["trace[1699487040] 'agreement among raft nodes before linearized reading' (duration: 110.526595ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:53:38.954141Z","caller":"traceutil/trace.go:171","msg":"trace[1898982952] transaction","detail":"{read_only:false; response_revision:2241; number_of_response:1; }","duration":"243.169006ms","start":"2026-04-20T04:53:38.710943Z","end":"2026-04-20T04:53:38.954112Z","steps":["trace[1898982952] 'process raft request' (duration: 242.977821ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:53:38.994456Z","caller":"traceutil/trace.go:171","msg":"trace[1676862781] linearizableReadLoop","detail":"{readStateIndex:2331; appliedIndex:2329; }","duration":"141.995684ms","start":"2026-04-20T04:53:38.852436Z","end":"2026-04-20T04:53:38.994432Z","steps":["trace[1676862781] 'read index received' (duration: 101.473527ms)","trace[1676862781] 'applied index is now lower than readState.Index' (duration: 40.521087ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:38.994622Z","caller":"traceutil/trace.go:171","msg":"trace[1531895658] transaction","detail":"{read_only:false; response_revision:2242; number_of_response:1; }","duration":"175.83355ms","start":"2026-04-20T04:53:38.818746Z","end":"2026-04-20T04:53:38.99458Z","steps":["trace[1531895658] 'process raft request' (duration: 175.552644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:38.994759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.312212ms","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-04-20T04:53:38.994848Z","caller":"traceutil/trace.go:171","msg":"trace[741736994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2242; }","duration":"142.461005ms","start":"2026-04-20T04:53:38.852372Z","end":"2026-04-20T04:53:38.994833Z","steps":["trace[741736994] 'agreement among raft nodes before linearized reading' (duration: 142.156458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:39.295076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.982782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:53:39.295204Z","caller":"traceutil/trace.go:171","msg":"trace[998645923] linearizableReadLoop","detail":"{readStateIndex:2332; appliedIndex:2331; }","duration":"263.234159ms","start":"2026-04-20T04:53:39.031952Z","end":"2026-04-20T04:53:39.295186Z","steps":["trace[998645923] 'read index received' (duration: 94.892309ms)","trace[998645923] 'applied index is now lower than readState.Index' (duration: 168.34041ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:39.295256Z","caller":"traceutil/trace.go:171","msg":"trace[18018937] transaction","detail":"{read_only:false; response_revision:2243; number_of_response:1; }","duration":"295.294123ms","start":"2026-04-20T04:53:38.999934Z","end":"2026-04-20T04:53:39.295228Z","steps":["trace[18018937] 'process raft request' (duration: 127.058895ms)","trace[18018937] 'compare' (duration: 167.757887ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:53:39.295362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.414534ms","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-04-20T04:53:39.295401Z","caller":"traceutil/trace.go:171","msg":"trace[988614167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2243; }","duration":"263.493926ms","start":"2026-04-20T04:53:39.031896Z","end":"2026-04-20T04:53:39.29539Z","steps":["trace[988614167] 'agreement among raft nodes before linearized reading' (duration: 263.338502ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:54.599441Z","caller":"traceutil/trace.go:171","msg":"trace[1574858010] transaction","detail":"{read_only:false; response_revision:2848; number_of_response:1; }","duration":"144.182394ms","start":"2026-04-20T04:54:54.455223Z","end":"2026-04-20T04:54:54.599406Z","steps":["trace[1574858010] 'process raft request' (duration: 143.809845ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:57:10.202264Z","caller":"traceutil/trace.go:171","msg":"trace[531252193] linearizableReadLoop","detail":"{readStateIndex:3907; appliedIndex:3906; }","duration":"100.399522ms","start":"2026-04-20T04:57:10.101839Z","end":"2026-04-20T04:57:10.202238Z","steps":["trace[531252193] 'read index received' (duration: 100.131856ms)","trace[531252193] 'applied index is now lower than readState.Index' (duration: 266.816µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:57:10.202368Z","caller":"traceutil/trace.go:171","msg":"trace[1491681991] transaction","detail":"{read_only:false; response_revision:3761; number_of_response:1; }","duration":"112.928858ms","start":"2026-04-20T04:57:10.089408Z","end":"2026-04-20T04:57:10.202336Z","steps":["trace[1491681991] 'process raft request' (duration: 112.621861ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:57:10.202439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.580736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T04:57:10.202496Z","caller":"traceutil/trace.go:171","msg":"trace[492776689] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:3761; }","duration":"100.706328ms","start":"2026-04-20T04:57:10.10178Z","end":"2026-04-20T04:57:10.202486Z","steps":["trace[492776689] 'agreement among raft nodes before linearized reading' (duration: 100.570445ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:57:15.677588Z","caller":"traceutil/trace.go:171","msg":"trace[115836913] transaction","detail":"{read_only:false; response_revision:3791; number_of_response:1; }","duration":"194.456827ms","start":"2026-04-20T04:57:15.483095Z","end":"2026-04-20T04:57:15.677552Z","steps":["trace[115836913] 'process raft request' (duration: 194.202552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:58:51.059701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.985277ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:58:51.059807Z","caller":"traceutil/trace.go:171","msg":"trace[835485696] linearizableReadLoop","detail":"{readStateIndex:5230; appliedIndex:5229; }","duration":"191.810768ms","start":"2026-04-20T04:58:50.867981Z","end":"2026-04-20T04:58:51.059792Z","steps":["trace[835485696] 'read index received' (duration: 39.558144ms)","trace[835485696] 'applied index is now lower than readState.Index' (duration: 152.251314ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:58:51.059838Z","caller":"traceutil/trace.go:171","msg":"trace[271392109] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"287.927712ms","start":"2026-04-20T04:58:50.771876Z","end":"2026-04-20T04:58:51.059804Z","steps":["trace[271392109] 'process raft request' (duration: 135.76524ms)","trace[271392109] 'compare' (duration: 151.575637ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:58:51.05995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.971942ms","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-04-20T04:58:51.059985Z","caller":"traceutil/trace.go:171","msg":"trace[1227037197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5036; }","duration":"192.046143ms","start":"2026-04-20T04:58:50.867932Z","end":"2026-04-20T04:58:51.059978Z","steps":["trace[1227037197] 'agreement among raft nodes before linearized reading' (duration: 191.89868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:58:51.060016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.898974ms","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":"warn","ts":"2026-04-20T04:58:51.060112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.065553ms","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-04-20T04:58:51.06011Z","caller":"traceutil/trace.go:171","msg":"trace[1940088116] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:5036; }","duration":"105.023877ms","start":"2026-04-20T04:58:50.955075Z","end":"2026-04-20T04:58:51.060098Z","steps":["trace[1940088116] 'agreement among raft nodes before linearized reading' (duration: 104.902944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:58:51.060205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.370984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a1dc9194-e244-4658-abe4-6e2376f7e7a9\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-20T04:58:51.060229Z","caller":"traceutil/trace.go:171","msg":"trace[2015266311] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a1dc9194-e244-4658-abe4-6e2376f7e7a9; range_end:; response_count:1; response_revision:5036; }","duration":"141.420156ms","start":"2026-04-20T04:58:50.918802Z","end":"2026-04-20T04:58:51.060222Z","steps":["trace[2015266311] 'agreement among raft nodes before linearized reading' (duration: 141.362605ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:58:51.060172Z","caller":"traceutil/trace.go:171","msg":"trace[2034590214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5036; }","duration":"171.154894ms","start":"2026-04-20T04:58:50.888999Z","end":"2026-04-20T04:58:51.060154Z","steps":["trace[2034590214] 'agreement among raft nodes before linearized reading' (duration: 170.95864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:58:51.418008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.605017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a1dc9194-e244-4658-abe4-6e2376f7e7a9\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-20T04:58:51.418093Z","caller":"traceutil/trace.go:171","msg":"trace[472619382] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a1dc9194-e244-4658-abe4-6e2376f7e7a9; range_end:; response_count:1; response_revision:5040; }","duration":"130.74602ms","start":"2026-04-20T04:58:51.287328Z","end":"2026-04-20T04:58:51.418074Z","steps":["trace[472619382] 'range keys from in-memory index tree' (duration: 130.376151ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:58:51.535492Z","caller":"traceutil/trace.go:171","msg":"trace[608066717] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"112.485515ms","start":"2026-04-20T04:58:51.422969Z","end":"2026-04-20T04:58:51.535454Z","steps":["trace[608066717] 'process raft request' (duration: 98.098081ms)","trace[608066717] 'compare' (duration: 14.200679ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:58:51.535614Z","caller":"traceutil/trace.go:171","msg":"trace[1384370997] linearizableReadLoop","detail":"{readStateIndex:5237; appliedIndex:5234; }","duration":"106.177394ms","start":"2026-04-20T04:58:51.42942Z","end":"2026-04-20T04:58:51.535597Z","steps":["trace[1384370997] 'read index received' (duration: 41.342997ms)","trace[1384370997] 'applied index is now lower than readState.Index' (duration: 64.833807ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:58:51.535807Z","caller":"traceutil/trace.go:171","msg":"trace[618864087] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"110.095758ms","start":"2026-04-20T04:58:51.425703Z","end":"2026-04-20T04:58:51.535799Z","steps":["trace[618864087] 'process raft request' (duration: 109.812181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:58:51.536157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.565992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16654"} {"level":"info","ts":"2026-04-20T04:58:51.536217Z","caller":"traceutil/trace.go:171","msg":"trace[795584795] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5044; }","duration":"103.656014ms","start":"2026-04-20T04:58:51.432542Z","end":"2026-04-20T04:58:51.536198Z","steps":["trace[795584795] 'agreement among raft nodes before linearized reading' (duration: 103.427208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:58:51.536564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.076246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:58:51.536631Z","caller":"traceutil/trace.go:171","msg":"trace[458004868] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:5044; }","duration":"107.22867ms","start":"2026-04-20T04:58:51.429387Z","end":"2026-04-20T04:58:51.536616Z","steps":["trace[458004868] 'agreement among raft nodes before linearized reading' (duration: 107.059726ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:58:57.981118Z","caller":"traceutil/trace.go:171","msg":"trace[1697923245] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"118.057287ms","start":"2026-04-20T04:58:57.863017Z","end":"2026-04-20T04:58:57.981074Z","steps":["trace[1697923245] 'process raft request' (duration: 94.832124ms)","trace[1697923245] 'compare' (duration: 22.457215ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:59:01.1374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.214472ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:59:01.13757Z","caller":"traceutil/trace.go:171","msg":"trace[2082726437] transaction","detail":"{read_only:false; response_revision:5246; number_of_response:1; }","duration":"236.934075ms","start":"2026-04-20T04:59:00.9006Z","end":"2026-04-20T04:59:01.137534Z","steps":["trace[2082726437] 'compare' (duration: 226.309061ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:01.137682Z","caller":"traceutil/trace.go:171","msg":"trace[598447906] transaction","detail":"{read_only:false; response_revision:5247; number_of_response:1; }","duration":"110.687632ms","start":"2026-04-20T04:59:01.026976Z","end":"2026-04-20T04:59:01.137663Z","steps":["trace[598447906] 'process raft request' (duration: 110.559249ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:01.137878Z","caller":"traceutil/trace.go:171","msg":"trace[12577023] linearizableReadLoop","detail":"{readStateIndex:5445; appliedIndex:5444; }","duration":"189.064671ms","start":"2026-04-20T04:59:00.948756Z","end":"2026-04-20T04:59:01.137821Z","steps":["trace[12577023] 'read index received' (duration: 58.271µs)","trace[12577023] 'applied index is now lower than readState.Index' (duration: 188.839466ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:59:01.137983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.218835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" ","response":"range_response_count:12 size:4407"} {"level":"info","ts":"2026-04-20T04:59:01.138036Z","caller":"traceutil/trace.go:171","msg":"trace[147046153] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:12; response_revision:5247; }","duration":"189.260186ms","start":"2026-04-20T04:59:00.948744Z","end":"2026-04-20T04:59:01.138005Z","steps":["trace[147046153] 'agreement among raft nodes before linearized reading' (duration: 189.055261ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:01.138259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.157403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16654"} {"level":"info","ts":"2026-04-20T04:59:01.139202Z","caller":"traceutil/trace.go:171","msg":"trace[1432704572] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5247; }","duration":"190.111357ms","start":"2026-04-20T04:59:00.949071Z","end":"2026-04-20T04:59:01.139182Z","steps":["trace[1432704572] 'agreement among raft nodes before linearized reading' (duration: 188.913918ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:01.138738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.714443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" ","response":"range_response_count:43 size:291560"} {"level":"info","ts":"2026-04-20T04:59:01.13945Z","caller":"traceutil/trace.go:171","msg":"trace[1183740633] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:43; response_revision:5247; }","duration":"189.402721ms","start":"2026-04-20T04:59:00.949997Z","end":"2026-04-20T04:59:01.1394Z","steps":["trace[1183740633] 'agreement among raft nodes before linearized reading' (duration: 188.071088ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:09.506514Z","caller":"traceutil/trace.go:171","msg":"trace[741821256] transaction","detail":"{read_only:false; response_revision:5417; number_of_response:1; }","duration":"273.999398ms","start":"2026-04-20T04:59:09.232477Z","end":"2026-04-20T04:59:09.506477Z","steps":["trace[741821256] 'process raft request' (duration: 273.774802ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:09.544345Z","caller":"traceutil/trace.go:171","msg":"trace[596792360] transaction","detail":"{read_only:false; response_revision:5418; number_of_response:1; }","duration":"311.539935ms","start":"2026-04-20T04:59:09.232765Z","end":"2026-04-20T04:59:09.544305Z","steps":["trace[596792360] 'process raft request' (duration: 311.30549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:09.544526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:59:09.232741Z","time spent":"311.688298ms","remote":"127.0.0.1:35476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:59:11.862889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.944151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:59:11.862994Z","caller":"traceutil/trace.go:171","msg":"trace[753748371] linearizableReadLoop","detail":"{readStateIndex:5637; appliedIndex:5636; }","duration":"233.34058ms","start":"2026-04-20T04:59:11.629635Z","end":"2026-04-20T04:59:11.862976Z","steps":["trace[753748371] 'read index received' (duration: 98.212674ms)","trace[753748371] 'applied index is now lower than readState.Index' (duration: 135.126486ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:59:11.863036Z","caller":"traceutil/trace.go:171","msg":"trace[217823417] transaction","detail":"{read_only:false; response_revision:5436; number_of_response:1; }","duration":"255.498918ms","start":"2026-04-20T04:59:11.607501Z","end":"2026-04-20T04:59:11.863Z","steps":["trace[217823417] 'process raft request' (duration: 120.352502ms)","trace[217823417] 'compare' (duration: 134.675634ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:59:11.863179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.547834ms","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-04-20T04:59:11.863214Z","caller":"traceutil/trace.go:171","msg":"trace[1879394497] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5436; }","duration":"233.608446ms","start":"2026-04-20T04:59:11.629597Z","end":"2026-04-20T04:59:11.863205Z","steps":["trace[1879394497] 'agreement among raft nodes before linearized reading' (duration: 233.467663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:11.863465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.899496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-20T04:59:11.863572Z","caller":"traceutil/trace.go:171","msg":"trace[665256347] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5436; }","duration":"142.04503ms","start":"2026-04-20T04:59:11.721495Z","end":"2026-04-20T04:59:11.86354Z","steps":["trace[665256347] 'agreement among raft nodes before linearized reading' (duration: 141.817385ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:00:05.021355Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2906} {"level":"info","ts":"2026-04-20T05:00:05.093753Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2906,"took":"70.700112ms","hash":2854177905,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":33325056,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-20T05:00:05.09383Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2854177905,"revision":2906,"compact-revision":-1} {"level":"info","ts":"2026-04-20T05:05:05.026805Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5945} {"level":"info","ts":"2026-04-20T05:05:05.121268Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5945,"took":"93.09329ms","hash":699883488,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":21749760,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-20T05:05:05.121329Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":699883488,"revision":5945,"compact-revision":2906} {"level":"warn","ts":"2026-04-20T05:05:17.75374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.59393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:05:17.753837Z","caller":"traceutil/trace.go:171","msg":"trace[61949198] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:8262; }","duration":"362.745293ms","start":"2026-04-20T05:05:17.391073Z","end":"2026-04-20T05:05:17.753818Z","steps":["trace[61949198] 'count revisions from in-memory index tree' (duration: 362.455616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:17.753836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.263718ms","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-04-20T05:05:17.753941Z","caller":"traceutil/trace.go:171","msg":"trace[700714529] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8262; }","duration":"337.410582ms","start":"2026-04-20T05:05:17.416509Z","end":"2026-04-20T05:05:17.753919Z","steps":["trace[700714529] 'range keys from in-memory index tree' (duration: 336.957421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:17.753991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:17.416494Z","time spent":"337.486883ms","remote":"127.0.0.1:35476","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-04-20T05:05:17.754123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.934477ms","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-04-20T05:05:17.754175Z","caller":"traceutil/trace.go:171","msg":"trace[623541640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8262; }","duration":"355.030679ms","start":"2026-04-20T05:05:17.399131Z","end":"2026-04-20T05:05:17.754161Z","steps":["trace[623541640] 'range keys from in-memory index tree' (duration: 354.798895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:17.754136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:17.391051Z","time spent":"363.07033ms","remote":"127.0.0.1:59052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T05:05:17.754223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:17.399111Z","time spent":"355.087781ms","remote":"127.0.0.1:35476","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-04-20T05:05:17.754255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.829648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-20T05:05:17.754009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.388489ms","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-04-20T05:05:17.754521Z","caller":"traceutil/trace.go:171","msg":"trace[2103909606] linearizableReadLoop","detail":"{readStateIndex:8556; appliedIndex:8554; }","duration":"170.740544ms","start":"2026-04-20T05:05:17.583759Z","end":"2026-04-20T05:05:17.754499Z","steps":["trace[2103909606] 'read index received' (duration: 25.595648ms)","trace[2103909606] 'applied index is now lower than readState.Index' (duration: 145.143956ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:05:17.754544Z","caller":"traceutil/trace.go:171","msg":"trace[1757832627] transaction","detail":"{read_only:false; response_revision:8263; number_of_response:1; }","duration":"243.075461ms","start":"2026-04-20T05:05:17.51143Z","end":"2026-04-20T05:05:17.754506Z","steps":["trace[1757832627] 'process raft request' (duration: 97.910435ms)","trace[1757832627] 'compare' (duration: 144.575523ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:05:17.754601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.847046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:05:17.75464Z","caller":"traceutil/trace.go:171","msg":"trace[1509030321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8264; }","duration":"170.931918ms","start":"2026-04-20T05:05:17.583694Z","end":"2026-04-20T05:05:17.754626Z","steps":["trace[1509030321] 'agreement among raft nodes before linearized reading' (duration: 170.863967ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:05:17.754948Z","caller":"traceutil/trace.go:171","msg":"trace[947355516] transaction","detail":"{read_only:false; response_revision:8264; number_of_response:1; }","duration":"242.896218ms","start":"2026-04-20T05:05:17.512012Z","end":"2026-04-20T05:05:17.754908Z","steps":["trace[947355516] 'process raft request' (duration: 242.376806ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:05:17.754995Z","caller":"traceutil/trace.go:171","msg":"trace[55051472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8262; }","duration":"350.900011ms","start":"2026-04-20T05:05:17.403537Z","end":"2026-04-20T05:05:17.754437Z","steps":["trace[55051472] 'range keys from in-memory index tree' (duration: 350.170814ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:17.75506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:17.403516Z","time spent":"351.524106ms","remote":"127.0.0.1:35476","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-04-20T05:05:29.332762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.681557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T05:05:29.332816Z","caller":"traceutil/trace.go:171","msg":"trace[1796405437] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8328; }","duration":"118.78062ms","start":"2026-04-20T05:05:29.214023Z","end":"2026-04-20T05:05:29.332804Z","steps":["trace[1796405437] 'range keys from in-memory index tree' (duration: 118.555824ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:05:29.503248Z","caller":"traceutil/trace.go:171","msg":"trace[576048260] linearizableReadLoop","detail":"{readStateIndex:8625; appliedIndex:8624; }","duration":"104.780918ms","start":"2026-04-20T05:05:29.398441Z","end":"2026-04-20T05:05:29.503222Z","steps":["trace[576048260] 'read index received' (duration: 104.641865ms)","trace[576048260] 'applied index is now lower than readState.Index' (duration: 138.013µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:05:29.503347Z","caller":"traceutil/trace.go:171","msg":"trace[1492663031] transaction","detail":"{read_only:false; response_revision:8329; number_of_response:1; }","duration":"145.517075ms","start":"2026-04-20T05:05:29.357788Z","end":"2026-04-20T05:05:29.503305Z","steps":["trace[1492663031] 'process raft request' (duration: 145.275749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:29.503414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.959223ms","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-04-20T05:05:29.503451Z","caller":"traceutil/trace.go:171","msg":"trace[1504615318] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8329; }","duration":"105.049615ms","start":"2026-04-20T05:05:29.398391Z","end":"2026-04-20T05:05:29.503441Z","steps":["trace[1504615318] 'agreement among raft nodes before linearized reading' (duration: 104.969953ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:05:30.336422Z","caller":"traceutil/trace.go:171","msg":"trace[1976189013] linearizableReadLoop","detail":"{readStateIndex:8633; appliedIndex:8632; }","duration":"112.002659ms","start":"2026-04-20T05:05:30.224395Z","end":"2026-04-20T05:05:30.336398Z","steps":["trace[1976189013] 'read index received' (duration: 38.195857ms)","trace[1976189013] 'applied index is now lower than readState.Index' (duration: 73.805362ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:05:30.336497Z","caller":"traceutil/trace.go:171","msg":"trace[1373007877] transaction","detail":"{read_only:false; response_revision:8337; number_of_response:1; }","duration":"185.420462ms","start":"2026-04-20T05:05:30.151039Z","end":"2026-04-20T05:05:30.336459Z","steps":["trace[1373007877] 'process raft request' (duration: 111.60244ms)","trace[1373007877] 'compare' (duration: 73.632388ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:05:30.336621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.201423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-2v62b\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-20T05:05:30.336689Z","caller":"traceutil/trace.go:171","msg":"trace[674847739] range","detail":"{range_begin:/registry/pods/openstack/keepalived-2v62b; range_end:; response_count:1; response_revision:8337; }","duration":"112.323276ms","start":"2026-04-20T05:05:30.224349Z","end":"2026-04-20T05:05:30.336672Z","steps":["trace[674847739] 'agreement among raft nodes before linearized reading' (duration: 112.147722ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:05:58.279002Z","caller":"traceutil/trace.go:171","msg":"trace[918093795] linearizableReadLoop","detail":"{readStateIndex:8838; appliedIndex:8836; }","duration":"209.621047ms","start":"2026-04-20T05:05:58.069364Z","end":"2026-04-20T05:05:58.278985Z","steps":["trace[918093795] 'read index received' (duration: 4.18792ms)","trace[918093795] 'applied index is now lower than readState.Index' (duration: 205.432237ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:05:58.279085Z","caller":"traceutil/trace.go:171","msg":"trace[1664689863] transaction","detail":"{read_only:false; response_revision:8535; number_of_response:1; }","duration":"249.80205ms","start":"2026-04-20T05:05:58.029275Z","end":"2026-04-20T05:05:58.279078Z","steps":["trace[1664689863] 'process raft request' (duration: 249.36372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:58.279218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.842892ms","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-04-20T05:05:58.279241Z","caller":"traceutil/trace.go:171","msg":"trace[366913872] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8535; }","duration":"209.908724ms","start":"2026-04-20T05:05:58.069325Z","end":"2026-04-20T05:05:58.279234Z","steps":["trace[366913872] 'agreement among raft nodes before linearized reading' (duration: 209.823832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:58.280413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.690941ms","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-04-20T05:05:58.280443Z","caller":"traceutil/trace.go:171","msg":"trace[1872250743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8536; }","duration":"207.721091ms","start":"2026-04-20T05:05:58.072715Z","end":"2026-04-20T05:05:58.280436Z","steps":["trace[1872250743] 'agreement among raft nodes before linearized reading' (duration: 207.646499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:58.280476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.22574ms","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-04-20T05:05:58.280545Z","caller":"traceutil/trace.go:171","msg":"trace[429175458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8536; }","duration":"207.329192ms","start":"2026-04-20T05:05:58.073199Z","end":"2026-04-20T05:05:58.280529Z","steps":["trace[429175458] 'agreement among raft nodes before linearized reading' (duration: 207.148968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:58.280695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.108004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T05:05:58.280725Z","caller":"traceutil/trace.go:171","msg":"trace[1913558865] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:8536; }","duration":"107.165185ms","start":"2026-04-20T05:05:58.173554Z","end":"2026-04-20T05:05:58.280719Z","steps":["trace[1913558865] 'agreement among raft nodes before linearized reading' (duration: 107.082622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:58.280546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.293303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T05:05:58.281212Z","caller":"traceutil/trace.go:171","msg":"trace[2058049246] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8536; }","duration":"211.351879ms","start":"2026-04-20T05:05:58.069839Z","end":"2026-04-20T05:05:58.281191Z","steps":["trace[2058049246] 'agreement among raft nodes before linearized reading' (duration: 210.184431ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:02.207836Z","caller":"traceutil/trace.go:171","msg":"trace[91334809] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"124.109516ms","start":"2026-04-20T05:06:02.083703Z","end":"2026-04-20T05:06:02.207813Z","steps":["trace[91334809] 'process raft request' (duration: 123.953893ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:02.467832Z","caller":"traceutil/trace.go:171","msg":"trace[1766433023] linearizableReadLoop","detail":"{readStateIndex:8860; appliedIndex:8859; }","duration":"168.032809ms","start":"2026-04-20T05:06:02.299768Z","end":"2026-04-20T05:06:02.467801Z","steps":["trace[1766433023] 'read index received' (duration: 163.951493ms)","trace[1766433023] 'applied index is now lower than readState.Index' (duration: 4.079996ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:06:02.467877Z","caller":"traceutil/trace.go:171","msg":"trace[335821123] transaction","detail":"{read_only:false; response_revision:8556; number_of_response:1; }","duration":"175.26151ms","start":"2026-04-20T05:06:02.292596Z","end":"2026-04-20T05:06:02.467857Z","steps":["trace[335821123] 'process raft request' (duration: 171.155873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:02.468029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.244525ms","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-04-20T05:06:02.468095Z","caller":"traceutil/trace.go:171","msg":"trace[1659336661] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8556; }","duration":"168.354917ms","start":"2026-04-20T05:06:02.299725Z","end":"2026-04-20T05:06:02.46808Z","steps":["trace[1659336661] 'agreement among raft nodes before linearized reading' (duration: 168.195143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:02.476441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.187069ms","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-04-20T05:06:02.476474Z","caller":"traceutil/trace.go:171","msg":"trace[42284652] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8557; }","duration":"151.252151ms","start":"2026-04-20T05:06:02.325215Z","end":"2026-04-20T05:06:02.476467Z","steps":["trace[42284652] 'agreement among raft nodes before linearized reading' (duration: 151.096977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:02.476467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.687007ms","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-04-20T05:06:02.476539Z","caller":"traceutil/trace.go:171","msg":"trace[1428315483] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8557; }","duration":"174.780829ms","start":"2026-04-20T05:06:02.301739Z","end":"2026-04-20T05:06:02.47652Z","steps":["trace[1428315483] 'agreement among raft nodes before linearized reading' (duration: 174.566094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:02.476619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.064882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-20T05:06:02.476659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.813935ms","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-04-20T05:06:02.476708Z","caller":"traceutil/trace.go:171","msg":"trace[495666887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8557; }","duration":"171.194515ms","start":"2026-04-20T05:06:02.305491Z","end":"2026-04-20T05:06:02.476686Z","steps":["trace[495666887] 'agreement among raft nodes before linearized reading' (duration: 170.99097ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:02.476746Z","caller":"traceutil/trace.go:171","msg":"trace[1725031666] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8557; }","duration":"170.973629ms","start":"2026-04-20T05:06:02.305746Z","end":"2026-04-20T05:06:02.47672Z","steps":["trace[1725031666] 'agreement among raft nodes before linearized reading' (duration: 170.621751ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:12.315839Z","caller":"traceutil/trace.go:171","msg":"trace[1148367332] transaction","detail":"{read_only:false; response_revision:8652; number_of_response:1; }","duration":"108.411794ms","start":"2026-04-20T05:06:12.207408Z","end":"2026-04-20T05:06:12.31582Z","steps":["trace[1148367332] 'process raft request' (duration: 108.287122ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:12.350348Z","caller":"traceutil/trace.go:171","msg":"trace[682473096] transaction","detail":"{read_only:false; response_revision:8653; number_of_response:1; }","duration":"101.52936ms","start":"2026-04-20T05:06:12.24879Z","end":"2026-04-20T05:06:12.350319Z","steps":["trace[682473096] 'process raft request' (duration: 101.387637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:12.638636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.348508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-04-20T05:06:12.638717Z","caller":"traceutil/trace.go:171","msg":"trace[1697560142] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:8653; }","duration":"219.467331ms","start":"2026-04-20T05:06:12.41923Z","end":"2026-04-20T05:06:12.638697Z","steps":["trace[1697560142] 'range keys from in-memory index tree' (duration: 219.173453ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:12.638808Z","caller":"traceutil/trace.go:171","msg":"trace[508328386] transaction","detail":"{read_only:false; response_revision:8654; number_of_response:1; }","duration":"139.617765ms","start":"2026-04-20T05:06:12.499147Z","end":"2026-04-20T05:06:12.638765Z","steps":["trace[508328386] 'process raft request' (duration: 125.039909ms)","trace[508328386] 'compare' (duration: 14.460253ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:06:12.67503Z","caller":"traceutil/trace.go:171","msg":"trace[818717513] linearizableReadLoop","detail":"{readStateIndex:8965; appliedIndex:8963; }","duration":"100.994328ms","start":"2026-04-20T05:06:12.574012Z","end":"2026-04-20T05:06:12.675006Z","steps":["trace[818717513] 'read index received' (duration: 50.170121ms)","trace[818717513] 'applied index is now lower than readState.Index' (duration: 50.823267ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:06:12.675102Z","caller":"traceutil/trace.go:171","msg":"trace[1923650939] transaction","detail":"{read_only:false; response_revision:8655; number_of_response:1; }","duration":"166.750629ms","start":"2026-04-20T05:06:12.508313Z","end":"2026-04-20T05:06:12.675063Z","steps":["trace[1923650939] 'process raft request' (duration: 166.554425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:12.675217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.194732ms","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-04-20T05:06:12.675274Z","caller":"traceutil/trace.go:171","msg":"trace[2103527550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8655; }","duration":"101.289305ms","start":"2026-04-20T05:06:12.573972Z","end":"2026-04-20T05:06:12.675262Z","steps":["trace[2103527550] 'agreement among raft nodes before linearized reading' (duration: 101.132301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:12.675352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.552907ms","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-04-20T05:06:12.675429Z","caller":"traceutil/trace.go:171","msg":"trace[2054798741] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8655; }","duration":"100.6638ms","start":"2026-04-20T05:06:12.574744Z","end":"2026-04-20T05:06:12.675408Z","steps":["trace[2054798741] 'agreement among raft nodes before linearized reading' (duration: 100.447145ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:27.783901Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002395.wal"} {"level":"info","ts":"2026-04-20T05:08:02.351938Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3ba9ae53cc4335db","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T05:08:02.357017Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T05:08:02.357098Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T05:10:05.033892Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8061} {"level":"info","ts":"2026-04-20T05:10:05.097518Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8061,"took":"61.32022ms","hash":3875205824,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":28966912,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T05:10:05.09759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3875205824,"revision":8061,"compact-revision":5945} {"level":"info","ts":"2026-04-20T05:15:05.039592Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10582} {"level":"info","ts":"2026-04-20T05:15:05.120906Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10582,"took":"79.737398ms","hash":3316489052,"current-db-size-bytes":58040320,"current-db-size":"58 MB","current-db-size-in-use-bytes":21213184,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-20T05:15:05.120959Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3316489052,"revision":10582,"compact-revision":8061}