{"level":"warn","ts":"2026-06-06T04:59:05.728227Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-06T04:59:05.728627Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.216: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.216:2380","--initial-cluster=instance=https://199.204.45.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.216:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-06T04:59:05.728739Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-06T04:59:05.728794Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-06T04:59:05.728831Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-06T04:59:05.729752Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"]} {"level":"info","ts":"2026-06-06T04:59:05.729935Z","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.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.216:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-06T04:59:05.73632Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.131884ms"} {"level":"info","ts":"2026-06-06T04:59:05.741466Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e98569549cc430c","cluster-id":"65d70b4d1d4a8bf9"} {"level":"info","ts":"2026-06-06T04:59:05.741613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=()"} {"level":"info","ts":"2026-06-06T04:59:05.741726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 0"} {"level":"info","ts":"2026-06-06T04:59:05.741751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e98569549cc430c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-06T04:59:05.741769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became follower at term 1"} {"level":"info","ts":"2026-06-06T04:59:05.741859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"warn","ts":"2026-06-06T04:59:05.747476Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-06T04:59:05.748771Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-06T04:59:05.750493Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-06T04:59:05.752487Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e98569549cc430c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-06T04:59:05.753221Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e98569549cc430c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-06T04:59:05.753468Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-06T04:59:05.753527Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-06T04:59:05.753541Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-06T04:59:05.753735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c switched to configuration voters=(5663371730606637836)"} {"level":"info","ts":"2026-06-06T04:59:05.754242Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","added-peer-id":"4e98569549cc430c","added-peer-peer-urls":["https://199.204.45.216:2380"]} {"level":"info","ts":"2026-06-06T04:59:05.759235Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-06T04:59:05.75954Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e98569549cc430c","initial-advertise-peer-urls":["https://199.204.45.216:2380"],"listen-peer-urls":["https://199.204.45.216:2380"],"advertise-client-urls":["https://199.204.45.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-06T04:59:05.759578Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-06T04:59:05.759691Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-06T04:59:05.759761Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.216:2380"} {"level":"info","ts":"2026-06-06T04:59:06.54304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c is starting a new election at term 1"} {"level":"info","ts":"2026-06-06T04:59:06.543174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became pre-candidate at term 1"} {"level":"info","ts":"2026-06-06T04:59:06.543273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgPreVoteResp from 4e98569549cc430c at term 1"} {"level":"info","ts":"2026-06-06T04:59:06.543351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became candidate at term 2"} {"level":"info","ts":"2026-06-06T04:59:06.543375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c received MsgVoteResp from 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-06T04:59:06.552962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e98569549cc430c became leader at term 2"} {"level":"info","ts":"2026-06-06T04:59:06.552984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e98569549cc430c elected leader 4e98569549cc430c at term 2"} {"level":"info","ts":"2026-06-06T04:59:06.557173Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T04:59:06.561755Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-06T04:59:06.561757Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e98569549cc430c","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.216:2379]}","request-path":"/0/members/4e98569549cc430c/attributes","cluster-id":"65d70b4d1d4a8bf9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-06T04:59:06.562062Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-06T04:59:06.562324Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-06T04:59:06.562353Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-06T04:59:06.563623Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-06T04:59:06.564868Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.216:2379"} {"level":"info","ts":"2026-06-06T04:59:06.568978Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65d70b4d1d4a8bf9","local-member-id":"4e98569549cc430c","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T04:59:06.56908Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T04:59:06.569112Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T04:59:09.492166Z","caller":"traceutil/trace.go:171","msg":"trace[919476818] transaction","detail":"{read_only:false; response_revision:168; number_of_response:1; }","duration":"154.329291ms","start":"2026-06-06T04:59:09.337799Z","end":"2026-06-06T04:59:09.492128Z","steps":["trace[919476818] 'process raft request' (duration: 154.085482ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T04:59:14.959337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.159052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-06T04:59:14.959486Z","caller":"traceutil/trace.go:171","msg":"trace[693446911] linearizableReadLoop","detail":"{readStateIndex:310; appliedIndex:309; }","duration":"231.799087ms","start":"2026-06-06T04:59:14.727669Z","end":"2026-06-06T04:59:14.959468Z","steps":["trace[693446911] 'read index received' (duration: 84.818806ms)","trace[693446911] 'applied index is now lower than readState.Index' (duration: 146.978341ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T04:59:14.95961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.941262ms","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-06-06T04:59:14.959643Z","caller":"traceutil/trace.go:171","msg":"trace[1235361495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:296; }","duration":"232.030786ms","start":"2026-06-06T04:59:14.727603Z","end":"2026-06-06T04:59:14.959634Z","steps":["trace[1235361495] 'agreement among raft nodes before linearized reading' (duration: 231.927522ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T04:59:14.959658Z","caller":"traceutil/trace.go:171","msg":"trace[1702030243] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"244.279709ms","start":"2026-06-06T04:59:14.715207Z","end":"2026-06-06T04:59:14.959487Z","steps":["trace[1702030243] 'process raft request' (duration: 97.367181ms)","trace[1702030243] 'compare' (duration: 145.949273ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T04:59:15.259151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.779862ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-06T04:59:15.259272Z","caller":"traceutil/trace.go:171","msg":"trace[504735769] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:310; }","duration":"294.627096ms","start":"2026-06-06T04:59:14.964626Z","end":"2026-06-06T04:59:15.259253Z","steps":["trace[504735769] 'read index received' (duration: 158.366977ms)","trace[504735769] 'applied index is now lower than readState.Index' (duration: 136.258839ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T04:59:15.259417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.227411ms","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-06-06T04:59:15.259459Z","caller":"traceutil/trace.go:171","msg":"trace[1147048060] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:297; }","duration":"257.268572ms","start":"2026-06-06T04:59:15.002179Z","end":"2026-06-06T04:59:15.259448Z","steps":["trace[1147048060] 'agreement among raft nodes before linearized reading' (duration: 257.175609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T04:59:15.259422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.769192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T04:59:15.259465Z","caller":"traceutil/trace.go:171","msg":"trace[1789914939] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"295.479808ms","start":"2026-06-06T04:59:14.963945Z","end":"2026-06-06T04:59:15.259424Z","steps":["trace[1789914939] 'process raft request' (duration: 159.172538ms)","trace[1789914939] 'compare' (duration: 135.632356ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T04:59:15.259533Z","caller":"traceutil/trace.go:171","msg":"trace[176590511] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:0; response_revision:297; }","duration":"294.930017ms","start":"2026-06-06T04:59:14.964575Z","end":"2026-06-06T04:59:15.259505Z","steps":["trace[176590511] 'agreement among raft nodes before linearized reading' (duration: 294.767542ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T04:59:16.038449Z","caller":"traceutil/trace.go:171","msg":"trace[1721635087] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"117.250622ms","start":"2026-06-06T04:59:15.921143Z","end":"2026-06-06T04:59:16.038393Z","steps":["trace[1721635087] 'process raft request' (duration: 33.684136ms)","trace[1721635087] 'compare' (duration: 83.367699ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T04:59:39.466433Z","caller":"traceutil/trace.go:171","msg":"trace[1821278735] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"104.746038ms","start":"2026-06-06T04:59:39.361663Z","end":"2026-06-06T04:59:39.466409Z","steps":["trace[1821278735] 'process raft request' (duration: 104.2767ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T04:59:39.576498Z","caller":"traceutil/trace.go:171","msg":"trace[171641887] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"107.091627ms","start":"2026-06-06T04:59:39.46938Z","end":"2026-06-06T04:59:39.576472Z","steps":["trace[171641887] 'process raft request' (duration: 106.000246ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T04:59:43.229945Z","caller":"traceutil/trace.go:171","msg":"trace[852251299] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"116.378439ms","start":"2026-06-06T04:59:43.113543Z","end":"2026-06-06T04:59:43.229921Z","steps":["trace[852251299] 'process raft request' (duration: 116.216793ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T04:59:43.230108Z","caller":"traceutil/trace.go:171","msg":"trace[1553781999] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"108.723913ms","start":"2026-06-06T04:59:43.121327Z","end":"2026-06-06T04:59:43.230051Z","steps":["trace[1553781999] 'process raft request' (duration: 108.545576ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T04:59:43.231157Z","caller":"traceutil/trace.go:171","msg":"trace[2027277019] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"108.828248ms","start":"2026-06-06T04:59:43.121174Z","end":"2026-06-06T04:59:43.230002Z","steps":["trace[2027277019] 'process raft request' (duration: 108.676042ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T04:59:44.876974Z","caller":"traceutil/trace.go:171","msg":"trace[628579139] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"330.468763ms","start":"2026-06-06T04:59:44.54648Z","end":"2026-06-06T04:59:44.876949Z","steps":["trace[628579139] 'process raft request' (duration: 276.768504ms)","trace[628579139] 'compare' (duration: 53.562533ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T04:59:44.877031Z","caller":"traceutil/trace.go:171","msg":"trace[1693444862] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:589; }","duration":"317.120935ms","start":"2026-06-06T04:59:44.559873Z","end":"2026-06-06T04:59:44.876994Z","steps":["trace[1693444862] 'read index received' (duration: 263.369375ms)","trace[1693444862] 'applied index is now lower than readState.Index' (duration: 53.74885ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T04:59:44.877114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T04:59:44.546449Z","time spent":"330.594267ms","remote":"127.0.0.1:56298","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T04:59:44.880135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.258488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-06-06T04:59:44.880174Z","caller":"traceutil/trace.go:171","msg":"trace[1762587585] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:565; }","duration":"320.300799ms","start":"2026-06-06T04:59:44.559864Z","end":"2026-06-06T04:59:44.880165Z","steps":["trace[1762587585] 'agreement among raft nodes before linearized reading' (duration: 317.314554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T04:59:44.880195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T04:59:44.559784Z","time spent":"320.405503ms","remote":"127.0.0.1:56298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":31148,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-06-06T04:59:49.288226Z","caller":"traceutil/trace.go:171","msg":"trace[1402605433] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"114.465217ms","start":"2026-06-06T04:59:49.173729Z","end":"2026-06-06T04:59:49.288194Z","steps":["trace[1402605433] 'process raft request' (duration: 114.315211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T04:59:49.77646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.911918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-06T04:59:49.776523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.72452ms","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-06-06T04:59:49.776573Z","caller":"traceutil/trace.go:171","msg":"trace[1087931182] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"149.088855ms","start":"2026-06-06T04:59:49.627458Z","end":"2026-06-06T04:59:49.776547Z","steps":["trace[1087931182] 'range keys from in-memory index tree' (duration: 148.71809ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T04:59:49.776586Z","caller":"traceutil/trace.go:171","msg":"trace[1598728391] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"262.814473ms","start":"2026-06-06T04:59:49.513753Z","end":"2026-06-06T04:59:49.776567Z","steps":["trace[1598728391] 'range keys from in-memory index tree' (duration: 262.666367ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T04:59:49.776572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.880784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zgzv6\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-06T04:59:49.776646Z","caller":"traceutil/trace.go:171","msg":"trace[213325716] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zgzv6; range_end:; response_count:1; response_revision:592; }","duration":"282.00753ms","start":"2026-06-06T04:59:49.494619Z","end":"2026-06-06T04:59:49.776626Z","steps":["trace[213325716] 'range keys from in-memory index tree' (duration: 281.624705ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:00:08.876494Z","caller":"traceutil/trace.go:171","msg":"trace[915989288] linearizableReadLoop","detail":"{readStateIndex:798; appliedIndex:797; }","duration":"166.434049ms","start":"2026-06-06T05:00:08.710039Z","end":"2026-06-06T05:00:08.876473Z","steps":["trace[915989288] 'read index received' (duration: 166.225571ms)","trace[915989288] 'applied index is now lower than readState.Index' (duration: 207.508µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:00:08.876931Z","caller":"traceutil/trace.go:171","msg":"trace[2066419106] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"271.004292ms","start":"2026-06-06T05:00:08.605888Z","end":"2026-06-06T05:00:08.876892Z","steps":["trace[2066419106] 'process raft request' (duration: 270.46389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:00:08.877091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.026232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-06T05:00:08.877171Z","caller":"traceutil/trace.go:171","msg":"trace[1036360348] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:767; }","duration":"167.154777ms","start":"2026-06-06T05:00:08.709994Z","end":"2026-06-06T05:00:08.877148Z","steps":["trace[1036360348] 'agreement among raft nodes before linearized reading' (duration: 166.972479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:00:08.877275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.043635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-06T05:00:08.877368Z","caller":"traceutil/trace.go:171","msg":"trace[1171152840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:767; }","duration":"121.333805ms","start":"2026-06-06T05:00:08.756012Z","end":"2026-06-06T05:00:08.877346Z","steps":["trace[1171152840] 'agreement among raft nodes before linearized reading' (duration: 120.921289ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:00:54.639435Z","caller":"traceutil/trace.go:171","msg":"trace[1063983449] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"123.043821ms","start":"2026-06-06T05:00:54.516355Z","end":"2026-06-06T05:00:54.639399Z","steps":["trace[1063983449] 'process raft request' (duration: 122.812287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:01:27.232899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.046707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-06T05:01:27.233018Z","caller":"traceutil/trace.go:171","msg":"trace[266493106] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1833; }","duration":"276.225452ms","start":"2026-06-06T05:01:26.956771Z","end":"2026-06-06T05:01:27.232996Z","steps":["trace[266493106] 'count revisions from in-memory index tree' (duration: 275.891663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:01:27.233269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.944409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8537a74e-5f54-45c7-a73c-ff5c8d9bc281\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-06T05:01:27.23342Z","caller":"traceutil/trace.go:171","msg":"trace[1606552392] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8537a74e-5f54-45c7-a73c-ff5c8d9bc281; range_end:; response_count:1; response_revision:1833; }","duration":"243.137763ms","start":"2026-06-06T05:01:26.990255Z","end":"2026-06-06T05:01:27.233393Z","steps":["trace[1606552392] 'range keys from in-memory index tree' (duration: 242.773624ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:27.629197Z","caller":"traceutil/trace.go:171","msg":"trace[1817205809] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1913; }","duration":"239.935948ms","start":"2026-06-06T05:01:27.389228Z","end":"2026-06-06T05:01:27.629164Z","steps":["trace[1817205809] 'read index received' (duration: 156.712881ms)","trace[1817205809] 'applied index is now lower than readState.Index' (duration: 83.221527ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:01:27.629379Z","caller":"traceutil/trace.go:171","msg":"trace[1282070579] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"253.010893ms","start":"2026-06-06T05:01:27.376355Z","end":"2026-06-06T05:01:27.629366Z","steps":["trace[1282070579] 'process raft request' (duration: 169.637662ms)","trace[1282070579] 'compare' (duration: 83.015042ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:01:27.629737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.679631ms","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":"warn","ts":"2026-06-06T05:01:27.629779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.530703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-06T05:01:27.629813Z","caller":"traceutil/trace.go:171","msg":"trace[1374438871] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1836; }","duration":"186.800353ms","start":"2026-06-06T05:01:27.442994Z","end":"2026-06-06T05:01:27.629794Z","steps":["trace[1374438871] 'agreement among raft nodes before linearized reading' (duration: 186.591778ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:27.629862Z","caller":"traceutil/trace.go:171","msg":"trace[366903185] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1836; }","duration":"240.656736ms","start":"2026-06-06T05:01:27.389179Z","end":"2026-06-06T05:01:27.629836Z","steps":["trace[366903185] 'agreement among raft nodes before linearized reading' (duration: 240.416571ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:35.165544Z","caller":"traceutil/trace.go:171","msg":"trace[795619818] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"101.782733ms","start":"2026-06-06T05:01:35.063734Z","end":"2026-06-06T05:01:35.165517Z","steps":["trace[795619818] 'process raft request' (duration: 101.550537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:01:35.672601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.135369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11989"} {"level":"info","ts":"2026-06-06T05:01:35.672663Z","caller":"traceutil/trace.go:171","msg":"trace[1540152827] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1920; }","duration":"172.251731ms","start":"2026-06-06T05:01:35.500399Z","end":"2026-06-06T05:01:35.672651Z","steps":["trace[1540152827] 'range keys from in-memory index tree' (duration: 172.043376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:01:35.67289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.447463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-06T05:01:35.672964Z","caller":"traceutil/trace.go:171","msg":"trace[1216581377] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1920; }","duration":"233.534125ms","start":"2026-06-06T05:01:35.439411Z","end":"2026-06-06T05:01:35.672945Z","steps":["trace[1216581377] 'range keys from in-memory index tree' (duration: 233.34566ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:41.00266Z","caller":"traceutil/trace.go:171","msg":"trace[2102096865] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"148.217716ms","start":"2026-06-06T05:01:40.854419Z","end":"2026-06-06T05:01:41.002637Z","steps":["trace[2102096865] 'process raft request' (duration: 148.054822ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:57.974537Z","caller":"traceutil/trace.go:171","msg":"trace[1618055847] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"118.898593ms","start":"2026-06-06T05:01:57.85559Z","end":"2026-06-06T05:01:57.974489Z","steps":["trace[1618055847] 'process raft request' (duration: 118.211994ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:58.178513Z","caller":"traceutil/trace.go:171","msg":"trace[37115053] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"109.976993ms","start":"2026-06-06T05:01:58.068509Z","end":"2026-06-06T05:01:58.178486Z","steps":["trace[37115053] 'process raft request' (duration: 109.813068ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:58.579879Z","caller":"traceutil/trace.go:171","msg":"trace[759682611] linearizableReadLoop","detail":"{readStateIndex:2148; appliedIndex:2147; }","duration":"109.622552ms","start":"2026-06-06T05:01:58.470241Z","end":"2026-06-06T05:01:58.579863Z","steps":["trace[759682611] 'read index received' (duration: 109.490078ms)","trace[759682611] 'applied index is now lower than readState.Index' (duration: 131.764µs)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:01:58.580035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.780487ms","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-06-06T05:01:58.58006Z","caller":"traceutil/trace.go:171","msg":"trace[2030909037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2063; }","duration":"109.845278ms","start":"2026-06-06T05:01:58.470207Z","end":"2026-06-06T05:01:58.580052Z","steps":["trace[2030909037] 'agreement among raft nodes before linearized reading' (duration: 109.723004ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:58.580371Z","caller":"traceutil/trace.go:171","msg":"trace[28224108] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"110.823247ms","start":"2026-06-06T05:01:58.469515Z","end":"2026-06-06T05:01:58.580339Z","steps":["trace[28224108] 'process raft request' (duration: 110.257501ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:01:58.921595Z","caller":"traceutil/trace.go:171","msg":"trace[225985841] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"338.319535ms","start":"2026-06-06T05:01:58.583252Z","end":"2026-06-06T05:01:58.921571Z","steps":["trace[225985841] 'process raft request' (duration: 338.192432ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:01:58.921738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:01:58.583238Z","time spent":"338.426488ms","remote":"127.0.0.1:56526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:01:59.219164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.688848ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-06T05:01:59.219264Z","caller":"traceutil/trace.go:171","msg":"trace[499156693] linearizableReadLoop","detail":"{readStateIndex:2150; appliedIndex:2148; }","duration":"359.578495ms","start":"2026-06-06T05:01:58.859669Z","end":"2026-06-06T05:01:59.219248Z","steps":["trace[499156693] 'read index received' (duration: 61.76504ms)","trace[499156693] 'applied index is now lower than readState.Index' (duration: 297.812015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:01:59.219363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.698828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T05:01:59.219388Z","caller":"traceutil/trace.go:171","msg":"trace[1459853667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2065; }","duration":"359.76055ms","start":"2026-06-06T05:01:58.859618Z","end":"2026-06-06T05:01:59.219379Z","steps":["trace[1459853667] 'agreement among raft nodes before linearized reading' (duration: 359.714128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:01:59.219421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:01:58.859596Z","time spent":"359.817412ms","remote":"127.0.0.1:56242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-06T05:01:59.219376Z","caller":"traceutil/trace.go:171","msg":"trace[26275690] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"537.80713ms","start":"2026-06-06T05:01:58.681528Z","end":"2026-06-06T05:01:59.219335Z","steps":["trace[26275690] 'process raft request' (duration: 309.862985ms)","trace[26275690] 'compare' (duration: 227.492003ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:01:59.219559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T05:01:58.681507Z","time spent":"537.965805ms","remote":"127.0.0.1:56526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T05:01:59.219553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.409366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-06T05:01:59.219633Z","caller":"traceutil/trace.go:171","msg":"trace[272400687] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2065; }","duration":"237.539369ms","start":"2026-06-06T05:01:58.982072Z","end":"2026-06-06T05:01:59.219611Z","steps":["trace[272400687] 'agreement among raft nodes before linearized reading' (duration: 237.305083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:03:45.970841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.97767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-06T05:03:45.971105Z","caller":"traceutil/trace.go:171","msg":"trace[648108704] linearizableReadLoop","detail":"{readStateIndex:2859; appliedIndex:2858; }","duration":"190.052504ms","start":"2026-06-06T05:03:45.781032Z","end":"2026-06-06T05:03:45.971085Z","steps":["trace[648108704] 'read index received' (duration: 58.608258ms)","trace[648108704] 'applied index is now lower than readState.Index' (duration: 131.442546ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:03:45.971072Z","caller":"traceutil/trace.go:171","msg":"trace[1970146932] transaction","detail":"{read_only:false; response_revision:2749; number_of_response:1; }","duration":"196.0303ms","start":"2026-06-06T05:03:45.774985Z","end":"2026-06-06T05:03:45.971016Z","steps":["trace[1970146932] 'process raft request' (duration: 64.693488ms)","trace[1970146932] 'compare' (duration: 130.842205ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:03:45.971251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.19753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T05:03:45.971323Z","caller":"traceutil/trace.go:171","msg":"trace[1387608751] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2749; }","duration":"190.310374ms","start":"2026-06-06T05:03:45.780996Z","end":"2026-06-06T05:03:45.971307Z","steps":["trace[1387608751] 'agreement among raft nodes before linearized reading' (duration: 190.153268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:03:45.971501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.980755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T05:03:45.971593Z","caller":"traceutil/trace.go:171","msg":"trace[1967209474] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2750; }","duration":"111.102549ms","start":"2026-06-06T05:03:45.860479Z","end":"2026-06-06T05:03:45.971582Z","steps":["trace[1967209474] 'agreement among raft nodes before linearized reading' (duration: 110.802329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:07:38.511587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.783434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-06T05:07:38.511821Z","caller":"traceutil/trace.go:171","msg":"trace[1120596668] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4742; }","duration":"184.054552ms","start":"2026-06-06T05:07:38.32774Z","end":"2026-06-06T05:07:38.511794Z","steps":["trace[1120596668] 'range keys from in-memory index tree' (duration: 183.478627ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:07:38.559624Z","caller":"traceutil/trace.go:171","msg":"trace[620478900] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"149.49664ms","start":"2026-06-06T05:07:38.410104Z","end":"2026-06-06T05:07:38.559601Z","steps":["trace[620478900] 'process raft request' (duration: 149.368906ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:07:38.587732Z","caller":"traceutil/trace.go:171","msg":"trace[1860020473] linearizableReadLoop","detail":"{readStateIndex:4930; appliedIndex:4928; }","duration":"116.811659ms","start":"2026-06-06T05:07:38.470908Z","end":"2026-06-06T05:07:38.58772Z","steps":["trace[1860020473] 'read index received' (duration: 88.524229ms)","trace[1860020473] 'applied index is now lower than readState.Index' (duration: 28.28671ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:07:38.587983Z","caller":"traceutil/trace.go:171","msg":"trace[654775914] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"154.007988ms","start":"2026-06-06T05:07:38.433968Z","end":"2026-06-06T05:07:38.587976Z","steps":["trace[654775914] 'process raft request' (duration: 153.646718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:07:38.588036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.992681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T05:07:38.588106Z","caller":"traceutil/trace.go:171","msg":"trace[1067561150] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:4745; }","duration":"115.121864ms","start":"2026-06-06T05:07:38.47297Z","end":"2026-06-06T05:07:38.588092Z","steps":["trace[1067561150] 'agreement among raft nodes before linearized reading' (duration: 114.96084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:07:38.588159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.26112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dec42a98-e55b-4094-a262-27ccd33ea849\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-06T05:07:38.588268Z","caller":"traceutil/trace.go:171","msg":"trace[1296549614] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dec42a98-e55b-4094-a262-27ccd33ea849; range_end:; response_count:1; response_revision:4745; }","duration":"117.410104ms","start":"2026-06-06T05:07:38.47083Z","end":"2026-06-06T05:07:38.58824Z","steps":["trace[1296549614] 'agreement among raft nodes before linearized reading' (duration: 117.119767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:07:38.969011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.933707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T05:07:38.969083Z","caller":"traceutil/trace.go:171","msg":"trace[501228772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4748; }","duration":"108.08249ms","start":"2026-06-06T05:07:38.860986Z","end":"2026-06-06T05:07:38.969069Z","steps":["trace[501228772] 'agreement among raft nodes before linearized reading' (duration: 107.944397ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:07:38.969061Z","caller":"traceutil/trace.go:171","msg":"trace[1267599049] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"157.14999ms","start":"2026-06-06T05:07:38.811851Z","end":"2026-06-06T05:07:38.969001Z","steps":["trace[1267599049] 'process raft request' (duration: 156.943555ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:08:29.984689Z","caller":"traceutil/trace.go:171","msg":"trace[1529155403] transaction","detail":"{read_only:false; response_revision:5265; number_of_response:1; }","duration":"193.344757ms","start":"2026-06-06T05:08:29.791318Z","end":"2026-06-06T05:08:29.984662Z","steps":["trace[1529155403] 'process raft request' (duration: 193.189252ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:08:29.984715Z","caller":"traceutil/trace.go:171","msg":"trace[1948228449] transaction","detail":"{read_only:false; response_revision:5264; number_of_response:1; }","duration":"201.746403ms","start":"2026-06-06T05:08:29.782931Z","end":"2026-06-06T05:08:29.984677Z","steps":["trace[1948228449] 'process raft request' (duration: 193.412329ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:08:30.004658Z","caller":"traceutil/trace.go:171","msg":"trace[315442048] linearizableReadLoop","detail":"{readStateIndex:5467; appliedIndex:5464; }","duration":"143.415964ms","start":"2026-06-06T05:08:29.861219Z","end":"2026-06-06T05:08:30.004635Z","steps":["trace[315442048] 'read index received' (duration: 114.996984ms)","trace[315442048] 'applied index is now lower than readState.Index' (duration: 28.41793ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:08:30.004702Z","caller":"traceutil/trace.go:171","msg":"trace[2006819092] transaction","detail":"{read_only:false; response_revision:5266; number_of_response:1; }","duration":"194.214602ms","start":"2026-06-06T05:08:29.810462Z","end":"2026-06-06T05:08:30.004677Z","steps":["trace[2006819092] 'process raft request' (duration: 194.065068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:08:30.004891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.604979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T05:08:30.00557Z","caller":"traceutil/trace.go:171","msg":"trace[1070385379] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5266; }","duration":"144.39228ms","start":"2026-06-06T05:08:29.86116Z","end":"2026-06-06T05:08:30.005552Z","steps":["trace[1070385379] 'agreement among raft nodes before linearized reading' (duration: 143.600858ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:08:38.901647Z","caller":"traceutil/trace.go:171","msg":"trace[1721343427] transaction","detail":"{read_only:false; response_revision:5334; number_of_response:1; }","duration":"122.155139ms","start":"2026-06-06T05:08:38.779452Z","end":"2026-06-06T05:08:38.901607Z","steps":["trace[1721343427] 'process raft request' (duration: 58.190593ms)","trace[1721343427] 'compare' (duration: 63.222094ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:09:06.586237Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2859} {"level":"info","ts":"2026-06-06T05:09:06.687034Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2859,"took":"98.77555ms","hash":3954439854,"current-db-size-bytes":53460992,"current-db-size":"54 MB","current-db-size-in-use-bytes":28762112,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-06T05:09:06.687163Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3954439854,"revision":2859,"compact-revision":-1} {"level":"info","ts":"2026-06-06T05:11:47.111432Z","caller":"traceutil/trace.go:171","msg":"trace[24824754] linearizableReadLoop","detail":"{readStateIndex:6907; appliedIndex:6906; }","duration":"116.790564ms","start":"2026-06-06T05:11:46.994619Z","end":"2026-06-06T05:11:47.11141Z","steps":["trace[24824754] 'read index received' (duration: 116.629309ms)","trace[24824754] 'applied index is now lower than readState.Index' (duration: 160.045µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:11:47.111541Z","caller":"traceutil/trace.go:171","msg":"trace[2069011289] transaction","detail":"{read_only:false; response_revision:6657; number_of_response:1; }","duration":"117.425293ms","start":"2026-06-06T05:11:46.994085Z","end":"2026-06-06T05:11:47.11151Z","steps":["trace[2069011289] 'process raft request' (duration: 117.169205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T05:11:47.113241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.575519ms","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-06-06T05:11:47.113523Z","caller":"traceutil/trace.go:171","msg":"trace[1714911505] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6657; }","duration":"118.751056ms","start":"2026-06-06T05:11:46.994586Z","end":"2026-06-06T05:11:47.113337Z","steps":["trace[1714911505] 'agreement among raft nodes before linearized reading' (duration: 116.940088ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:11:47.265243Z","caller":"traceutil/trace.go:171","msg":"trace[1569792879] transaction","detail":"{read_only:false; response_revision:6658; number_of_response:1; }","duration":"146.921129ms","start":"2026-06-06T05:11:47.118284Z","end":"2026-06-06T05:11:47.265205Z","steps":["trace[1569792879] 'process raft request' (duration: 72.959929ms)","trace[1569792879] 'compare' (duration: 73.815395ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:11:47.453456Z","caller":"traceutil/trace.go:171","msg":"trace[1328590605] linearizableReadLoop","detail":"{readStateIndex:6909; appliedIndex:6908; }","duration":"171.043315ms","start":"2026-06-06T05:11:47.282389Z","end":"2026-06-06T05:11:47.453432Z","steps":["trace[1328590605] 'read index received' (duration: 84.147299ms)","trace[1328590605] 'applied index is now lower than readState.Index' (duration: 86.895046ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T05:11:47.453606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.189799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/bindings.rabbitmq.com\" ","response":"range_response_count:1 size:5614"} {"level":"info","ts":"2026-06-06T05:11:47.453646Z","caller":"traceutil/trace.go:171","msg":"trace[574549000] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/bindings.rabbitmq.com; range_end:; response_count:1; response_revision:6659; }","duration":"171.302573ms","start":"2026-06-06T05:11:47.282331Z","end":"2026-06-06T05:11:47.453634Z","steps":["trace[574549000] 'agreement among raft nodes before linearized reading' (duration: 171.18478ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T05:11:47.454238Z","caller":"traceutil/trace.go:171","msg":"trace[377519898] transaction","detail":"{read_only:false; response_revision:6659; number_of_response:1; }","duration":"180.803361ms","start":"2026-06-06T05:11:47.27342Z","end":"2026-06-06T05:11:47.454223Z","steps":["trace[377519898] 'process raft request' (duration: 93.207303ms)","trace[377519898] 'compare' (duration: 86.589666ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T05:14:06.591905Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5537} {"level":"info","ts":"2026-06-06T05:14:06.678143Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5537,"took":"85.240171ms","hash":3267949032,"current-db-size-bytes":53460992,"current-db-size":"54 MB","current-db-size-in-use-bytes":18268160,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-06T05:14:06.678195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3267949032,"revision":5537,"compact-revision":2859}