{"level":"warn","ts":"2026-07-17T07:25:17.044864Z","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-17T07:25:17.04502Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-17T07:25:17.046736Z","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-17T07:25:17.046761Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-07-17T07:25:17.04865Z","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-17T07:25:17.05074Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-07-17T07:25:17.050846Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-17T07:25:17.057642Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.496658ms"} {"level":"info","ts":"2026-07-17T07:25:17.065354Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-07-17T07:25:17.065462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-07-17T07:25:17.065501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-07-17T07:25:17.065523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-17T07:25:17.065548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-07-17T07:25:17.065599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-07-17T07:25:17.073796Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-17T07:25:17.075883Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-17T07:25:17.08111Z","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-17T07:25:17.084435Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-17T07:25:17.084698Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-17T07:25:17.084788Z","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-17T07:25:17.088696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-07-17T07:25:17.088925Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-07-17T07:25:17.095564Z","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-17T07:25:17.095624Z","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-17T07:25:17.097705Z","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-17T07:25:17.097791Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-07-17T07:25:17.097897Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-07-17T07:25:17.09802Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-17T07:25:17.098071Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-17T07:25:18.066094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-07-17T07:25:18.066154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-07-17T07:25:18.066195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-07-17T07:25:18.066331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-07-17T07:25:18.066357Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-07-17T07:25:18.066375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-07-17T07:25:18.066492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-07-17T07:25:18.067475Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-07-17T07:25:18.067525Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T07:25:18.067483Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T07:25:18.067523Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-17T07:25:18.068037Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-17T07:25:18.068071Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-17T07:25:18.068547Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T07:25:18.068655Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T07:25:18.06869Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-17T07:25:18.070911Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-17T07:25:18.07318Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-07-17T07:25:52.658254Z","caller":"traceutil/trace.go:171","msg":"trace[150784895] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"219.240119ms","start":"2026-07-17T07:25:52.4387Z","end":"2026-07-17T07:25:52.65794Z","steps":["trace[150784895] 'process raft request' (duration: 219.110436ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.664894Z","caller":"traceutil/trace.go:171","msg":"trace[458461446] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"216.995981ms","start":"2026-07-17T07:25:52.447884Z","end":"2026-07-17T07:25:52.66488Z","steps":["trace[458461446] 'process raft request' (duration: 216.460932ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.666098Z","caller":"traceutil/trace.go:171","msg":"trace[1813313540] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"212.015687ms","start":"2026-07-17T07:25:52.453687Z","end":"2026-07-17T07:25:52.665702Z","steps":["trace[1813313540] 'process raft request' (duration: 211.704192ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.668851Z","caller":"traceutil/trace.go:171","msg":"trace[2060647244] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"213.238078ms","start":"2026-07-17T07:25:52.455587Z","end":"2026-07-17T07:25:52.668825Z","steps":["trace[2060647244] 'process raft request' (duration: 210.027034ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.671969Z","caller":"traceutil/trace.go:171","msg":"trace[942909638] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"209.72099ms","start":"2026-07-17T07:25:52.460084Z","end":"2026-07-17T07:25:52.669805Z","steps":["trace[942909638] 'process raft request' (duration: 208.424558ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.673904Z","caller":"traceutil/trace.go:171","msg":"trace[978887996] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"211.939786ms","start":"2026-07-17T07:25:52.461947Z","end":"2026-07-17T07:25:52.673887Z","steps":["trace[978887996] 'process raft request' (duration: 211.398057ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.67413Z","caller":"traceutil/trace.go:171","msg":"trace[1020946939] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"209.7718ms","start":"2026-07-17T07:25:52.464344Z","end":"2026-07-17T07:25:52.674116Z","steps":["trace[1020946939] 'process raft request' (duration: 209.112799ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.674218Z","caller":"traceutil/trace.go:171","msg":"trace[1055519643] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"204.013824ms","start":"2026-07-17T07:25:52.470198Z","end":"2026-07-17T07:25:52.674212Z","steps":["trace[1055519643] 'process raft request' (duration: 203.873831ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.673747Z","caller":"traceutil/trace.go:171","msg":"trace[968500749] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"208.097263ms","start":"2026-07-17T07:25:52.461697Z","end":"2026-07-17T07:25:52.669795Z","steps":["trace[968500749] 'process raft request' (duration: 208.019411ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.674347Z","caller":"traceutil/trace.go:171","msg":"trace[855326628] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"200.270471ms","start":"2026-07-17T07:25:52.47407Z","end":"2026-07-17T07:25:52.674341Z","steps":["trace[855326628] 'process raft request' (duration: 200.059507ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:52.674597Z","caller":"traceutil/trace.go:171","msg":"trace[1463076885] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"182.681733ms","start":"2026-07-17T07:25:52.491891Z","end":"2026-07-17T07:25:52.674573Z","steps":["trace[1463076885] 'process raft request' (duration: 182.553131ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:58.579404Z","caller":"traceutil/trace.go:171","msg":"trace[946482900] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"156.877731ms","start":"2026-07-17T07:25:58.422505Z","end":"2026-07-17T07:25:58.579383Z","steps":["trace[946482900] 'read index received' (duration: 156.320201ms)","trace[946482900] 'applied index is now lower than readState.Index' (duration: 556.85µs)"],"step_count":2} {"level":"info","ts":"2026-07-17T07:25:58.579488Z","caller":"traceutil/trace.go:171","msg":"trace[413869483] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"160.824076ms","start":"2026-07-17T07:25:58.418631Z","end":"2026-07-17T07:25:58.579455Z","steps":["trace[413869483] 'process raft request' (duration: 160.298697ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:25:58.579595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.051563ms","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-07-17T07:25:58.579644Z","caller":"traceutil/trace.go:171","msg":"trace[1974847621] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"157.157475ms","start":"2026-07-17T07:25:58.422479Z","end":"2026-07-17T07:25:58.579637Z","steps":["trace[1974847621] 'agreement among raft nodes before linearized reading' (duration: 156.985752ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:25:58.819141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.560653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-17T07:25:58.819273Z","caller":"traceutil/trace.go:171","msg":"trace[2087803646] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"233.123755ms","start":"2026-07-17T07:25:58.58613Z","end":"2026-07-17T07:25:58.819253Z","steps":["trace[2087803646] 'process raft request' (duration: 121.924091ms)","trace[2087803646] 'compare' (duration: 110.452331ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T07:25:58.821929Z","caller":"traceutil/trace.go:171","msg":"trace[1797200180] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"191.460863ms","start":"2026-07-17T07:25:58.630441Z","end":"2026-07-17T07:25:58.821901Z","steps":["trace[1797200180] 'process raft request' (duration: 191.26167ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:25:59.036611Z","caller":"traceutil/trace.go:171","msg":"trace[1926310220] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"107.176575ms","start":"2026-07-17T07:25:58.929417Z","end":"2026-07-17T07:25:59.036593Z","steps":["trace[1926310220] 'read index received' (duration: 86.513523ms)","trace[1926310220] 'applied index is now lower than readState.Index' (duration: 20.662222ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T07:25:59.036734Z","caller":"traceutil/trace.go:171","msg":"trace[309013032] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"121.666406ms","start":"2026-07-17T07:25:58.915033Z","end":"2026-07-17T07:25:59.0367Z","steps":["trace[309013032] 'process raft request' (duration: 100.974264ms)","trace[309013032] 'compare' (duration: 20.481568ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T07:25:59.036765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.338878ms","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-07-17T07:25:59.036825Z","caller":"traceutil/trace.go:171","msg":"trace[495743106] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"107.45247ms","start":"2026-07-17T07:25:58.929365Z","end":"2026-07-17T07:25:59.036817Z","steps":["trace[495743106] 'agreement among raft nodes before linearized reading' (duration: 107.298738ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:25:59.613958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:25:59.235063Z","time spent":"378.888416ms","remote":"127.0.0.1:38722","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-17T07:25:59.642483Z","caller":"traceutil/trace.go:171","msg":"trace[966843032] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:658; }","duration":"341.261545ms","start":"2026-07-17T07:25:59.301187Z","end":"2026-07-17T07:25:59.642449Z","steps":["trace[966843032] 'read index received' (duration: 340.526843ms)","trace[966843032] 'applied index is now lower than readState.Index' (duration: 733.622µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T07:25:59.642607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.401467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T07:25:59.642643Z","caller":"traceutil/trace.go:171","msg":"trace[2042452373] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"341.491619ms","start":"2026-07-17T07:25:59.301142Z","end":"2026-07-17T07:25:59.642633Z","steps":["trace[2042452373] 'agreement among raft nodes before linearized reading' (duration: 341.411577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:25:59.642682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:25:59.301122Z","time spent":"341.55259ms","remote":"127.0.0.1:50672","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-17T07:25:59.642968Z","caller":"traceutil/trace.go:171","msg":"trace[216296429] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"408.845733ms","start":"2026-07-17T07:25:59.234111Z","end":"2026-07-17T07:25:59.642957Z","steps":["trace[216296429] 'process raft request' (duration: 407.827635ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:25:59.643062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:25:59.234079Z","time spent":"408.922613ms","remote":"127.0.0.1:50786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T07:26:01.158687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.079494ms","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-07-17T07:26:01.158945Z","caller":"traceutil/trace.go:171","msg":"trace[1462538495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:673; }","duration":"107.374758ms","start":"2026-07-17T07:26:01.05155Z","end":"2026-07-17T07:26:01.158925Z","steps":["trace[1462538495] 'range keys from in-memory index tree' (duration: 106.84168ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:26:13.355031Z","caller":"traceutil/trace.go:171","msg":"trace[1724849246] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"129.673478ms","start":"2026-07-17T07:26:13.225335Z","end":"2026-07-17T07:26:13.355009Z","steps":["trace[1724849246] 'process raft request' (duration: 129.572896ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:26:13.578026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.221396ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T07:26:13.578192Z","caller":"traceutil/trace.go:171","msg":"trace[569207309] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:789; }","duration":"133.391171ms","start":"2026-07-17T07:26:13.444768Z","end":"2026-07-17T07:26:13.578159Z","steps":["trace[569207309] 'range keys from in-memory index tree' (duration: 133.202086ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:27:28.72699Z","caller":"traceutil/trace.go:171","msg":"trace[1398652437] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"370.049396ms","start":"2026-07-17T07:27:28.356915Z","end":"2026-07-17T07:27:28.726964Z","steps":["trace[1398652437] 'process raft request' (duration: 369.867912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:27:28.727227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:27:28.356893Z","time spent":"370.251421ms","remote":"127.0.0.1:50868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10966,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T07:27:28.727389Z","caller":"traceutil/trace.go:171","msg":"trace[1842916097] linearizableReadLoop","detail":"{readStateIndex:1940; appliedIndex:1939; }","duration":"353.829921ms","start":"2026-07-17T07:27:28.373076Z","end":"2026-07-17T07:27:28.726906Z","steps":["trace[1842916097] 'read index received' (duration: 353.643848ms)","trace[1842916097] 'applied index is now lower than readState.Index' (duration: 185.233µs)"],"step_count":2} {"level":"warn","ts":"2026-07-17T07:27:28.727778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.021415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a5164b01-4f30-4bcb-bda4-03df2470d137\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-17T07:27:28.727851Z","caller":"traceutil/trace.go:171","msg":"trace[124975275] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a5164b01-4f30-4bcb-bda4-03df2470d137; range_end:; response_count:1; response_revision:1866; }","duration":"195.143827ms","start":"2026-07-17T07:27:28.53269Z","end":"2026-07-17T07:27:28.727834Z","steps":["trace[124975275] 'agreement among raft nodes before linearized reading' (duration: 194.905382ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:27:28.728262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.191135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T07:27:28.72829Z","caller":"traceutil/trace.go:171","msg":"trace[1051887100] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1866; }","duration":"170.247057ms","start":"2026-07-17T07:27:28.558036Z","end":"2026-07-17T07:27:28.728283Z","steps":["trace[1051887100] 'agreement among raft nodes before linearized reading' (duration: 170.201947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:27:28.728716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.472693ms","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-07-17T07:27:28.728899Z","caller":"traceutil/trace.go:171","msg":"trace[1711961370] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1866; }","duration":"355.850493ms","start":"2026-07-17T07:27:28.373024Z","end":"2026-07-17T07:27:28.728875Z","steps":["trace[1711961370] 'agreement among raft nodes before linearized reading' (duration: 354.069107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:27:28.728968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:27:28.373006Z","time spent":"355.947274ms","remote":"127.0.0.1:50932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-17T07:27:28.840862Z","caller":"traceutil/trace.go:171","msg":"trace[1112525159] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"106.984806ms","start":"2026-07-17T07:27:28.733846Z","end":"2026-07-17T07:27:28.840831Z","steps":["trace[1112525159] 'process raft request' (duration: 106.67574ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:27:28.841002Z","caller":"traceutil/trace.go:171","msg":"trace[98553022] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"102.13099ms","start":"2026-07-17T07:27:28.738837Z","end":"2026-07-17T07:27:28.840968Z","steps":["trace[98553022] 'process raft request' (duration: 101.866345ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:27:28.841055Z","caller":"traceutil/trace.go:171","msg":"trace[2040752268] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"102.121469ms","start":"2026-07-17T07:27:28.73892Z","end":"2026-07-17T07:27:28.841041Z","steps":["trace[2040752268] 'process raft request' (duration: 101.944135ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:27:28.841056Z","caller":"traceutil/trace.go:171","msg":"trace[105146459] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"101.797892ms","start":"2026-07-17T07:27:28.739232Z","end":"2026-07-17T07:27:28.84103Z","steps":["trace[105146459] 'process raft request' (duration: 101.739131ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:27:28.841226Z","caller":"traceutil/trace.go:171","msg":"trace[1476161524] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"102.14285ms","start":"2026-07-17T07:27:28.739074Z","end":"2026-07-17T07:27:28.841217Z","steps":["trace[1476161524] 'process raft request' (duration: 101.851904ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:27:28.912341Z","caller":"traceutil/trace.go:171","msg":"trace[1090484032] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"167.526503ms","start":"2026-07-17T07:27:28.744786Z","end":"2026-07-17T07:27:28.912312Z","steps":["trace[1090484032] 'process raft request' (duration: 167.356519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:27:29.178494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.435596ms","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-17T07:27:29.179155Z","caller":"traceutil/trace.go:171","msg":"trace[2102800009] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1873; }","duration":"227.16799ms","start":"2026-07-17T07:27:28.95195Z","end":"2026-07-17T07:27:29.179118Z","steps":["trace[2102800009] 'count revisions from in-memory index tree' (duration: 226.327024ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:27:34.606216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.063907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-07-17T07:27:34.606306Z","caller":"traceutil/trace.go:171","msg":"trace[825495186] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1934; }","duration":"109.191529ms","start":"2026-07-17T07:27:34.497089Z","end":"2026-07-17T07:27:34.606281Z","steps":["trace[825495186] 'range keys from in-memory index tree' (duration: 108.858513ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:27:40.209088Z","caller":"traceutil/trace.go:171","msg":"trace[794315774] transaction","detail":"{read_only:false; response_revision:1969; number_of_response:1; }","duration":"217.753508ms","start":"2026-07-17T07:27:39.991308Z","end":"2026-07-17T07:27:40.209062Z","steps":["trace[794315774] 'process raft request' (duration: 166.968847ms)","trace[794315774] 'compare' (duration: 50.240591ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T07:28:03.25186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.277808ms","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-07-17T07:28:03.251967Z","caller":"traceutil/trace.go:171","msg":"trace[1117880826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2108; }","duration":"249.42831ms","start":"2026-07-17T07:28:03.00252Z","end":"2026-07-17T07:28:03.251948Z","steps":["trace[1117880826] 'range keys from in-memory index tree' (duration: 249.042914ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:28:03.681843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.009539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-17T07:28:03.681843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.784745ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-17T07:28:03.681894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.352098ms","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-07-17T07:28:03.681951Z","caller":"traceutil/trace.go:171","msg":"trace[1661471760] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2109; }","duration":"236.907777ms","start":"2026-07-17T07:28:03.445028Z","end":"2026-07-17T07:28:03.681936Z","steps":["trace[1661471760] 'range keys from in-memory index tree' (duration: 236.766525ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:28:03.681947Z","caller":"traceutil/trace.go:171","msg":"trace[96102561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2109; }","duration":"328.157411ms","start":"2026-07-17T07:28:03.353764Z","end":"2026-07-17T07:28:03.681921Z","steps":["trace[96102561] 'range keys from in-memory index tree' (duration: 327.827705ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:28:03.681973Z","caller":"traceutil/trace.go:171","msg":"trace[391744899] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2109; }","duration":"326.48063ms","start":"2026-07-17T07:28:03.355475Z","end":"2026-07-17T07:28:03.681955Z","steps":["trace[391744899] 'range keys from in-memory index tree' (duration: 326.179665ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:28:03.681984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.311089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-07-17T07:28:03.682019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:28:03.355454Z","time spent":"326.554471ms","remote":"127.0.0.1:50932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-07-17T07:28:03.682057Z","caller":"traceutil/trace.go:171","msg":"trace[1415983563] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2109; }","duration":"180.429801ms","start":"2026-07-17T07:28:03.501608Z","end":"2026-07-17T07:28:03.682038Z","steps":["trace[1415983563] 'range keys from in-memory index tree' (duration: 180.155226ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:28:03.682022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:28:03.353747Z","time spent":"328.259253ms","remote":"127.0.0.1:50932","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":"info","ts":"2026-07-17T07:28:03.864337Z","caller":"traceutil/trace.go:171","msg":"trace[933907518] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"249.635685ms","start":"2026-07-17T07:28:03.614661Z","end":"2026-07-17T07:28:03.864297Z","steps":["trace[933907518] 'process raft request' (duration: 249.479592ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:28:04.01276Z","caller":"traceutil/trace.go:171","msg":"trace[1113582466] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"326.119524ms","start":"2026-07-17T07:28:03.686611Z","end":"2026-07-17T07:28:04.01273Z","steps":["trace[1113582466] 'process raft request' (duration: 318.004943ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:28:04.012773Z","caller":"traceutil/trace.go:171","msg":"trace[1986382264] linearizableReadLoop","detail":"{readStateIndex:2194; appliedIndex:2191; }","duration":"181.587644ms","start":"2026-07-17T07:28:03.831165Z","end":"2026-07-17T07:28:04.012753Z","steps":["trace[1986382264] 'read index received' (duration: 32.956026ms)","trace[1986382264] 'applied index is now lower than readState.Index' (duration: 148.630808ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T07:28:04.012847Z","caller":"traceutil/trace.go:171","msg":"trace[905166141] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"325.90402ms","start":"2026-07-17T07:28:03.686906Z","end":"2026-07-17T07:28:04.01281Z","steps":["trace[905166141] 'process raft request' (duration: 325.560343ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:28:04.013117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:28:03.686587Z","time spent":"326.264147ms","remote":"127.0.0.1:50932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-17T07:28:04.013163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-17T07:28:03.686894Z","time spent":"326.029852ms","remote":"127.0.0.1:50932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-17T07:28:04.013264Z","caller":"traceutil/trace.go:171","msg":"trace[1972169225] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"111.229898ms","start":"2026-07-17T07:28:03.901867Z","end":"2026-07-17T07:28:04.013097Z","steps":["trace[1972169225] 'process raft request' (duration: 110.835991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:28:04.013724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.373245ms","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-07-17T07:28:04.014546Z","caller":"traceutil/trace.go:171","msg":"trace[2145986948] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2113; }","duration":"147.239691ms","start":"2026-07-17T07:28:03.867282Z","end":"2026-07-17T07:28:04.014522Z","steps":["trace[2145986948] 'agreement among raft nodes before linearized reading' (duration: 145.851805ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:28:04.012957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.756376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-17T07:28:04.014795Z","caller":"traceutil/trace.go:171","msg":"trace[514449399] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2112; }","duration":"183.666291ms","start":"2026-07-17T07:28:03.831114Z","end":"2026-07-17T07:28:04.014781Z","steps":["trace[514449399] 'agreement among raft nodes before linearized reading' (duration: 181.760186ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:28:04.244279Z","caller":"traceutil/trace.go:171","msg":"trace[1556709326] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"190.422993ms","start":"2026-07-17T07:28:04.05383Z","end":"2026-07-17T07:28:04.244253Z","steps":["trace[1556709326] 'process raft request' (duration: 185.791626ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:29:40.28717Z","caller":"traceutil/trace.go:171","msg":"trace[100074973] transaction","detail":"{read_only:false; response_revision:2737; number_of_response:1; }","duration":"103.099804ms","start":"2026-07-17T07:29:40.184046Z","end":"2026-07-17T07:29:40.287146Z","steps":["trace[100074973] 'process raft request' (duration: 102.968772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:33:17.899797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.188225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2b85b376-d052-45e0-a9b9-5ed3b35affe3\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-07-17T07:33:17.899889Z","caller":"traceutil/trace.go:171","msg":"trace[1146016550] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2b85b376-d052-45e0-a9b9-5ed3b35affe3; range_end:; response_count:1; response_revision:4515; }","duration":"100.332757ms","start":"2026-07-17T07:33:17.799537Z","end":"2026-07-17T07:33:17.899869Z","steps":["trace[1146016550] 'range keys from in-memory index tree' (duration: 99.942861ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:33:25.00446Z","caller":"traceutil/trace.go:171","msg":"trace[1420647635] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"136.274031ms","start":"2026-07-17T07:33:24.868158Z","end":"2026-07-17T07:33:25.004432Z","steps":["trace[1420647635] 'process raft request' (duration: 136.070898ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:33:25.150954Z","caller":"traceutil/trace.go:171","msg":"trace[1101659249] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"107.595719ms","start":"2026-07-17T07:33:25.043334Z","end":"2026-07-17T07:33:25.15093Z","steps":["trace[1101659249] 'process raft request' (duration: 92.851751ms)","trace[1101659249] 'compare' (duration: 14.578075ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T07:33:25.162109Z","caller":"traceutil/trace.go:171","msg":"trace[1469154123] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"114.335462ms","start":"2026-07-17T07:33:25.047755Z","end":"2026-07-17T07:33:25.162091Z","steps":["trace[1469154123] 'process raft request' (duration: 114.18121ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:33:25.595161Z","caller":"traceutil/trace.go:171","msg":"trace[59105115] transaction","detail":"{read_only:false; response_revision:4698; number_of_response:1; }","duration":"169.768216ms","start":"2026-07-17T07:33:25.425367Z","end":"2026-07-17T07:33:25.595135Z","steps":["trace[59105115] 'process raft request' (duration: 169.592942ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:33:25.601569Z","caller":"traceutil/trace.go:171","msg":"trace[381172732] linearizableReadLoop","detail":"{readStateIndex:4879; appliedIndex:4877; }","duration":"107.998446ms","start":"2026-07-17T07:33:25.493546Z","end":"2026-07-17T07:33:25.601545Z","steps":["trace[381172732] 'read index received' (duration: 101.508177ms)","trace[381172732] 'applied index is now lower than readState.Index' (duration: 6.489279ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T07:33:25.601608Z","caller":"traceutil/trace.go:171","msg":"trace[1835856609] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"175.694355ms","start":"2026-07-17T07:33:25.425895Z","end":"2026-07-17T07:33:25.60159Z","steps":["trace[1835856609] 'process raft request' (duration: 175.499182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:33:25.601914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.40728ms","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-17T07:33:25.602003Z","caller":"traceutil/trace.go:171","msg":"trace[380119031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4699; }","duration":"106.558402ms","start":"2026-07-17T07:33:25.495427Z","end":"2026-07-17T07:33:25.601985Z","steps":["trace[380119031] 'agreement among raft nodes before linearized reading' (duration: 106.303758ms)"],"step_count":1} {"level":"warn","ts":"2026-07-17T07:33:25.602171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.565486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-17T07:33:25.602416Z","caller":"traceutil/trace.go:171","msg":"trace[1471657465] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4699; }","duration":"108.701707ms","start":"2026-07-17T07:33:25.493512Z","end":"2026-07-17T07:33:25.602214Z","steps":["trace[1471657465] 'agreement among raft nodes before linearized reading' (duration: 108.155208ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:33:38.652115Z","caller":"traceutil/trace.go:171","msg":"trace[1682337443] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"247.618353ms","start":"2026-07-17T07:33:38.404465Z","end":"2026-07-17T07:33:38.652083Z","steps":["trace[1682337443] 'process raft request' (duration: 230.465185ms)","trace[1682337443] 'compare' (duration: 16.715821ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T07:33:38.652099Z","caller":"traceutil/trace.go:171","msg":"trace[2095950531] linearizableReadLoop","detail":"{readStateIndex:5055; appliedIndex:5054; }","duration":"181.713035ms","start":"2026-07-17T07:33:38.470358Z","end":"2026-07-17T07:33:38.652071Z","steps":["trace[2095950531] 'read index received' (duration: 164.509085ms)","trace[2095950531] 'applied index is now lower than readState.Index' (duration: 17.20245ms)"],"step_count":2} {"level":"warn","ts":"2026-07-17T07:33:38.652467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.088922ms","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-17T07:33:38.652573Z","caller":"traceutil/trace.go:171","msg":"trace[1533429120] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4870; }","duration":"182.241374ms","start":"2026-07-17T07:33:38.470307Z","end":"2026-07-17T07:33:38.652549Z","steps":["trace[1533429120] 'agreement among raft nodes before linearized reading' (duration: 181.882418ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:34:11.416029Z","caller":"traceutil/trace.go:171","msg":"trace[1578237366] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"106.773256ms","start":"2026-07-17T07:34:11.309224Z","end":"2026-07-17T07:34:11.415998Z","steps":["trace[1578237366] 'process raft request' (duration: 95.012207ms)","trace[1578237366] 'compare' (duration: 11.472684ms)"],"step_count":2} {"level":"info","ts":"2026-07-17T07:34:11.448832Z","caller":"traceutil/trace.go:171","msg":"trace[877707153] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"135.6105ms","start":"2026-07-17T07:34:11.313188Z","end":"2026-07-17T07:34:11.448799Z","steps":["trace[877707153] 'process raft request' (duration: 135.362286ms)"],"step_count":1} {"level":"info","ts":"2026-07-17T07:35:18.098146Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2936} {"level":"info","ts":"2026-07-17T07:35:18.197151Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2936,"took":"97.485998ms","hash":518022119,"current-db-size-bytes":55177216,"current-db-size":"55 MB","current-db-size-in-use-bytes":29814784,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-17T07:35:18.197207Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":518022119,"revision":2936,"compact-revision":-1} {"level":"info","ts":"2026-07-17T07:40:18.103827Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5665} {"level":"info","ts":"2026-07-17T07:40:18.184605Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5665,"took":"79.527199ms","hash":3261010930,"current-db-size-bytes":55177216,"current-db-size":"55 MB","current-db-size-in-use-bytes":18518016,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-17T07:40:18.184681Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3261010930,"revision":5665,"compact-revision":2936}