{"level":"warn","ts":"2026-07-25T04:17:30.586774Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T04:17:30.586844Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-07-25T04:17:30.586899Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-25T04:17:30.586906Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-25T04:17:30.58692Z","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-07-25T04:17:30.587516Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-07-25T04:17:30.587591Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-07-25T04:17:30.59352Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.226427ms"} {"level":"info","ts":"2026-07-25T04:17:30.609182Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-07-25T04:17:30.609281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-07-25T04:17:30.609305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-07-25T04:17:30.609319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-25T04:17:30.609332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-07-25T04:17:30.609384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-07-25T04:17:30.618718Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-25T04:17:30.62003Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-25T04:17:30.621633Z","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-07-25T04:17:30.623492Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-25T04:17:30.623641Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-25T04:17:30.623602Z","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-07-25T04:17:30.623864Z","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-07-25T04:17:30.623893Z","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-07-25T04:17:30.625849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-07-25T04:17:30.626127Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-07-25T04:17:30.627738Z","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-07-25T04:17:30.627799Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-25T04:17:30.627892Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-07-25T04:17:30.627968Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-25T04:17:30.627991Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-25T04:17:30.71036Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-07-25T04:17:30.710467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-07-25T04:17:30.710514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-07-25T04:17:30.710538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-07-25T04:17:30.710576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-25T04:17:30.710597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-07-25T04:17:30.710615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-07-25T04:17:30.711655Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-07-25T04:17:30.711706Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T04:17:30.711767Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-25T04:17:30.712288Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T04:17:30.713113Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-25T04:17:30.713182Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-25T04:17:30.715033Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-25T04:17:30.715227Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-07-25T04:17:30.715672Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T04:17:30.715771Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-25T04:17:30.715804Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-25T04:17:34.342162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.471535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:113"} {"level":"info","ts":"2026-07-25T04:17:34.342296Z","caller":"traceutil/trace.go:171","msg":"trace[810057851] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:233; }","duration":"254.713154ms","start":"2026-07-25T04:17:34.087555Z","end":"2026-07-25T04:17:34.342268Z","steps":["trace[810057851] 'range keys from in-memory index tree' (duration: 254.266177ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:17:35.908715Z","caller":"traceutil/trace.go:171","msg":"trace[177587886] linearizableReadLoop","detail":"{readStateIndex:283; appliedIndex:282; }","duration":"168.744965ms","start":"2026-07-25T04:17:35.739953Z","end":"2026-07-25T04:17:35.908698Z","steps":["trace[177587886] 'read index received' (duration: 168.658401ms)","trace[177587886] 'applied index is now lower than readState.Index' (duration: 85.833µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T04:17:35.908904Z","caller":"traceutil/trace.go:171","msg":"trace[1952961887] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"178.658822ms","start":"2026-07-25T04:17:35.730238Z","end":"2026-07-25T04:17:35.908896Z","steps":["trace[1952961887] 'process raft request' (duration: 178.34133ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:35.90906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.104918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T04:17:35.90909Z","caller":"traceutil/trace.go:171","msg":"trace[1643318213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:277; }","duration":"169.185972ms","start":"2026-07-25T04:17:35.739897Z","end":"2026-07-25T04:17:35.909083Z","steps":["trace[1643318213] 'agreement among raft nodes before linearized reading' (duration: 169.117399ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:17:36.211122Z","caller":"traceutil/trace.go:171","msg":"trace[939824195] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"318.60837ms","start":"2026-07-25T04:17:35.892498Z","end":"2026-07-25T04:17:36.211106Z","steps":["trace[939824195] 'process raft request' (duration: 242.570521ms)","trace[939824195] 'compare' (duration: 75.962376ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T04:17:36.21118Z","caller":"traceutil/trace.go:171","msg":"trace[1808390566] linearizableReadLoop","detail":"{readStateIndex:284; appliedIndex:283; }","duration":"302.365071ms","start":"2026-07-25T04:17:35.908771Z","end":"2026-07-25T04:17:36.211137Z","steps":["trace[1808390566] 'read index received' (duration: 226.369404ms)","trace[1808390566] 'applied index is now lower than readState.Index' (duration: 75.990187ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T04:17:36.211391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.058667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"warn","ts":"2026-07-25T04:17:36.211341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.934763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T04:17:36.211437Z","caller":"traceutil/trace.go:171","msg":"trace[1796383160] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:278; }","duration":"319.156931ms","start":"2026-07-25T04:17:35.89227Z","end":"2026-07-25T04:17:36.211427Z","steps":["trace[1796383160] 'agreement among raft nodes before linearized reading' (duration: 319.017006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.21145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:35.892479Z","time spent":"318.691254ms","remote":"127.0.0.1:39392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T04:17:36.211485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:35.892255Z","time spent":"319.222414ms","remote":"127.0.0.1:39706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-07-25T04:17:36.211492Z","caller":"traceutil/trace.go:171","msg":"trace[1475006335] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:278; }","duration":"319.12676ms","start":"2026-07-25T04:17:35.892323Z","end":"2026-07-25T04:17:36.21145Z","steps":["trace[1475006335] 'agreement among raft nodes before linearized reading' (duration: 318.831509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.211654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.190776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T04:17:36.211686Z","caller":"traceutil/trace.go:171","msg":"trace[648353956] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:278; }","duration":"411.238886ms","start":"2026-07-25T04:17:35.800435Z","end":"2026-07-25T04:17:36.211674Z","steps":["trace[648353956] 'agreement among raft nodes before linearized reading' (duration: 411.192705ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.211704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:35.800424Z","time spent":"411.276048ms","remote":"127.0.0.1:39774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"warn","ts":"2026-07-25T04:17:36.212258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:35.892309Z","time spent":"319.927969ms","remote":"127.0.0.1:39574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-07-25T04:17:36.406664Z","caller":"traceutil/trace.go:171","msg":"trace[1411966059] transaction","detail":"{read_only:false; number_of_response:0; response_revision:279; }","duration":"417.25075ms","start":"2026-07-25T04:17:35.989375Z","end":"2026-07-25T04:17:36.406626Z","steps":["trace[1411966059] 'process raft request' (duration: 417.144446ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:17:36.406839Z","caller":"traceutil/trace.go:171","msg":"trace[1152096068] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"191.145813ms","start":"2026-07-25T04:17:36.215683Z","end":"2026-07-25T04:17:36.406829Z","steps":["trace[1152096068] 'process raft request' (duration: 191.108252ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.406842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:35.989346Z","time spent":"417.416507ms","remote":"127.0.0.1:39484","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T04:17:36.406869Z","caller":"traceutil/trace.go:171","msg":"trace[204081165] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"395.304958ms","start":"2026-07-25T04:17:36.011509Z","end":"2026-07-25T04:17:36.406814Z","steps":["trace[204081165] 'process raft request' (duration: 395.121011ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:17:36.407059Z","caller":"traceutil/trace.go:171","msg":"trace[543353618] transaction","detail":"{read_only:false; number_of_response:0; response_revision:283; }","duration":"394.29588ms","start":"2026-07-25T04:17:36.01276Z","end":"2026-07-25T04:17:36.407055Z","steps":["trace[543353618] 'process raft request' (duration: 393.993559ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.407111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:36.012748Z","time spent":"394.323541ms","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T04:17:36.40668Z","caller":"traceutil/trace.go:171","msg":"trace[1159526145] transaction","detail":"{read_only:false; response_revision:279; number_of_response:1; }","duration":"494.323845ms","start":"2026-07-25T04:17:35.912328Z","end":"2026-07-25T04:17:36.406651Z","steps":["trace[1159526145] 'process raft request' (duration: 493.368179ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:17:36.407265Z","caller":"traceutil/trace.go:171","msg":"trace[2117609561] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"395.88112ms","start":"2026-07-25T04:17:36.011373Z","end":"2026-07-25T04:17:36.407254Z","steps":["trace[2117609561] 'process raft request' (duration: 395.230256ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.407379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:36.011366Z","time spent":"395.952503ms","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3953,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T04:17:36.407265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:36.011502Z","time spent":"395.580338ms","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T04:17:36.407232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.547091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T04:17:36.407606Z","caller":"traceutil/trace.go:171","msg":"trace[486366272] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:0; response_revision:284; }","duration":"495.891176ms","start":"2026-07-25T04:17:35.911652Z","end":"2026-07-25T04:17:36.407543Z","steps":["trace[486366272] 'agreement among raft nodes before linearized reading' (duration: 495.545603ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:17:36.407185Z","caller":"traceutil/trace.go:171","msg":"trace[1260002368] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"395.898721ms","start":"2026-07-25T04:17:36.011258Z","end":"2026-07-25T04:17:36.407157Z","steps":["trace[1260002368] 'process raft request' (duration: 395.296418ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:17:36.407188Z","caller":"traceutil/trace.go:171","msg":"trace[1792049946] linearizableReadLoop","detail":"{readStateIndex:291; appliedIndex:284; }","duration":"195.934235ms","start":"2026-07-25T04:17:36.211246Z","end":"2026-07-25T04:17:36.40718Z","steps":["trace[1792049946] 'read index received' (duration: 194.455979ms)","trace[1792049946] 'applied index is now lower than readState.Index' (duration: 1.477446ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T04:17:36.407628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:35.912319Z","time spent":"494.970139ms","remote":"127.0.0.1:39574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T04:17:36.407862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.417874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T04:17:36.407897Z","caller":"traceutil/trace.go:171","msg":"trace[735201807] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:284; }","duration":"191.489406ms","start":"2026-07-25T04:17:36.216399Z","end":"2026-07-25T04:17:36.407888Z","steps":["trace[735201807] 'agreement among raft nodes before linearized reading' (duration: 191.415133ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.4077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:36.011236Z","time spent":"396.43016ms","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5872,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-25T04:17:36.40704Z","caller":"traceutil/trace.go:171","msg":"trace[2016924799] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"394.536929ms","start":"2026-07-25T04:17:36.012499Z","end":"2026-07-25T04:17:36.407036Z","steps":["trace[2016924799] 'process raft request' (duration: 394.230677ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.408118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.418442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4015"} {"level":"warn","ts":"2026-07-25T04:17:36.408179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:35.911641Z","time spent":"496.527429ms","remote":"127.0.0.1:39514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" "} {"level":"info","ts":"2026-07-25T04:17:36.40823Z","caller":"traceutil/trace.go:171","msg":"trace[1514586714] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:284; }","duration":"192.520276ms","start":"2026-07-25T04:17:36.215663Z","end":"2026-07-25T04:17:36.408184Z","steps":["trace[1514586714] 'agreement among raft nodes before linearized reading' (duration: 192.325428ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:17:36.408286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:17:36.012453Z","time spent":"395.720934ms","remote":"127.0.0.1:39498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-25T04:17:36.407782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.550214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-25T04:17:36.408533Z","caller":"traceutil/trace.go:171","msg":"trace[1197531316] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:284; }","duration":"194.354335ms","start":"2026-07-25T04:17:36.21417Z","end":"2026-07-25T04:17:36.408525Z","steps":["trace[1197531316] 'agreement among raft nodes before linearized reading' (duration: 193.556246ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:18:08.908785Z","caller":"traceutil/trace.go:171","msg":"trace[1364627943] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"224.757689ms","start":"2026-07-25T04:18:08.684002Z","end":"2026-07-25T04:18:08.908759Z","steps":["trace[1364627943] 'process raft request' (duration: 216.104945ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:18:08.909054Z","caller":"traceutil/trace.go:171","msg":"trace[1526874304] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"204.155213ms","start":"2026-07-25T04:18:08.704876Z","end":"2026-07-25T04:18:08.909031Z","steps":["trace[1526874304] 'process raft request' (duration: 203.951617ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:18:08.909153Z","caller":"traceutil/trace.go:171","msg":"trace[1943606141] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"197.391194ms","start":"2026-07-25T04:18:08.711751Z","end":"2026-07-25T04:18:08.909142Z","steps":["trace[1943606141] 'process raft request' (duration: 197.220868ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:18:08.909247Z","caller":"traceutil/trace.go:171","msg":"trace[1603793715] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"171.859913ms","start":"2026-07-25T04:18:08.737363Z","end":"2026-07-25T04:18:08.909223Z","steps":["trace[1603793715] 'process raft request' (duration: 171.666888ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:18:15.00158Z","caller":"traceutil/trace.go:171","msg":"trace[866926265] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"376.365335ms","start":"2026-07-25T04:18:14.625184Z","end":"2026-07-25T04:18:15.001549Z","steps":["trace[866926265] 'process raft request' (duration: 376.149709ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:18:15.001555Z","caller":"traceutil/trace.go:171","msg":"trace[1981399468] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"374.861562ms","start":"2026-07-25T04:18:14.626662Z","end":"2026-07-25T04:18:15.001523Z","steps":["trace[1981399468] 'read index received' (duration: 374.746319ms)","trace[1981399468] 'applied index is now lower than readState.Index' (duration: 113.813µs)"],"step_count":2} {"level":"warn","ts":"2026-07-25T04:18:15.001884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.11311ms","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-07-25T04:18:15.001954Z","caller":"traceutil/trace.go:171","msg":"trace[2021387012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"375.336886ms","start":"2026-07-25T04:18:14.6266Z","end":"2026-07-25T04:18:15.001937Z","steps":["trace[2021387012] 'agreement among raft nodes before linearized reading' (duration: 375.021317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:18:15.001996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:18:14.626578Z","time spent":"375.406959ms","remote":"127.0.0.1:39574","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-07-25T04:18:15.002019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:18:14.62514Z","time spent":"376.514399ms","remote":"127.0.0.1:39574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T04:18:15.207385Z","caller":"traceutil/trace.go:171","msg":"trace[1307387199] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"205.563982ms","start":"2026-07-25T04:18:15.001788Z","end":"2026-07-25T04:18:15.207352Z","steps":["trace[1307387199] 'read index received' (duration: 198.701659ms)","trace[1307387199] 'applied index is now lower than readState.Index' (duration: 6.859322ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T04:18:15.20785Z","caller":"traceutil/trace.go:171","msg":"trace[619247851] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"545.155348ms","start":"2026-07-25T04:18:14.662424Z","end":"2026-07-25T04:18:15.207579Z","steps":["trace[619247851] 'process raft request' (duration: 538.627264ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:18:15.208266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:18:14.66238Z","time spent":"545.560399ms","remote":"127.0.0.1:39414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T04:18:15.208287Z","caller":"traceutil/trace.go:171","msg":"trace[1471564288] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"200.53093ms","start":"2026-07-25T04:18:15.007719Z","end":"2026-07-25T04:18:15.20825Z","steps":["trace[1471564288] 'process raft request' (duration: 199.979645ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:18:15.210024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.79636ms","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-07-25T04:18:15.210104Z","caller":"traceutil/trace.go:171","msg":"trace[1146988181] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"582.926094ms","start":"2026-07-25T04:18:14.627161Z","end":"2026-07-25T04:18:15.210087Z","steps":["trace[1146988181] 'agreement among raft nodes before linearized reading' (duration: 580.927447ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:18:15.210149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:18:14.627135Z","time spent":"583.003597ms","remote":"127.0.0.1:39574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-25T04:18:16.27801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.454519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T04:18:16.27819Z","caller":"traceutil/trace.go:171","msg":"trace[831477209] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"111.683686ms","start":"2026-07-25T04:18:16.166472Z","end":"2026-07-25T04:18:16.278155Z","steps":["trace[831477209] 'range keys from in-memory index tree' (duration: 111.358078ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:19:19.408794Z","caller":"traceutil/trace.go:171","msg":"trace[662106706] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"109.08397ms","start":"2026-07-25T04:19:19.299686Z","end":"2026-07-25T04:19:19.40877Z","steps":["trace[662106706] 'process raft request' (duration: 108.928318ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:19:24.694662Z","caller":"traceutil/trace.go:171","msg":"trace[484113980] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1117; }","duration":"191.154248ms","start":"2026-07-25T04:19:24.503487Z","end":"2026-07-25T04:19:24.694642Z","steps":["trace[484113980] 'read index received' (duration: 191.033336ms)","trace[484113980] 'applied index is now lower than readState.Index' (duration: 120.092µs)"],"step_count":2} {"level":"info","ts":"2026-07-25T04:19:24.694765Z","caller":"traceutil/trace.go:171","msg":"trace[562222441] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"209.263626ms","start":"2026-07-25T04:19:24.485467Z","end":"2026-07-25T04:19:24.69473Z","steps":["trace[562222441] 'process raft request' (duration: 209.026291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:19:24.69483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.326231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T04:19:24.694857Z","caller":"traceutil/trace.go:171","msg":"trace[238210320] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1076; }","duration":"191.399693ms","start":"2026-07-25T04:19:24.503449Z","end":"2026-07-25T04:19:24.694849Z","steps":["trace[238210320] 'agreement among raft nodes before linearized reading' (duration: 191.26685ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:19:29.660036Z","caller":"traceutil/trace.go:171","msg":"trace[987015461] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"104.174123ms","start":"2026-07-25T04:19:29.555841Z","end":"2026-07-25T04:19:29.660015Z","steps":["trace[987015461] 'process raft request' (duration: 104.027121ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:19:29.668133Z","caller":"traceutil/trace.go:171","msg":"trace[518695659] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"112.233022ms","start":"2026-07-25T04:19:29.555883Z","end":"2026-07-25T04:19:29.668116Z","steps":["trace[518695659] 'process raft request' (duration: 112.151311ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:19:57.177636Z","caller":"traceutil/trace.go:171","msg":"trace[368760525] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"145.504877ms","start":"2026-07-25T04:19:57.032074Z","end":"2026-07-25T04:19:57.177579Z","steps":["trace[368760525] 'process raft request' (duration: 145.243552ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:21:20.26208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.998218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-25T04:21:20.262201Z","caller":"traceutil/trace.go:171","msg":"trace[184198641] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1454; }","duration":"133.192653ms","start":"2026-07-25T04:21:20.128987Z","end":"2026-07-25T04:21:20.26218Z","steps":["trace[184198641] 'count revisions from in-memory index tree' (duration: 132.891165ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:21:20.817523Z","caller":"traceutil/trace.go:171","msg":"trace[1823809011] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"278.507934ms","start":"2026-07-25T04:21:20.538996Z","end":"2026-07-25T04:21:20.817503Z","steps":["trace[1823809011] 'process raft request' (duration: 278.387291ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:21:38.594435Z","caller":"traceutil/trace.go:171","msg":"trace[118372711] transaction","detail":"{read_only:false; response_revision:1515; number_of_response:1; }","duration":"183.586471ms","start":"2026-07-25T04:21:38.410825Z","end":"2026-07-25T04:21:38.594411Z","steps":["trace[118372711] 'process raft request' (duration: 183.438507ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:21:38.596732Z","caller":"traceutil/trace.go:171","msg":"trace[1673868233] linearizableReadLoop","detail":"{readStateIndex:1584; appliedIndex:1582; }","duration":"177.785957ms","start":"2026-07-25T04:21:38.418927Z","end":"2026-07-25T04:21:38.596713Z","steps":["trace[1673868233] 'read index received' (duration: 175.40385ms)","trace[1673868233] 'applied index is now lower than readState.Index' (duration: 2.380637ms)"],"step_count":2} {"level":"warn","ts":"2026-07-25T04:21:38.597148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.192539ms","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-07-25T04:21:38.597257Z","caller":"traceutil/trace.go:171","msg":"trace[278796578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1516; }","duration":"178.329642ms","start":"2026-07-25T04:21:38.418904Z","end":"2026-07-25T04:21:38.597234Z","steps":["trace[278796578] 'agreement among raft nodes before linearized reading' (duration: 177.89138ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:21:38.597755Z","caller":"traceutil/trace.go:171","msg":"trace[277056782] transaction","detail":"{read_only:false; response_revision:1516; number_of_response:1; }","duration":"184.747363ms","start":"2026-07-25T04:21:38.412979Z","end":"2026-07-25T04:21:38.597727Z","steps":["trace[277056782] 'process raft request' (duration: 183.651853ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:21:39.62573Z","caller":"traceutil/trace.go:171","msg":"trace[1077087321] transaction","detail":"{read_only:false; response_revision:1518; number_of_response:1; }","duration":"394.418703ms","start":"2026-07-25T04:21:39.231282Z","end":"2026-07-25T04:21:39.625701Z","steps":["trace[1077087321] 'process raft request' (duration: 394.240028ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:21:39.626201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-25T04:21:39.231248Z","time spent":"394.870174ms","remote":"127.0.0.1:39574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-25T04:26:46.238968Z","caller":"traceutil/trace.go:171","msg":"trace[1856676626] transaction","detail":"{read_only:false; response_revision:2526; number_of_response:1; }","duration":"115.673919ms","start":"2026-07-25T04:26:46.123272Z","end":"2026-07-25T04:26:46.238946Z","steps":["trace[1856676626] 'process raft request' (duration: 115.528864ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:26:46.249383Z","caller":"traceutil/trace.go:171","msg":"trace[660178113] linearizableReadLoop","detail":"{readStateIndex:2657; appliedIndex:2655; }","duration":"115.882394ms","start":"2026-07-25T04:26:46.133478Z","end":"2026-07-25T04:26:46.24936Z","steps":["trace[660178113] 'read index received' (duration: 105.389757ms)","trace[660178113] 'applied index is now lower than readState.Index' (duration: 10.489457ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T04:26:46.249441Z","caller":"traceutil/trace.go:171","msg":"trace[1698626018] transaction","detail":"{read_only:false; response_revision:2527; number_of_response:1; }","duration":"125.58205ms","start":"2026-07-25T04:26:46.123846Z","end":"2026-07-25T04:26:46.249428Z","steps":["trace[1698626018] 'process raft request' (duration: 125.380374ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:26:46.249632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.129911ms","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-07-25T04:26:46.249694Z","caller":"traceutil/trace.go:171","msg":"trace[1585088593] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2527; }","duration":"116.215563ms","start":"2026-07-25T04:26:46.133462Z","end":"2026-07-25T04:26:46.249678Z","steps":["trace[1585088593] 'agreement among raft nodes before linearized reading' (duration: 115.985427ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:26:46.353503Z","caller":"traceutil/trace.go:171","msg":"trace[804096757] transaction","detail":"{read_only:false; response_revision:2528; number_of_response:1; }","duration":"100.268315ms","start":"2026-07-25T04:26:46.253215Z","end":"2026-07-25T04:26:46.353483Z","steps":["trace[804096757] 'process raft request' (duration: 98.168238ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:27:03.000533Z","caller":"traceutil/trace.go:171","msg":"trace[165471703] transaction","detail":"{read_only:false; response_revision:2633; number_of_response:1; }","duration":"208.643216ms","start":"2026-07-25T04:27:02.791871Z","end":"2026-07-25T04:27:03.000514Z","steps":["trace[165471703] 'process raft request' (duration: 208.522563ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:27:22.61712Z","caller":"traceutil/trace.go:171","msg":"trace[359755026] linearizableReadLoop","detail":"{readStateIndex:2844; appliedIndex:2843; }","duration":"107.426989ms","start":"2026-07-25T04:27:22.509668Z","end":"2026-07-25T04:27:22.617095Z","steps":["trace[359755026] 'read index received' (duration: 102.661537ms)","trace[359755026] 'applied index is now lower than readState.Index' (duration: 4.764252ms)"],"step_count":2} {"level":"info","ts":"2026-07-25T04:27:22.617196Z","caller":"traceutil/trace.go:171","msg":"trace[335905703] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"204.160362ms","start":"2026-07-25T04:27:22.413007Z","end":"2026-07-25T04:27:22.617167Z","steps":["trace[335905703] 'process raft request' (duration: 199.298727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-25T04:27:22.617279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.586593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-25T04:27:22.617313Z","caller":"traceutil/trace.go:171","msg":"trace[820247794] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2705; }","duration":"107.669776ms","start":"2026-07-25T04:27:22.509634Z","end":"2026-07-25T04:27:22.617304Z","steps":["trace[820247794] 'agreement among raft nodes before linearized reading' (duration: 107.585334ms)"],"step_count":1} {"level":"info","ts":"2026-07-25T04:27:31.176627Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1689} {"level":"info","ts":"2026-07-25T04:27:31.216275Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":1689,"took":"38.937936ms","hash":1928328998,"current-db-size-bytes":23433216,"current-db-size":"23 MB","current-db-size-in-use-bytes":6049792,"current-db-size-in-use":"6.0 MB"} {"level":"info","ts":"2026-07-25T04:27:31.216346Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1928328998,"revision":1689,"compact-revision":-1} {"level":"info","ts":"2026-07-25T04:32:31.182151Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2735} {"level":"info","ts":"2026-07-25T04:32:31.203823Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2735,"took":"21.081769ms","hash":1075599494,"current-db-size-bytes":23433216,"current-db-size":"23 MB","current-db-size-in-use-bytes":6590464,"current-db-size-in-use":"6.6 MB"} {"level":"info","ts":"2026-07-25T04:32:31.203892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1075599494,"revision":2735,"compact-revision":1689}