{"level":"warn","ts":"2026-04-20T04:50:38.332797Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T04:50:38.332886Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.65: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.65:2380","--initial-cluster=instance=https://199.204.45.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.65:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T04:50:38.332959Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T04:50:38.332974Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-20T04:50:38.332992Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T04:50:38.333701Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"]} {"level":"info","ts":"2026-04-20T04:50:38.33379Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.65:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T04:50:38.337627Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.558839ms"} {"level":"info","ts":"2026-04-20T04:50:38.344197Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cf8c3a138c9a77a2","cluster-id":"c278183e1f634dff"} {"level":"info","ts":"2026-04-20T04:50:38.344367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T04:50:38.344414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 0"} {"level":"info","ts":"2026-04-20T04:50:38.344444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cf8c3a138c9a77a2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T04:50:38.344471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became follower at term 1"} {"level":"info","ts":"2026-04-20T04:50:38.344548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"warn","ts":"2026-04-20T04:50:38.351436Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T04:50:38.353046Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T04:50:38.355639Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T04:50:38.359359Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cf8c3a138c9a77a2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T04:50:38.359789Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cf8c3a138c9a77a2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T04:50:38.359929Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T04:50:38.36007Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T04:50:38.360113Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T04:50:38.360495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 switched to configuration voters=(14955392318228297634)"} {"level":"info","ts":"2026-04-20T04:50:38.360624Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","added-peer-id":"cf8c3a138c9a77a2","added-peer-peer-urls":["https://199.204.45.65:2380"]} {"level":"info","ts":"2026-04-20T04:50:38.364341Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T04:50:38.364447Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-20T04:50:38.364486Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.65:2380"} {"level":"info","ts":"2026-04-20T04:50:38.36457Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cf8c3a138c9a77a2","initial-advertise-peer-urls":["https://199.204.45.65:2380"],"listen-peer-urls":["https://199.204.45.65:2380"],"advertise-client-urls":["https://199.204.45.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T04:50:38.364614Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T04:50:38.644903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T04:50:38.644958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T04:50:38.644978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgPreVoteResp from cf8c3a138c9a77a2 at term 1"} {"level":"info","ts":"2026-04-20T04:50:38.644994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became candidate at term 2"} {"level":"info","ts":"2026-04-20T04:50:38.645003Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 received MsgVoteResp from cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-20T04:50:38.645039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cf8c3a138c9a77a2 became leader at term 2"} {"level":"info","ts":"2026-04-20T04:50:38.64505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cf8c3a138c9a77a2 elected leader cf8c3a138c9a77a2 at term 2"} {"level":"info","ts":"2026-04-20T04:50:38.646332Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cf8c3a138c9a77a2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.65:2379]}","request-path":"/0/members/cf8c3a138c9a77a2/attributes","cluster-id":"c278183e1f634dff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T04:50:38.646395Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:50:38.646459Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:50:38.646628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:50:38.646792Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T04:50:38.646823Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T04:50:38.647528Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c278183e1f634dff","local-member-id":"cf8c3a138c9a77a2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:50:38.648325Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:50:38.648391Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:50:38.648661Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T04:50:38.651159Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.65:2379"} {"level":"warn","ts":"2026-04-20T04:50:38.987286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.633506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.987343Z","caller":"traceutil/trace.go:171","msg":"trace[230868075] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"230.716068ms","start":"2026-04-20T04:50:38.756613Z","end":"2026-04-20T04:50:38.987329Z","steps":["trace[230868075] 'range keys from in-memory index tree' (duration: 230.566184ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.987194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.992472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T04:50:38.987506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.217013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T04:50:38.987551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.93422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.987612Z","caller":"traceutil/trace.go:171","msg":"trace[1195365090] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"147.468343ms","start":"2026-04-20T04:50:38.84012Z","end":"2026-04-20T04:50:38.987588Z","steps":["trace[1195365090] 'range keys from in-memory index tree' (duration: 146.886739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.987621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.505155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.987644Z","caller":"traceutil/trace.go:171","msg":"trace[610230737] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"159.548805ms","start":"2026-04-20T04:50:38.828088Z","end":"2026-04-20T04:50:38.987637Z","steps":["trace[610230737] 'range keys from in-memory index tree' (duration: 159.450253ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:38.987635Z","caller":"traceutil/trace.go:171","msg":"trace[171860200] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"182.385687ms","start":"2026-04-20T04:50:38.805233Z","end":"2026-04-20T04:50:38.987619Z","steps":["trace[171860200] 'count revisions from in-memory index tree' (duration: 182.147801ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:38.987659Z","caller":"traceutil/trace.go:171","msg":"trace[292839628] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"171.066354ms","start":"2026-04-20T04:50:38.816556Z","end":"2026-04-20T04:50:38.987622Z","steps":["trace[292839628] 'count revisions from in-memory index tree' (duration: 170.853449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.987255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.688718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.987745Z","caller":"traceutil/trace.go:171","msg":"trace[874539592] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"231.20006ms","start":"2026-04-20T04:50:38.756536Z","end":"2026-04-20T04:50:38.987736Z","steps":["trace[874539592] 'count revisions from in-memory index tree' (duration: 230.641287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.98778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.605986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.987809Z","caller":"traceutil/trace.go:171","msg":"trace[686372408] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"147.659818ms","start":"2026-04-20T04:50:38.840141Z","end":"2026-04-20T04:50:38.987801Z","steps":["trace[686372408] 'count revisions from in-memory index tree' (duration: 147.546105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.987227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.117168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.987919Z","caller":"traceutil/trace.go:171","msg":"trace[1667586510] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"243.831566ms","start":"2026-04-20T04:50:38.744077Z","end":"2026-04-20T04:50:38.987908Z","steps":["trace[1667586510] 'count revisions from in-memory index tree' (duration: 242.983255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.987937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.968808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T04:50:38.98799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.895911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.988035Z","caller":"traceutil/trace.go:171","msg":"trace[2046644450] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"220.026881ms","start":"2026-04-20T04:50:38.767949Z","end":"2026-04-20T04:50:38.987976Z","steps":["trace[2046644450] 'range keys from in-memory index tree' (duration: 219.935088ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:38.988044Z","caller":"traceutil/trace.go:171","msg":"trace[1332385139] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"206.971703ms","start":"2026-04-20T04:50:38.781056Z","end":"2026-04-20T04:50:38.988027Z","steps":["trace[1332385139] 'count revisions from in-memory index tree' (duration: 206.86653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.987566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.521915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T04:50:38.987839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.735718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.988133Z","caller":"traceutil/trace.go:171","msg":"trace[1912528418] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"160.092649ms","start":"2026-04-20T04:50:38.828022Z","end":"2026-04-20T04:50:38.988115Z","steps":["trace[1912528418] 'count revisions from in-memory index tree' (duration: 159.474453ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:38.98815Z","caller":"traceutil/trace.go:171","msg":"trace[1795385053] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"207.153278ms","start":"2026-04-20T04:50:38.780989Z","end":"2026-04-20T04:50:38.988142Z","steps":["trace[1795385053] 'range keys from in-memory index tree' (duration: 206.557613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.987243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.073617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T04:50:38.988246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.817639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.988265Z","caller":"traceutil/trace.go:171","msg":"trace[166285363] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"192.883841ms","start":"2026-04-20T04:50:38.795375Z","end":"2026-04-20T04:50:38.988259Z","steps":["trace[166285363] 'count revisions from in-memory index tree' (duration: 192.735137ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:38.988264Z","caller":"traceutil/trace.go:171","msg":"trace[666633713] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"244.111822ms","start":"2026-04-20T04:50:38.744132Z","end":"2026-04-20T04:50:38.988244Z","steps":["trace[666633713] 'range keys from in-memory index tree' (duration: 242.966354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.98829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.828158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.988325Z","caller":"traceutil/trace.go:171","msg":"trace[1536485263] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"182.962841ms","start":"2026-04-20T04:50:38.805354Z","end":"2026-04-20T04:50:38.988317Z","steps":["trace[1536485263] 'range keys from in-memory index tree' (duration: 182.739266ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.988224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.013353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.988418Z","caller":"traceutil/trace.go:171","msg":"trace[138733958] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"193.221339ms","start":"2026-04-20T04:50:38.795189Z","end":"2026-04-20T04:50:38.988411Z","steps":["trace[138733958] 'range keys from in-memory index tree' (duration: 192.982773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.988537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.193462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.98857Z","caller":"traceutil/trace.go:171","msg":"trace[1800142560] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"172.253953ms","start":"2026-04-20T04:50:38.816307Z","end":"2026-04-20T04:50:38.988561Z","steps":["trace[1800142560] 'range keys from in-memory index tree' (duration: 172.11992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.988557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.763229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T04:50:38.988588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.353418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.988603Z","caller":"traceutil/trace.go:171","msg":"trace[471445319] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"109.81242ms","start":"2026-04-20T04:50:38.878778Z","end":"2026-04-20T04:50:38.988591Z","steps":["trace[471445319] 'range keys from in-memory index tree' (duration: 109.688446ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:38.988611Z","caller":"traceutil/trace.go:171","msg":"trace[1130388541] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"220.386859ms","start":"2026-04-20T04:50:38.768218Z","end":"2026-04-20T04:50:38.988605Z","steps":["trace[1130388541] 'count revisions from in-memory index tree' (duration: 220.324187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.988626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.617516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.988673Z","caller":"traceutil/trace.go:171","msg":"trace[2088075098] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"135.666657ms","start":"2026-04-20T04:50:38.852996Z","end":"2026-04-20T04:50:38.988662Z","steps":["trace[2088075098] 'count revisions from in-memory index tree' (duration: 135.563864ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.988732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.131358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.990265Z","caller":"traceutil/trace.go:171","msg":"trace[1980834912] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"125.686218ms","start":"2026-04-20T04:50:38.86457Z","end":"2026-04-20T04:50:38.990256Z","steps":["trace[1980834912] 'count revisions from in-memory index tree' (duration: 124.085407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.988738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.814721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.990447Z","caller":"traceutil/trace.go:171","msg":"trace[1469589599] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"137.544034ms","start":"2026-04-20T04:50:38.852895Z","end":"2026-04-20T04:50:38.990439Z","steps":["trace[1469589599] 'range keys from in-memory index tree' (duration: 135.710508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.988775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.147458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.990584Z","caller":"traceutil/trace.go:171","msg":"trace[112878402] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"125.966905ms","start":"2026-04-20T04:50:38.86461Z","end":"2026-04-20T04:50:38.990577Z","steps":["trace[112878402] 'range keys from in-memory index tree' (duration: 124.082007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:38.98894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.178019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T04:50:38.990761Z","caller":"traceutil/trace.go:171","msg":"trace[452041991] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"111.960114ms","start":"2026-04-20T04:50:38.878752Z","end":"2026-04-20T04:50:38.990713Z","steps":["trace[452041991] 'count revisions from in-memory index tree' (duration: 110.064026ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:52.095763Z","caller":"traceutil/trace.go:171","msg":"trace[2042668119] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"283.921239ms","start":"2026-04-20T04:50:51.811814Z","end":"2026-04-20T04:50:52.095736Z","steps":["trace[2042668119] 'process raft request' (duration: 275.312754ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:52.422105Z","caller":"traceutil/trace.go:171","msg":"trace[1022776605] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:369; }","duration":"223.967908ms","start":"2026-04-20T04:50:52.198105Z","end":"2026-04-20T04:50:52.422073Z","steps":["trace[1022776605] 'read index received' (duration: 221.474047ms)","trace[1022776605] 'applied index is now lower than readState.Index' (duration: 2.492841ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:50:52.422245Z","caller":"traceutil/trace.go:171","msg":"trace[2073917519] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"294.401441ms","start":"2026-04-20T04:50:52.127761Z","end":"2026-04-20T04:50:52.422162Z","steps":["trace[2073917519] 'process raft request' (duration: 291.89782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:52.422367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.250896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T04:50:52.422474Z","caller":"traceutil/trace.go:171","msg":"trace[1554612037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:358; }","duration":"224.41102ms","start":"2026-04-20T04:50:52.19804Z","end":"2026-04-20T04:50:52.422451Z","steps":["trace[1554612037] 'agreement among raft nodes before linearized reading' (duration: 224.225744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:52.422406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.05771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-20T04:50:52.422614Z","caller":"traceutil/trace.go:171","msg":"trace[503469690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:358; }","duration":"218.302477ms","start":"2026-04-20T04:50:52.204276Z","end":"2026-04-20T04:50:52.422579Z","steps":["trace[503469690] 'agreement among raft nodes before linearized reading' (duration: 218.04001ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:56.645633Z","caller":"traceutil/trace.go:171","msg":"trace[1274642571] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"195.209599ms","start":"2026-04-20T04:50:56.450395Z","end":"2026-04-20T04:50:56.645605Z","steps":["trace[1274642571] 'process raft request' (duration: 194.997173ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:56.64688Z","caller":"traceutil/trace.go:171","msg":"trace[2097929939] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"195.632338ms","start":"2026-04-20T04:50:56.451212Z","end":"2026-04-20T04:50:56.646844Z","steps":["trace[2097929939] 'process raft request' (duration: 195.058433ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:14.300678Z","caller":"traceutil/trace.go:171","msg":"trace[2050346917] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"170.466257ms","start":"2026-04-20T04:51:14.130177Z","end":"2026-04-20T04:51:14.300643Z","steps":["trace[2050346917] 'process raft request' (duration: 168.371626ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:20.157318Z","caller":"traceutil/trace.go:171","msg":"trace[636046307] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"187.032319ms","start":"2026-04-20T04:51:19.970254Z","end":"2026-04-20T04:51:20.157286Z","steps":["trace[636046307] 'process raft request' (duration: 186.868595ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:20.845691Z","caller":"traceutil/trace.go:171","msg":"trace[1900819026] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"120.604078ms","start":"2026-04-20T04:51:20.725057Z","end":"2026-04-20T04:51:20.845661Z","steps":["trace[1900819026] 'read index received' (duration: 63.105758ms)","trace[1900819026] 'applied index is now lower than readState.Index' (duration: 57.49684ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:51:20.845967Z","caller":"traceutil/trace.go:171","msg":"trace[1488002725] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"180.573129ms","start":"2026-04-20T04:51:20.665283Z","end":"2026-04-20T04:51:20.845856Z","steps":["trace[1488002725] 'process raft request' (duration: 122.863444ms)","trace[1488002725] 'compare' (duration: 56.756471ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:51:20.846055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.888568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:51:20.84613Z","caller":"traceutil/trace.go:171","msg":"trace[1610746955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"103.023531ms","start":"2026-04-20T04:51:20.743085Z","end":"2026-04-20T04:51:20.846109Z","steps":["trace[1610746955] 'agreement among raft nodes before linearized reading' (duration: 102.865187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:20.846266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.176792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-flz7z\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-20T04:51:20.846387Z","caller":"traceutil/trace.go:171","msg":"trace[1793017244] range","detail":"{range_begin:/registry/pods/kube-system/cilium-flz7z; range_end:; response_count:1; response_revision:635; }","duration":"121.325725ms","start":"2026-04-20T04:51:20.725039Z","end":"2026-04-20T04:51:20.846364Z","steps":["trace[1793017244] 'agreement among raft nodes before linearized reading' (duration: 120.863484ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:20.978252Z","caller":"traceutil/trace.go:171","msg":"trace[1624605348] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"126.120564ms","start":"2026-04-20T04:51:20.851806Z","end":"2026-04-20T04:51:20.977926Z","steps":["trace[1624605348] 'process raft request' (duration: 122.590637ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:21.04411Z","caller":"traceutil/trace.go:171","msg":"trace[1243668422] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"191.712696ms","start":"2026-04-20T04:51:20.852369Z","end":"2026-04-20T04:51:21.044081Z","steps":["trace[1243668422] 'process raft request' (duration: 191.452499ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:21.044487Z","caller":"traceutil/trace.go:171","msg":"trace[1371536293] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"191.948382ms","start":"2026-04-20T04:51:20.852472Z","end":"2026-04-20T04:51:21.04442Z","steps":["trace[1371536293] 'process raft request' (duration: 191.51233ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:21.044518Z","caller":"traceutil/trace.go:171","msg":"trace[1992537440] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"191.836389ms","start":"2026-04-20T04:51:20.852649Z","end":"2026-04-20T04:51:21.044485Z","steps":["trace[1992537440] 'process raft request' (duration: 191.656925ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:21.044859Z","caller":"traceutil/trace.go:171","msg":"trace[1219562420] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:656; }","duration":"190.323711ms","start":"2026-04-20T04:51:20.854482Z","end":"2026-04-20T04:51:21.044805Z","steps":["trace[1219562420] 'read index received' (duration: 120.120486ms)","trace[1219562420] 'applied index is now lower than readState.Index' (duration: 70.201725ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:51:21.044875Z","caller":"traceutil/trace.go:171","msg":"trace[1863165939] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"183.02797ms","start":"2026-04-20T04:51:20.861804Z","end":"2026-04-20T04:51:21.044832Z","steps":["trace[1863165939] 'process raft request' (duration: 182.878436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:21.044997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.497115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-20T04:51:21.045229Z","caller":"traceutil/trace.go:171","msg":"trace[505400230] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:641; }","duration":"190.753111ms","start":"2026-04-20T04:51:20.854458Z","end":"2026-04-20T04:51:21.045211Z","steps":["trace[505400230] 'agreement among raft nodes before linearized reading' (duration: 190.459544ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:21.044876Z","caller":"traceutil/trace.go:171","msg":"trace[1753400401] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"191.798978ms","start":"2026-04-20T04:51:20.853032Z","end":"2026-04-20T04:51:21.044831Z","steps":["trace[1753400401] 'process raft request' (duration: 191.393618ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:21.186154Z","caller":"traceutil/trace.go:171","msg":"trace[315612308] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"126.852343ms","start":"2026-04-20T04:51:21.059273Z","end":"2026-04-20T04:51:21.186125Z","steps":["trace[315612308] 'process raft request' (duration: 126.550865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:21.783307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.252335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T04:51:21.783417Z","caller":"traceutil/trace.go:171","msg":"trace[61576890] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:646; }","duration":"177.43178ms","start":"2026-04-20T04:51:21.605963Z","end":"2026-04-20T04:51:21.783395Z","steps":["trace[61576890] 'range keys from in-memory index tree' (duration: 177.009889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:43.355775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.739567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T04:51:43.355901Z","caller":"traceutil/trace.go:171","msg":"trace[606326148] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:773; }","duration":"189.916931ms","start":"2026-04-20T04:51:43.165962Z","end":"2026-04-20T04:51:43.355879Z","steps":["trace[606326148] 'range keys from in-memory index tree' (duration: 189.529862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:43.355803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.579732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-20T04:51:43.355919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.014764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T04:51:43.355981Z","caller":"traceutil/trace.go:171","msg":"trace[985933030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:773; }","duration":"191.843209ms","start":"2026-04-20T04:51:43.164116Z","end":"2026-04-20T04:51:43.355959Z","steps":["trace[985933030] 'range keys from in-memory index tree' (duration: 191.262354ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:43.356035Z","caller":"traceutil/trace.go:171","msg":"trace[546789322] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:773; }","duration":"190.204158ms","start":"2026-04-20T04:51:43.165802Z","end":"2026-04-20T04:51:43.356006Z","steps":["trace[546789322] 'range keys from in-memory index tree' (duration: 189.758197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:51:43.356047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.226113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T04:51:43.35616Z","caller":"traceutil/trace.go:171","msg":"trace[1322991278] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:773; }","duration":"189.370687ms","start":"2026-04-20T04:51:43.166759Z","end":"2026-04-20T04:51:43.356129Z","steps":["trace[1322991278] 'range keys from in-memory index tree' (duration: 189.019168ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:58.715249Z","caller":"traceutil/trace.go:171","msg":"trace[1962694515] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"197.757446ms","start":"2026-04-20T04:51:58.517465Z","end":"2026-04-20T04:51:58.715223Z","steps":["trace[1962694515] 'process raft request' (duration: 197.613423ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:51:59.056847Z","caller":"traceutil/trace.go:171","msg":"trace[1082522546] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"101.945665ms","start":"2026-04-20T04:51:58.954865Z","end":"2026-04-20T04:51:59.056811Z","steps":["trace[1082522546] 'process raft request' (duration: 101.628447ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:36.364595Z","caller":"traceutil/trace.go:171","msg":"trace[1100133606] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"116.817575ms","start":"2026-04-20T04:52:36.247745Z","end":"2026-04-20T04:52:36.364562Z","steps":["trace[1100133606] 'process raft request' (duration: 116.636161ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:38.384452Z","caller":"traceutil/trace.go:171","msg":"trace[491697011] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"212.501153ms","start":"2026-04-20T04:52:38.171916Z","end":"2026-04-20T04:52:38.384417Z","steps":["trace[491697011] 'process raft request' (duration: 211.329695ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:38.633998Z","caller":"traceutil/trace.go:171","msg":"trace[1668925277] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1466; }","duration":"231.577862ms","start":"2026-04-20T04:52:38.402391Z","end":"2026-04-20T04:52:38.633969Z","steps":["trace[1668925277] 'process raft request' (duration: 229.005319ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:38.937787Z","caller":"traceutil/trace.go:171","msg":"trace[292626930] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1511; }","duration":"293.100461ms","start":"2026-04-20T04:52:38.644648Z","end":"2026-04-20T04:52:38.937749Z","steps":["trace[292626930] 'read index received' (duration: 290.817904ms)","trace[292626930] 'applied index is now lower than readState.Index' (duration: 2.280857ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:38.937976Z","caller":"traceutil/trace.go:171","msg":"trace[217279217] transaction","detail":"{read_only:false; response_revision:1467; number_of_response:1; }","duration":"534.686727ms","start":"2026-04-20T04:52:38.403239Z","end":"2026-04-20T04:52:38.937925Z","steps":["trace[217279217] 'process raft request' (duration: 532.220316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:38.938275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.568491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/ingress-nginx-admission\" ","response":"range_response_count:1 size:1143"} {"level":"info","ts":"2026-04-20T04:52:38.9384Z","caller":"traceutil/trace.go:171","msg":"trace[1814224747] range","detail":"{range_begin:/registry/clusterroles/ingress-nginx-admission; range_end:; response_count:1; response_revision:1467; }","duration":"293.750476ms","start":"2026-04-20T04:52:38.644581Z","end":"2026-04-20T04:52:38.938331Z","steps":["trace[1814224747] 'agreement among raft nodes before linearized reading' (duration: 293.320785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:38.938989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:38.403204Z","time spent":"534.886772ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4479,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:53:04.373702Z","caller":"traceutil/trace.go:171","msg":"trace[700579101] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"356.455454ms","start":"2026-04-20T04:53:04.017221Z","end":"2026-04-20T04:53:04.373676Z","steps":["trace[700579101] 'process raft request' (duration: 356.317911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:04.373988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:53:04.017189Z","time spent":"356.71156ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:53:04.380684Z","caller":"traceutil/trace.go:171","msg":"trace[1091967941] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1927; }","duration":"220.242862ms","start":"2026-04-20T04:53:04.16041Z","end":"2026-04-20T04:53:04.380652Z","steps":["trace[1091967941] 'read index received' (duration: 213.147089ms)","trace[1091967941] 'applied index is now lower than readState.Index' (duration: 7.094073ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:04.380866Z","caller":"traceutil/trace.go:171","msg":"trace[753411698] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"362.792479ms","start":"2026-04-20T04:53:04.018042Z","end":"2026-04-20T04:53:04.380835Z","steps":["trace[753411698] 'process raft request' (duration: 362.368359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:04.38101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:53:04.018028Z","time spent":"362.931603ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:53:04.381021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.59253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-20T04:53:04.381019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.412026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T04:53:04.381142Z","caller":"traceutil/trace.go:171","msg":"trace[571698748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1856; }","duration":"220.729424ms","start":"2026-04-20T04:53:04.160388Z","end":"2026-04-20T04:53:04.381117Z","steps":["trace[571698748] 'agreement among raft nodes before linearized reading' (duration: 220.422216ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:53:04.381154Z","caller":"traceutil/trace.go:171","msg":"trace[1662946190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1856; }","duration":"187.602952ms","start":"2026-04-20T04:53:04.193531Z","end":"2026-04-20T04:53:04.381134Z","steps":["trace[1662946190] 'agreement among raft nodes before linearized reading' (duration: 187.297455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:04.381141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.725149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-20T04:53:04.381265Z","caller":"traceutil/trace.go:171","msg":"trace[991886964] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1856; }","duration":"102.905143ms","start":"2026-04-20T04:53:04.278326Z","end":"2026-04-20T04:53:04.381231Z","steps":["trace[991886964] 'agreement among raft nodes before linearized reading' (duration: 102.567935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:04.725888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.128629ms","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-04-20T04:53:04.726005Z","caller":"traceutil/trace.go:171","msg":"trace[1407040216] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:1860; }","duration":"105.333434ms","start":"2026-04-20T04:53:04.620648Z","end":"2026-04-20T04:53:04.725982Z","steps":["trace[1407040216] 'count revisions from in-memory index tree' (duration: 104.981845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:13.559803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.256099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:53:13.560006Z","caller":"traceutil/trace.go:171","msg":"trace[1862230449] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"130.889141ms","start":"2026-04-20T04:53:13.429091Z","end":"2026-04-20T04:53:13.559981Z","steps":["trace[1862230449] 'process raft request' (duration: 26.104129ms)","trace[1862230449] 'compare' (duration: 104.065035ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:16.951795Z","caller":"traceutil/trace.go:171","msg":"trace[344806550] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"107.086226ms","start":"2026-04-20T04:53:16.844684Z","end":"2026-04-20T04:53:16.95177Z","steps":["trace[344806550] 'process raft request' (duration: 106.921693ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:53:49.853044Z","caller":"traceutil/trace.go:171","msg":"trace[818282351] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2235; }","duration":"109.416572ms","start":"2026-04-20T04:53:49.743598Z","end":"2026-04-20T04:53:49.853014Z","steps":["trace[818282351] 'read index received' (duration: 109.094534ms)","trace[818282351] 'applied index is now lower than readState.Index' (duration: 320.397µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:53:49.85314Z","caller":"traceutil/trace.go:171","msg":"trace[162943599] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"142.022833ms","start":"2026-04-20T04:53:49.71107Z","end":"2026-04-20T04:53:49.853093Z","steps":["trace[162943599] 'process raft request' (duration: 141.749927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:49.853353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.72674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:53:49.853477Z","caller":"traceutil/trace.go:171","msg":"trace[1085110194] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2153; }","duration":"109.924715ms","start":"2026-04-20T04:53:49.743532Z","end":"2026-04-20T04:53:49.853457Z","steps":["trace[1085110194] 'agreement among raft nodes before linearized reading' (duration: 109.70916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.690931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":8620625986887261213,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T04:54:32.801519Z","caller":"traceutil/trace.go:171","msg":"trace[1232186118] linearizableReadLoop","detail":"{readStateIndex:2492; appliedIndex:2491; }","duration":"610.9303ms","start":"2026-04-20T04:54:32.190557Z","end":"2026-04-20T04:54:32.801487Z","steps":["trace[1232186118] 'read index received' (duration: 610.756576ms)","trace[1232186118] 'applied index is now lower than readState.Index' (duration: 173.114µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:54:32.801639Z","caller":"traceutil/trace.go:171","msg":"trace[656974942] transaction","detail":"{read_only:false; response_revision:2399; number_of_response:1; }","duration":"753.215911ms","start":"2026-04-20T04:54:32.048389Z","end":"2026-04-20T04:54:32.801605Z","steps":["trace[656974942] 'process raft request' (duration: 752.950795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.801864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:32.048345Z","time spent":"753.449316ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:54:32.801696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.114503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:54:32.802034Z","caller":"traceutil/trace.go:171","msg":"trace[970710057] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2399; }","duration":"611.503562ms","start":"2026-04-20T04:54:32.190492Z","end":"2026-04-20T04:54:32.801995Z","steps":["trace[970710057] 'agreement among raft nodes before linearized reading' (duration: 611.124863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.802152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:32.190454Z","time spent":"611.659165ms","remote":"127.0.0.1:34850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-04-20T04:54:38.462641Z","caller":"traceutil/trace.go:171","msg":"trace[712693221] linearizableReadLoop","detail":"{readStateIndex:2530; appliedIndex:2530; }","duration":"461.499795ms","start":"2026-04-20T04:54:38.001087Z","end":"2026-04-20T04:54:38.462587Z","steps":["trace[712693221] 'read index received' (duration: 461.457954ms)","trace[712693221] 'applied index is now lower than readState.Index' (duration: 38.511µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:54:38.463166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.058718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:124116"} {"level":"info","ts":"2026-04-20T04:54:38.463295Z","caller":"traceutil/trace.go:171","msg":"trace[75952054] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:2436; }","duration":"462.210982ms","start":"2026-04-20T04:54:38.001032Z","end":"2026-04-20T04:54:38.463243Z","steps":["trace[75952054] 'agreement among raft nodes before linearized reading' (duration: 461.846394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:38.463349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:38.001017Z","time spent":"462.322224ms","remote":"127.0.0.1:43602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":124140,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-04-20T04:54:38.464979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.300041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:54:38.465021Z","caller":"traceutil/trace.go:171","msg":"trace[908931425] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2437; }","duration":"408.349372ms","start":"2026-04-20T04:54:38.056663Z","end":"2026-04-20T04:54:38.465012Z","steps":["trace[908931425] 'agreement among raft nodes before linearized reading' (duration: 408.23391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:38.465045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:38.056591Z","time spent":"408.446215ms","remote":"127.0.0.1:34904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-04-20T04:54:38.465248Z","caller":"traceutil/trace.go:171","msg":"trace[265538008] transaction","detail":"{read_only:false; response_revision:2437; number_of_response:1; }","duration":"462.352655ms","start":"2026-04-20T04:54:38.002887Z","end":"2026-04-20T04:54:38.46524Z","steps":["trace[265538008] 'process raft request' (duration: 461.907695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:38.465312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:38.00286Z","time spent":"462.414846ms","remote":"127.0.0.1:43726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1351,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T04:55:14.094788Z","caller":"traceutil/trace.go:171","msg":"trace[1138791082] transaction","detail":"{read_only:false; response_revision:2654; number_of_response:1; }","duration":"255.164756ms","start":"2026-04-20T04:55:13.839594Z","end":"2026-04-20T04:55:14.094759Z","steps":["trace[1138791082] 'process raft request' (duration: 254.970501ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:55:14.170303Z","caller":"traceutil/trace.go:171","msg":"trace[2141766430] transaction","detail":"{read_only:false; response_revision:2655; number_of_response:1; }","duration":"317.864036ms","start":"2026-04-20T04:55:13.852357Z","end":"2026-04-20T04:55:14.170221Z","steps":["trace[2141766430] 'process raft request' (duration: 286.199329ms)","trace[2141766430] 'compare' (duration: 31.403901ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:55:14.170592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:55:13.852322Z","time spent":"318.128112ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:59:23.333011Z","caller":"traceutil/trace.go:171","msg":"trace[1864466357] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"136.775491ms","start":"2026-04-20T04:59:23.196172Z","end":"2026-04-20T04:59:23.332948Z","steps":["trace[1864466357] 'process raft request' (duration: 46.946493ms)","trace[1864466357] 'compare' (duration: 89.449589ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:59:24.545363Z","caller":"traceutil/trace.go:171","msg":"trace[1776107087] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"200.099053ms","start":"2026-04-20T04:59:24.345241Z","end":"2026-04-20T04:59:24.54534Z","steps":["trace[1776107087] 'process raft request' (duration: 199.95732ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:24.550299Z","caller":"traceutil/trace.go:171","msg":"trace[917535934] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"138.533804ms","start":"2026-04-20T04:59:24.411729Z","end":"2026-04-20T04:59:24.550263Z","steps":["trace[917535934] 'process raft request' (duration: 138.441191ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:24.550342Z","caller":"traceutil/trace.go:171","msg":"trace[1610086171] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"177.658516ms","start":"2026-04-20T04:59:24.372634Z","end":"2026-04-20T04:59:24.550293Z","steps":["trace[1610086171] 'process raft request' (duration: 177.333019ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:29.153761Z","caller":"traceutil/trace.go:171","msg":"trace[1364161429] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"375.057074ms","start":"2026-04-20T04:59:28.778654Z","end":"2026-04-20T04:59:29.153711Z","steps":["trace[1364161429] 'process raft request' (duration: 345.092434ms)","trace[1364161429] 'compare' (duration: 29.783516ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:59:29.154017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:59:28.778624Z","time spent":"375.27833ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:59:29.156376Z","caller":"traceutil/trace.go:171","msg":"trace[1362013310] linearizableReadLoop","detail":"{readStateIndex:5116; appliedIndex:5114; }","duration":"329.72704ms","start":"2026-04-20T04:59:28.826612Z","end":"2026-04-20T04:59:29.15634Z","steps":["trace[1362013310] 'read index received' (duration: 297.267239ms)","trace[1362013310] 'applied index is now lower than readState.Index' (duration: 32.458171ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:59:29.156469Z","caller":"traceutil/trace.go:171","msg":"trace[813603974] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"372.931972ms","start":"2026-04-20T04:59:28.783494Z","end":"2026-04-20T04:59:29.156426Z","steps":["trace[813603974] 'process raft request' (duration: 372.708287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:29.15665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:59:28.783468Z","time spent":"373.086755ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:59:29.156854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.183761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T04:59:29.156954Z","caller":"traceutil/trace.go:171","msg":"trace[1618543202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4929; }","duration":"330.407357ms","start":"2026-04-20T04:59:28.826531Z","end":"2026-04-20T04:59:29.156938Z","steps":["trace[1618543202] 'agreement among raft nodes before linearized reading' (duration: 330.073459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:29.156996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.612616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a7bf5965-4230-4462-993f-4f8d047d4c96\" ","response":"range_response_count:1 size:3600"} {"level":"warn","ts":"2026-04-20T04:59:29.156791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.024155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a7bf5965-4230-4462-993f-4f8d047d4c96\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-04-20T04:59:29.157081Z","caller":"traceutil/trace.go:171","msg":"trace[1538249237] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a7bf5965-4230-4462-993f-4f8d047d4c96; range_end:; response_count:1; response_revision:4929; }","duration":"168.738839ms","start":"2026-04-20T04:59:28.988314Z","end":"2026-04-20T04:59:29.157052Z","steps":["trace[1538249237] 'agreement among raft nodes before linearized reading' (duration: 168.588006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:29.157079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:59:28.826504Z","time spent":"330.560891ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-20T04:59:29.157123Z","caller":"traceutil/trace.go:171","msg":"trace[776810419] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a7bf5965-4230-4462-993f-4f8d047d4c96; range_end:; response_count:1; response_revision:4929; }","duration":"325.391325ms","start":"2026-04-20T04:59:28.83171Z","end":"2026-04-20T04:59:29.157101Z","steps":["trace[776810419] 'agreement among raft nodes before linearized reading' (duration: 324.912133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:29.15719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:59:28.831691Z","time spent":"325.485046ms","remote":"127.0.0.1:43716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3624,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a7bf5965-4230-4462-993f-4f8d047d4c96\" "} {"level":"warn","ts":"2026-04-20T04:59:31.170643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.526351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:26 size:822321"} {"level":"info","ts":"2026-04-20T04:59:31.170776Z","caller":"traceutil/trace.go:171","msg":"trace[1508582273] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:26; response_revision:4973; }","duration":"204.719845ms","start":"2026-04-20T04:59:30.966023Z","end":"2026-04-20T04:59:31.170743Z","steps":["trace[1508582273] 'range keys from in-memory index tree' (duration: 203.892465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:40.514699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.773838ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:59:40.514821Z","caller":"traceutil/trace.go:171","msg":"trace[1615898630] linearizableReadLoop","detail":"{readStateIndex:5333; appliedIndex:5332; }","duration":"232.874352ms","start":"2026-04-20T04:59:40.281927Z","end":"2026-04-20T04:59:40.514801Z","steps":["trace[1615898630] 'read index received' (duration: 78.632µs)","trace[1615898630] 'applied index is now lower than readState.Index' (duration: 232.79414ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:59:40.514855Z","caller":"traceutil/trace.go:171","msg":"trace[111643772] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"342.083271ms","start":"2026-04-20T04:59:40.172735Z","end":"2026-04-20T04:59:40.514818Z","steps":["trace[111643772] 'process raft request' (duration: 24.073957ms)","trace[111643772] 'compare' (duration: 317.538353ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:59:40.515029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:59:40.1727Z","time spent":"342.239685ms","remote":"127.0.0.1:43708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":524,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T04:59:40.515059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.135448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-4kvwz\" ","response":"range_response_count:1 size:7817"} {"level":"info","ts":"2026-04-20T04:59:40.515114Z","caller":"traceutil/trace.go:171","msg":"trace[124468748] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-4kvwz; range_end:; response_count:1; response_revision:5139; }","duration":"233.234ms","start":"2026-04-20T04:59:40.281864Z","end":"2026-04-20T04:59:40.515098Z","steps":["trace[124468748] 'agreement among raft nodes before linearized reading' (duration: 232.986914ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:41.089867Z","caller":"traceutil/trace.go:171","msg":"trace[965245750] transaction","detail":"{read_only:false; response_revision:5149; number_of_response:1; }","duration":"252.008713ms","start":"2026-04-20T04:59:40.837826Z","end":"2026-04-20T04:59:41.089835Z","steps":["trace[965245750] 'process raft request' (duration: 251.775172ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:41.090055Z","caller":"traceutil/trace.go:171","msg":"trace[373090556] linearizableReadLoop","detail":"{readStateIndex:5344; appliedIndex:5342; }","duration":"136.7138ms","start":"2026-04-20T04:59:40.953306Z","end":"2026-04-20T04:59:41.09002Z","steps":["trace[373090556] 'read index received' (duration: 136.267549ms)","trace[373090556] 'applied index is now lower than readState.Index' (duration: 443.531µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:59:41.090061Z","caller":"traceutil/trace.go:171","msg":"trace[5030508] transaction","detail":"{read_only:false; response_revision:5150; number_of_response:1; }","duration":"251.381972ms","start":"2026-04-20T04:59:40.838645Z","end":"2026-04-20T04:59:41.090027Z","steps":["trace[5030508] 'process raft request' (duration: 251.127001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:41.090362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.032174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-20T04:59:41.090475Z","caller":"traceutil/trace.go:171","msg":"trace[306965917] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5150; }","duration":"137.206631ms","start":"2026-04-20T04:59:40.953243Z","end":"2026-04-20T04:59:41.090449Z","steps":["trace[306965917] 'agreement among raft nodes before linearized reading' (duration: 136.864545ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:48.496236Z","caller":"traceutil/trace.go:171","msg":"trace[1696377883] linearizableReadLoop","detail":"{readStateIndex:5518; appliedIndex:5517; }","duration":"299.108661ms","start":"2026-04-20T04:59:48.197102Z","end":"2026-04-20T04:59:48.496211Z","steps":["trace[1696377883] 'read index received' (duration: 298.847619ms)","trace[1696377883] 'applied index is now lower than readState.Index' (duration: 259.942µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:59:48.496354Z","caller":"traceutil/trace.go:171","msg":"trace[1630566739] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"314.084315ms","start":"2026-04-20T04:59:48.182219Z","end":"2026-04-20T04:59:48.496303Z","steps":["trace[1630566739] 'process raft request' (duration: 313.803112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:48.496521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.793468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-93d2d534-e107-47d2-a70f-54c7aa265024\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-20T04:59:48.496572Z","caller":"traceutil/trace.go:171","msg":"trace[68293416] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-93d2d534-e107-47d2-a70f-54c7aa265024; range_end:; response_count:1; response_revision:5319; }","duration":"109.892142ms","start":"2026-04-20T04:59:48.386666Z","end":"2026-04-20T04:59:48.496558Z","steps":["trace[68293416] 'agreement among raft nodes before linearized reading' (duration: 109.708133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:48.496665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:59:48.182185Z","time spent":"314.352387ms","remote":"127.0.0.1:38998","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7598,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:59:48.497158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.361212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:59:48.497225Z","caller":"traceutil/trace.go:171","msg":"trace[1376164254] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:5319; }","duration":"300.15411ms","start":"2026-04-20T04:59:48.197055Z","end":"2026-04-20T04:59:48.497209Z","steps":["trace[1376164254] 'agreement among raft nodes before linearized reading' (duration: 299.31429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:48.49727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:59:48.197037Z","time spent":"300.219193ms","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-20T04:59:48.694315Z","caller":"traceutil/trace.go:171","msg":"trace[481359110] linearizableReadLoop","detail":"{readStateIndex:5519; appliedIndex:5518; }","duration":"162.202587ms","start":"2026-04-20T04:59:48.532084Z","end":"2026-04-20T04:59:48.694286Z","steps":["trace[481359110] 'read index received' (duration: 161.262734ms)","trace[481359110] 'applied index is now lower than readState.Index' (duration: 938.163µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:59:48.694408Z","caller":"traceutil/trace.go:171","msg":"trace[1894106809] transaction","detail":"{read_only:false; response_revision:5320; number_of_response:1; }","duration":"189.563535ms","start":"2026-04-20T04:59:48.5048Z","end":"2026-04-20T04:59:48.694364Z","steps":["trace[1894106809] 'process raft request' (duration: 188.686725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:59:48.694548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.450488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-04-20T04:59:48.694655Z","caller":"traceutil/trace.go:171","msg":"trace[1958186348] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5320; }","duration":"162.617407ms","start":"2026-04-20T04:59:48.53202Z","end":"2026-04-20T04:59:48.694637Z","steps":["trace[1958186348] 'agreement among raft nodes before linearized reading' (duration: 162.376886ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:00:37.578323Z","caller":"traceutil/trace.go:171","msg":"trace[2086494115] linearizableReadLoop","detail":"{readStateIndex:6019; appliedIndex:6018; }","duration":"100.121878ms","start":"2026-04-20T05:00:37.478151Z","end":"2026-04-20T05:00:37.578273Z","steps":["trace[2086494115] 'read index received' (duration: 29.555893ms)","trace[2086494115] 'applied index is now lower than readState.Index' (duration: 70.561895ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:00:37.578613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.439107ms","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-04-20T05:00:37.578686Z","caller":"traceutil/trace.go:171","msg":"trace[307263328] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5809; }","duration":"100.563789ms","start":"2026-04-20T05:00:37.478111Z","end":"2026-04-20T05:00:37.578675Z","steps":["trace[307263328] 'agreement among raft nodes before linearized reading' (duration: 100.243791ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:00:37.578323Z","caller":"traceutil/trace.go:171","msg":"trace[43471302] transaction","detail":"{read_only:false; response_revision:5808; number_of_response:1; }","duration":"114.079479ms","start":"2026-04-20T05:00:37.464197Z","end":"2026-04-20T05:00:37.578276Z","steps":["trace[43471302] 'process raft request' (duration: 43.593226ms)","trace[43471302] 'compare' (duration: 70.261948ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:00:38.677536Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2784} {"level":"info","ts":"2026-04-20T05:00:38.7466Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2784,"took":"66.951368ms","hash":1317615459,"current-db-size-bytes":55431168,"current-db-size":"55 MB","current-db-size-in-use-bytes":32256000,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-20T05:00:38.746676Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1317615459,"revision":2784,"compact-revision":-1} {"level":"info","ts":"2026-04-20T05:02:12.237891Z","caller":"traceutil/trace.go:171","msg":"trace[1423485147] linearizableReadLoop","detail":"{readStateIndex:6664; appliedIndex:6662; }","duration":"331.583915ms","start":"2026-04-20T05:02:11.906283Z","end":"2026-04-20T05:02:12.237867Z","steps":["trace[1423485147] 'read index received' (duration: 250.335326ms)","trace[1423485147] 'applied index is now lower than readState.Index' (duration: 81.247039ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:02:12.238004Z","caller":"traceutil/trace.go:171","msg":"trace[1574105499] transaction","detail":"{read_only:false; response_revision:6432; number_of_response:1; }","duration":"342.659925ms","start":"2026-04-20T05:02:11.895302Z","end":"2026-04-20T05:02:12.237962Z","steps":["trace[1574105499] 'process raft request' (duration: 261.304034ms)","trace[1574105499] 'compare' (duration: 80.978942ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:02:12.238077Z","caller":"traceutil/trace.go:171","msg":"trace[216806928] transaction","detail":"{read_only:false; response_revision:6434; number_of_response:1; }","duration":"292.37245ms","start":"2026-04-20T05:02:11.945683Z","end":"2026-04-20T05:02:12.238055Z","steps":["trace[216806928] 'process raft request' (duration: 292.124174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:02:12.238112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.79345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:02:12.238197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:02:11.895278Z","time spent":"342.823458ms","remote":"127.0.0.1:43576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:02:12.238327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.250069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T05:02:12.238365Z","caller":"traceutil/trace.go:171","msg":"trace[289225527] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6434; }","duration":"157.305641ms","start":"2026-04-20T05:02:12.081049Z","end":"2026-04-20T05:02:12.238354Z","steps":["trace[289225527] 'agreement among raft nodes before linearized reading' (duration: 157.225429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:02:12.238094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.748343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T05:02:12.238222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.56178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T05:02:12.238462Z","caller":"traceutil/trace.go:171","msg":"trace[1682232612] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:6434; }","duration":"193.104253ms","start":"2026-04-20T05:02:12.045311Z","end":"2026-04-20T05:02:12.238415Z","steps":["trace[1682232612] 'agreement among raft nodes before linearized reading' (duration: 192.720983ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:02:12.238509Z","caller":"traceutil/trace.go:171","msg":"trace[1701911214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6434; }","duration":"137.844178ms","start":"2026-04-20T05:02:12.100613Z","end":"2026-04-20T05:02:12.238457Z","steps":["trace[1701911214] 'agreement among raft nodes before linearized reading' (duration: 137.506809ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:02:12.238023Z","caller":"traceutil/trace.go:171","msg":"trace[215979358] transaction","detail":"{read_only:false; response_revision:6433; number_of_response:1; }","duration":"339.071808ms","start":"2026-04-20T05:02:11.898921Z","end":"2026-04-20T05:02:12.237993Z","steps":["trace[215979358] 'process raft request' (duration: 338.826472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:02:12.238648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.268158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T05:02:12.238743Z","caller":"traceutil/trace.go:171","msg":"trace[220362212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6434; }","duration":"184.388771ms","start":"2026-04-20T05:02:12.054328Z","end":"2026-04-20T05:02:12.238717Z","steps":["trace[220362212] 'agreement among raft nodes before linearized reading' (duration: 184.058092ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:02:12.238201Z","caller":"traceutil/trace.go:171","msg":"trace[1390782324] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:6434; }","duration":"331.927923ms","start":"2026-04-20T05:02:11.906252Z","end":"2026-04-20T05:02:12.23818Z","steps":["trace[1390782324] 'agreement among raft nodes before linearized reading' (duration: 331.765849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:02:12.238819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:02:11.898888Z","time spent":"339.731874ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:02:12.238843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:02:11.906239Z","time spent":"332.581019ms","remote":"127.0.0.1:33212","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"info","ts":"2026-04-20T05:05:35.7927Z","caller":"traceutil/trace.go:171","msg":"trace[1979692893] linearizableReadLoop","detail":"{readStateIndex:8334; appliedIndex:8333; }","duration":"331.63171ms","start":"2026-04-20T05:05:35.46104Z","end":"2026-04-20T05:05:35.792672Z","steps":["trace[1979692893] 'read index received' (duration: 331.373424ms)","trace[1979692893] 'applied index is now lower than readState.Index' (duration: 256.906µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:05:35.792774Z","caller":"traceutil/trace.go:171","msg":"trace[1837000039] transaction","detail":"{read_only:false; response_revision:8053; number_of_response:1; }","duration":"337.690756ms","start":"2026-04-20T05:05:35.45502Z","end":"2026-04-20T05:05:35.79271Z","steps":["trace[1837000039] 'process raft request' (duration: 337.490151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:35.792909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:35.455Z","time spent":"337.825599ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:05:35.792962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.893626ms","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-04-20T05:05:35.793097Z","caller":"traceutil/trace.go:171","msg":"trace[413764170] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8053; }","duration":"332.019019ms","start":"2026-04-20T05:05:35.461013Z","end":"2026-04-20T05:05:35.793032Z","steps":["trace[413764170] 'agreement among raft nodes before linearized reading' (duration: 331.768693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:35.793151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:35.461002Z","time spent":"332.139902ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-20T05:05:35.9668Z","caller":"traceutil/trace.go:171","msg":"trace[734934790] transaction","detail":"{read_only:false; response_revision:8055; number_of_response:1; }","duration":"104.07729ms","start":"2026-04-20T05:05:35.8627Z","end":"2026-04-20T05:05:35.966778Z","steps":["trace[734934790] 'process raft request' (duration: 103.118218ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:05:38.683737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5815} {"level":"info","ts":"2026-04-20T05:05:38.759041Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5815,"took":"73.76121ms","hash":2968837539,"current-db-size-bytes":55431168,"current-db-size":"55 MB","current-db-size-in-use-bytes":26939392,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-04-20T05:05:38.759098Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2968837539,"revision":5815,"compact-revision":2784} {"level":"info","ts":"2026-04-20T05:05:47.797508Z","caller":"traceutil/trace.go:171","msg":"trace[408263733] linearizableReadLoop","detail":"{readStateIndex:8398; appliedIndex:8397; }","duration":"382.919586ms","start":"2026-04-20T05:05:47.41439Z","end":"2026-04-20T05:05:47.79731Z","steps":["trace[408263733] 'read index received' (duration: 371.927681ms)","trace[408263733] 'applied index is now lower than readState.Index' (duration: 10.989245ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:05:47.797988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.582162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T05:05:47.798086Z","caller":"traceutil/trace.go:171","msg":"trace[1752910443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8112; }","duration":"383.729516ms","start":"2026-04-20T05:05:47.414335Z","end":"2026-04-20T05:05:47.798064Z","steps":["trace[1752910443] 'agreement among raft nodes before linearized reading' (duration: 383.4819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:47.798128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:47.41431Z","time spent":"383.809677ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T05:05:47.798136Z","caller":"traceutil/trace.go:171","msg":"trace[1187404604] transaction","detail":"{read_only:false; response_revision:8112; number_of_response:1; }","duration":"394.288441ms","start":"2026-04-20T05:05:47.403262Z","end":"2026-04-20T05:05:47.79755Z","steps":["trace[1187404604] 'process raft request' (duration: 383.036239ms)","trace[1187404604] 'compare' (duration: 10.386571ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:05:47.798364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:47.403244Z","time spent":"395.025398ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:05:47.805499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.292456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-20T05:05:47.805503Z","caller":"traceutil/trace.go:171","msg":"trace[1541198848] transaction","detail":"{read_only:false; response_revision:8114; number_of_response:1; }","duration":"372.446224ms","start":"2026-04-20T05:05:47.433037Z","end":"2026-04-20T05:05:47.805483Z","steps":["trace[1541198848] 'process raft request' (duration: 372.343821ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:05:47.8055Z","caller":"traceutil/trace.go:171","msg":"trace[527412025] transaction","detail":"{read_only:false; response_revision:8113; number_of_response:1; }","duration":"372.875313ms","start":"2026-04-20T05:05:47.432588Z","end":"2026-04-20T05:05:47.805463Z","steps":["trace[527412025] 'process raft request' (duration: 372.71477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:47.805599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.966052ms","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-04-20T05:05:47.805593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:47.433008Z","time spent":"372.541545ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:05:47.80562Z","caller":"traceutil/trace.go:171","msg":"trace[1146095857] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8114; }","duration":"382.007024ms","start":"2026-04-20T05:05:47.423607Z","end":"2026-04-20T05:05:47.805614Z","steps":["trace[1146095857] 'agreement among raft nodes before linearized reading' (duration: 381.952573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:47.805639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:47.423597Z","time spent":"382.037594ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T05:05:47.805674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:47.432566Z","time spent":"373.010937ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:05:47.805539Z","caller":"traceutil/trace.go:171","msg":"trace[339987824] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8114; }","duration":"388.353977ms","start":"2026-04-20T05:05:47.417175Z","end":"2026-04-20T05:05:47.805529Z","steps":["trace[339987824] 'agreement among raft nodes before linearized reading' (duration: 388.247664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:05:47.806314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:05:47.417162Z","time spent":"389.045284ms","remote":"127.0.0.1:43766","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-20T05:06:28.312416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.866461ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:06:28.312633Z","caller":"traceutil/trace.go:171","msg":"trace[1776112771] linearizableReadLoop","detail":"{readStateIndex:8721; appliedIndex:8719; }","duration":"264.460759ms","start":"2026-04-20T05:06:28.048152Z","end":"2026-04-20T05:06:28.312613Z","steps":["trace[1776112771] 'read index received' (duration: 122.248279ms)","trace[1776112771] 'applied index is now lower than readState.Index' (duration: 142.21106ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:06:28.312643Z","caller":"traceutil/trace.go:171","msg":"trace[1241918738] transaction","detail":"{read_only:false; response_revision:8423; number_of_response:1; }","duration":"271.893528ms","start":"2026-04-20T05:06:28.040711Z","end":"2026-04-20T05:06:28.312604Z","steps":["trace[1241918738] 'process raft request' (duration: 129.680467ms)","trace[1241918738] 'compare' (duration: 141.744449ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:06:28.312716Z","caller":"traceutil/trace.go:171","msg":"trace[1213542186] transaction","detail":"{read_only:false; response_revision:8424; number_of_response:1; }","duration":"272.00315ms","start":"2026-04-20T05:06:28.040702Z","end":"2026-04-20T05:06:28.312705Z","steps":["trace[1213542186] 'process raft request' (duration: 271.831936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:28.312935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.779887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-20T05:06:28.312972Z","caller":"traceutil/trace.go:171","msg":"trace[235182196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8424; }","duration":"264.835388ms","start":"2026-04-20T05:06:28.048128Z","end":"2026-04-20T05:06:28.312963Z","steps":["trace[235182196] 'agreement among raft nodes before linearized reading' (duration: 264.702095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:28.323435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.435672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T05:06:28.323522Z","caller":"traceutil/trace.go:171","msg":"trace[1057039703] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8425; }","duration":"202.575216ms","start":"2026-04-20T05:06:28.120929Z","end":"2026-04-20T05:06:28.323505Z","steps":["trace[1057039703] 'agreement among raft nodes before linearized reading' (duration: 202.391881ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:28.434062Z","caller":"traceutil/trace.go:171","msg":"trace[123032769] transaction","detail":"{read_only:false; response_revision:8426; number_of_response:1; }","duration":"118.17016ms","start":"2026-04-20T05:06:28.315867Z","end":"2026-04-20T05:06:28.434038Z","steps":["trace[123032769] 'process raft request' (duration: 99.201703ms)","trace[123032769] 'compare' (duration: 18.815184ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:06:28.434385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.634307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-q6948\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-04-20T05:06:28.43448Z","caller":"traceutil/trace.go:171","msg":"trace[1426990517] range","detail":"{range_begin:/registry/pods/openstack/keepalived-q6948; range_end:; response_count:1; response_revision:8426; }","duration":"112.779541ms","start":"2026-04-20T05:06:28.321682Z","end":"2026-04-20T05:06:28.434462Z","steps":["trace[1426990517] 'agreement among raft nodes before linearized reading' (duration: 112.481293ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:28.434057Z","caller":"traceutil/trace.go:171","msg":"trace[584881653] linearizableReadLoop","detail":"{readStateIndex:8723; appliedIndex:8722; }","duration":"110.736311ms","start":"2026-04-20T05:06:28.323294Z","end":"2026-04-20T05:06:28.43403Z","steps":["trace[584881653] 'read index received' (duration: 92.106732ms)","trace[584881653] 'applied index is now lower than readState.Index' (duration: 18.628029ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:06:28.448836Z","caller":"traceutil/trace.go:171","msg":"trace[1606735024] transaction","detail":"{read_only:false; response_revision:8428; number_of_response:1; }","duration":"121.764177ms","start":"2026-04-20T05:06:28.327052Z","end":"2026-04-20T05:06:28.448816Z","steps":["trace[1606735024] 'process raft request' (duration: 121.297045ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:28.449022Z","caller":"traceutil/trace.go:171","msg":"trace[1992146715] transaction","detail":"{read_only:false; response_revision:8427; number_of_response:1; }","duration":"122.005172ms","start":"2026-04-20T05:06:28.326993Z","end":"2026-04-20T05:06:28.448998Z","steps":["trace[1992146715] 'process raft request' (duration: 121.193053ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:06:29.515682Z","caller":"traceutil/trace.go:171","msg":"trace[2139280785] transaction","detail":"{read_only:false; response_revision:8432; number_of_response:1; }","duration":"337.992623ms","start":"2026-04-20T05:06:29.177664Z","end":"2026-04-20T05:06:29.515656Z","steps":["trace[2139280785] 'process raft request' (duration: 313.037651ms)","trace[2139280785] 'compare' (duration: 24.512212ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:06:29.515794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:06:29.177647Z","time spent":"338.096985ms","remote":"127.0.0.1:43628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":583,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T05:06:29.525211Z","caller":"traceutil/trace.go:171","msg":"trace[1152245514] linearizableReadLoop","detail":"{readStateIndex:8730; appliedIndex:8728; }","duration":"105.125955ms","start":"2026-04-20T05:06:29.420062Z","end":"2026-04-20T05:06:29.525188Z","steps":["trace[1152245514] 'read index received' (duration: 70.633733ms)","trace[1152245514] 'applied index is now lower than readState.Index' (duration: 34.491102ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:06:29.525392Z","caller":"traceutil/trace.go:171","msg":"trace[1698410820] transaction","detail":"{read_only:false; response_revision:8433; number_of_response:1; }","duration":"234.413105ms","start":"2026-04-20T05:06:29.290909Z","end":"2026-04-20T05:06:29.525322Z","steps":["trace[1698410820] 'process raft request' (duration: 234.178648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:06:29.525508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.375342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-20T05:06:29.525575Z","caller":"traceutil/trace.go:171","msg":"trace[1587834639] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8433; }","duration":"105.545726ms","start":"2026-04-20T05:06:29.420011Z","end":"2026-04-20T05:06:29.525557Z","steps":["trace[1587834639] 'agreement among raft nodes before linearized reading' (duration: 105.312711ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:26.680551Z","caller":"traceutil/trace.go:171","msg":"trace[1146118620] transaction","detail":"{read_only:false; response_revision:9007; number_of_response:1; }","duration":"109.238172ms","start":"2026-04-20T05:07:26.571282Z","end":"2026-04-20T05:07:26.68052Z","steps":["trace[1146118620] 'process raft request' (duration: 108.986306ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:32.696495Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000248e.wal"} {"level":"info","ts":"2026-04-20T05:07:37.125608Z","caller":"traceutil/trace.go:171","msg":"trace[1238821173] transaction","detail":"{read_only:false; response_revision:9069; number_of_response:1; }","duration":"240.142307ms","start":"2026-04-20T05:07:36.885402Z","end":"2026-04-20T05:07:37.125544Z","steps":["trace[1238821173] 'process raft request' (duration: 239.737217ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:37.130398Z","caller":"traceutil/trace.go:171","msg":"trace[395331921] transaction","detail":"{read_only:false; response_revision:9070; number_of_response:1; }","duration":"244.258816ms","start":"2026-04-20T05:07:36.886113Z","end":"2026-04-20T05:07:37.130372Z","steps":["trace[395331921] 'process raft request' (duration: 244.045191ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:07:37.130827Z","caller":"traceutil/trace.go:171","msg":"trace[705423799] linearizableReadLoop","detail":"{readStateIndex:9385; appliedIndex:9383; }","duration":"244.43324ms","start":"2026-04-20T05:07:36.886137Z","end":"2026-04-20T05:07:37.13057Z","steps":["trace[705423799] 'read index received' (duration: 239.005559ms)","trace[705423799] 'applied index is now lower than readState.Index' (duration: 5.425631ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:07:37.130953Z","caller":"traceutil/trace.go:171","msg":"trace[1302300089] transaction","detail":"{read_only:false; response_revision:9071; number_of_response:1; }","duration":"244.265626ms","start":"2026-04-20T05:07:36.886644Z","end":"2026-04-20T05:07:37.13091Z","steps":["trace[1302300089] 'process raft request' (duration: 243.680142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:07:37.131448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.294822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:28 size:244603"} {"level":"info","ts":"2026-04-20T05:07:37.131498Z","caller":"traceutil/trace.go:171","msg":"trace[536290099] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:28; response_revision:9071; }","duration":"245.405905ms","start":"2026-04-20T05:07:36.88608Z","end":"2026-04-20T05:07:37.131486Z","steps":["trace[536290099] 'agreement among raft nodes before linearized reading' (duration: 244.83844ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:08:49.486896Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"cf8c3a138c9a77a2","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T05:08:49.492016Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T05:08:49.492083Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T05:10:38.690282Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8067} {"level":"info","ts":"2026-04-20T05:10:38.766709Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8067,"took":"74.188105ms","hash":920290417,"current-db-size-bytes":55431168,"current-db-size":"55 MB","current-db-size-in-use-bytes":24489984,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-20T05:10:38.766783Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":920290417,"revision":8067,"compact-revision":5815} {"level":"info","ts":"2026-04-20T05:15:38.695816Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10500} {"level":"info","ts":"2026-04-20T05:15:38.772875Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10500,"took":"75.221301ms","hash":2372093742,"current-db-size-bytes":55431168,"current-db-size":"55 MB","current-db-size-in-use-bytes":20463616,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-20T05:15:38.772941Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2372093742,"revision":10500,"compact-revision":8067}