{"level":"warn","ts":"2026-04-22T00:22:23.271729Z","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-22T00:22:23.271803Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74: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.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-22T00:22:23.271868Z","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-22T00:22:23.27188Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-04-22T00:22:23.2719Z","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-22T00:22:23.272733Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-04-22T00:22:23.272816Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-22T00:22:23.276762Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.779842ms"} {"level":"info","ts":"2026-04-22T00:22:23.284267Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-04-22T00:22:23.284368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T00:22:23.284397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-04-22T00:22:23.284414Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T00:22:23.284426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-04-22T00:22:23.284463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-04-22T00:22:23.295181Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T00:22:23.297416Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T00:22:23.298486Z","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-22T00:22:23.301553Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T00:22:23.301812Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T00:22:23.301893Z","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-22T00:22:23.301962Z","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-22T00:22:23.301979Z","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-22T00:22:23.303534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-04-22T00:22:23.30377Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-04-22T00:22:23.307231Z","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-22T00:22:23.307725Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T00:22:23.307796Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T00:22:23.308229Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-04-22T00:22:23.30829Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-04-22T00:22:23.58722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T00:22:23.587284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T00:22:23.58731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-04-22T00:22:23.587321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-04-22T00:22:23.587339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-04-22T00:22:23.58735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-04-22T00:22:23.587358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-04-22T00:22:23.593981Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:22:23.595058Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T00:22:23.595238Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:22:23.59538Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T00:22:23.595617Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:22:23.595865Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:22:23.59595Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T00:22:23.596594Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T00:22:23.596639Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T00:22:23.599384Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T00:22:23.600552Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-04-22T00:22:28.532629Z","caller":"traceutil/trace.go:171","msg":"trace[257234011] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"113.48807ms","start":"2026-04-22T00:22:28.419085Z","end":"2026-04-22T00:22:28.532573Z","steps":["trace[257234011] 'process raft request' (duration: 41.227132ms)","trace[257234011] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/configmaps/kube-public/cluster-info; req_size:1940; } (duration: 72.125627ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:38.984646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.322246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T00:22:38.984704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.240123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-22T00:22:38.984741Z","caller":"traceutil/trace.go:171","msg":"trace[2012878868] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:409; }","duration":"146.520278ms","start":"2026-04-22T00:22:38.838204Z","end":"2026-04-22T00:22:38.984724Z","steps":["trace[2012878868] 'range keys from in-memory index tree' (duration: 146.190076ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:38.984786Z","caller":"traceutil/trace.go:171","msg":"trace[783131821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:409; }","duration":"230.353534ms","start":"2026-04-22T00:22:38.754412Z","end":"2026-04-22T00:22:38.984766Z","steps":["trace[783131821] 'range keys from in-memory index tree' (duration: 230.137203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:38.984915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.633824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-22T00:22:38.985146Z","caller":"traceutil/trace.go:171","msg":"trace[2125890486] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:409; }","duration":"148.930368ms","start":"2026-04-22T00:22:38.836128Z","end":"2026-04-22T00:22:38.985058Z","steps":["trace[2125890486] 'range keys from in-memory index tree' (duration: 148.332893ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:39.214713Z","caller":"traceutil/trace.go:171","msg":"trace[654647400] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"224.908575ms","start":"2026-04-22T00:22:38.989772Z","end":"2026-04-22T00:22:39.214681Z","steps":["trace[654647400] 'process raft request' (duration: 224.750263ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:22:39.691565Z","caller":"traceutil/trace.go:171","msg":"trace[1498533408] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"701.380389ms","start":"2026-04-22T00:22:38.990151Z","end":"2026-04-22T00:22:39.691532Z","steps":["trace[1498533408] 'process raft request' (duration: 642.59472ms)","trace[1498533408] 'compare' (duration: 58.485557ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:22:39.692148Z","caller":"traceutil/trace.go:171","msg":"trace[1780137284] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"701.003665ms","start":"2026-04-22T00:22:38.991098Z","end":"2026-04-22T00:22:39.692101Z","steps":["trace[1780137284] 'process raft request' (duration: 700.3198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:39.692158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:38.990133Z","time spent":"701.50771ms","remote":"127.0.0.1:50662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:39.692155Z","caller":"traceutil/trace.go:171","msg":"trace[2133283505] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"698.99657ms","start":"2026-04-22T00:22:38.993126Z","end":"2026-04-22T00:22:39.692122Z","steps":["trace[2133283505] 'process raft request' (duration: 698.688878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:39.692372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:38.99109Z","time spent":"701.162996ms","remote":"127.0.0.1:50662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T00:22:39.692568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:38.993105Z","time spent":"699.337983ms","remote":"127.0.0.1:50586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4645,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:22:39.753746Z","caller":"traceutil/trace.go:171","msg":"trace[1819178742] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:424; }","duration":"356.552289ms","start":"2026-04-22T00:22:39.397164Z","end":"2026-04-22T00:22:39.753716Z","steps":["trace[1819178742] 'read index received' (duration: 235.567726ms)","trace[1819178742] 'applied index is now lower than readState.Index' (duration: 120.983243ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:22:39.753959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.646242ms","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-22T00:22:39.75401Z","caller":"traceutil/trace.go:171","msg":"trace[2123391485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:414; }","duration":"192.786653ms","start":"2026-04-22T00:22:39.56121Z","end":"2026-04-22T00:22:39.753996Z","steps":["trace[2123391485] 'agreement among raft nodes before linearized reading' (duration: 192.672962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:39.754014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.818811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4374"} {"level":"info","ts":"2026-04-22T00:22:39.754139Z","caller":"traceutil/trace.go:171","msg":"trace[630334405] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:414; }","duration":"357.005712ms","start":"2026-04-22T00:22:39.397112Z","end":"2026-04-22T00:22:39.754117Z","steps":["trace[630334405] 'agreement among raft nodes before linearized reading' (duration: 356.75705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:39.754184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:39.397091Z","time spent":"357.085393ms","remote":"127.0.0.1:50570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4397,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-22T00:22:39.753931Z","caller":"traceutil/trace.go:171","msg":"trace[235215314] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"395.678084ms","start":"2026-04-22T00:22:39.358192Z","end":"2026-04-22T00:22:39.75387Z","steps":["trace[235215314] 'process raft request' (duration: 395.358192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:22:39.754509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:22:39.358171Z","time spent":"396.154728ms","remote":"127.0.0.1:50662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:23:00.028893Z","caller":"traceutil/trace.go:171","msg":"trace[368005306] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"148.604017ms","start":"2026-04-22T00:22:59.880267Z","end":"2026-04-22T00:23:00.028871Z","steps":["trace[368005306] 'process raft request' (duration: 148.16876ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:23:00.161663Z","caller":"traceutil/trace.go:171","msg":"trace[71698074] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"274.451895ms","start":"2026-04-22T00:22:59.887165Z","end":"2026-04-22T00:23:00.161617Z","steps":["trace[71698074] 'process raft request' (duration: 274.202675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:23:00.726518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.508457ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:23:00.726726Z","caller":"traceutil/trace.go:171","msg":"trace[472653399] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"492.321774ms","start":"2026-04-22T00:23:00.234384Z","end":"2026-04-22T00:23:00.726705Z","steps":["trace[472653399] 'process raft request' (duration: 262.38282ms)","trace[472653399] 'compare' (duration: 229.394062ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:23:00.726828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T00:23:00.234348Z","time spent":"492.44491ms","remote":"127.0.0.1:50662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T00:23:00.753357Z","caller":"traceutil/trace.go:171","msg":"trace[22163670] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"203.694151ms","start":"2026-04-22T00:23:00.549634Z","end":"2026-04-22T00:23:00.753328Z","steps":["trace[22163670] 'process raft request' (duration: 203.16083ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:23:36.98994Z","caller":"traceutil/trace.go:171","msg":"trace[962827996] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"103.933937ms","start":"2026-04-22T00:23:36.885974Z","end":"2026-04-22T00:23:36.989908Z","steps":["trace[962827996] 'process raft request' (duration: 81.31148ms)","trace[962827996] 'compare' (duration: 22.478853ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:23:37.000141Z","caller":"traceutil/trace.go:171","msg":"trace[2084848303] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"111.378207ms","start":"2026-04-22T00:23:36.888733Z","end":"2026-04-22T00:23:37.000111Z","steps":["trace[2084848303] 'process raft request' (duration: 111.220673ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:24:33.725547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.743284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10667"} {"level":"info","ts":"2026-04-22T00:24:33.725637Z","caller":"traceutil/trace.go:171","msg":"trace[1746339838] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1861; }","duration":"172.879037ms","start":"2026-04-22T00:24:33.552738Z","end":"2026-04-22T00:24:33.725617Z","steps":["trace[1746339838] 'range keys from in-memory index tree' (duration: 172.565961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:24:33.725716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.951695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-22T00:24:33.725799Z","caller":"traceutil/trace.go:171","msg":"trace[1166819724] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1861; }","duration":"148.087726ms","start":"2026-04-22T00:24:33.577687Z","end":"2026-04-22T00:24:33.725775Z","steps":["trace[1166819724] 'range keys from in-memory index tree' (duration: 147.71713ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:24:33.895306Z","caller":"traceutil/trace.go:171","msg":"trace[492376795] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"120.993087ms","start":"2026-04-22T00:24:33.774285Z","end":"2026-04-22T00:24:33.895278Z","steps":["trace[492376795] 'process raft request' (duration: 111.312668ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:24:33.895393Z","caller":"traceutil/trace.go:171","msg":"trace[869936507] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"120.518719ms","start":"2026-04-22T00:24:33.774838Z","end":"2026-04-22T00:24:33.895356Z","steps":["trace[869936507] 'process raft request' (duration: 120.133892ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:24:33.895598Z","caller":"traceutil/trace.go:171","msg":"trace[704278421] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"118.83498ms","start":"2026-04-22T00:24:33.776741Z","end":"2026-04-22T00:24:33.895576Z","steps":["trace[704278421] 'process raft request' (duration: 118.413492ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:24:33.895823Z","caller":"traceutil/trace.go:171","msg":"trace[336916782] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"119.740516ms","start":"2026-04-22T00:24:33.776007Z","end":"2026-04-22T00:24:33.895748Z","steps":["trace[336916782] 'process raft request' (duration: 119.101205ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:24:34.179083Z","caller":"traceutil/trace.go:171","msg":"trace[841310767] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"239.543914ms","start":"2026-04-22T00:24:33.939457Z","end":"2026-04-22T00:24:34.179Z","steps":["trace[841310767] 'process raft request' (duration: 218.928489ms)","trace[841310767] 'compare' (duration: 19.73067ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:24:48.714646Z","caller":"traceutil/trace.go:171","msg":"trace[631319697] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"143.145814ms","start":"2026-04-22T00:24:48.57147Z","end":"2026-04-22T00:24:48.714616Z","steps":["trace[631319697] 'process raft request' (duration: 142.952741ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:24:48.715923Z","caller":"traceutil/trace.go:171","msg":"trace[1668566711] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"119.07204ms","start":"2026-04-22T00:24:48.596832Z","end":"2026-04-22T00:24:48.715904Z","steps":["trace[1668566711] 'process raft request' (duration: 118.531872ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:25:12.643195Z","caller":"traceutil/trace.go:171","msg":"trace[2122271455] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"124.908781ms","start":"2026-04-22T00:25:12.518223Z","end":"2026-04-22T00:25:12.643132Z","steps":["trace[2122271455] 'process raft request' (duration: 124.519745ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:41.424736Z","caller":"traceutil/trace.go:171","msg":"trace[1502048040] transaction","detail":"{read_only:false; response_revision:2719; number_of_response:1; }","duration":"129.218659ms","start":"2026-04-22T00:26:41.295496Z","end":"2026-04-22T00:26:41.424715Z","steps":["trace[1502048040] 'process raft request' (duration: 129.068977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:41.611286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.652889ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T00:26:41.611462Z","caller":"traceutil/trace.go:171","msg":"trace[2021484595] linearizableReadLoop","detail":"{readStateIndex:2825; appliedIndex:2823; }","duration":"182.083727ms","start":"2026-04-22T00:26:41.429362Z","end":"2026-04-22T00:26:41.611446Z","steps":["trace[2021484595] 'read index received' (duration: 61.168055ms)","trace[2021484595] 'applied index is now lower than readState.Index' (duration: 120.914572ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:26:41.611579Z","caller":"traceutil/trace.go:171","msg":"trace[1346125032] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"226.484555ms","start":"2026-04-22T00:26:41.385085Z","end":"2026-04-22T00:26:41.611569Z","steps":["trace[1346125032] 'process raft request' (duration: 226.309393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:26:41.611737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.35027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:26:41.611851Z","caller":"traceutil/trace.go:171","msg":"trace[1256795183] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2721; }","duration":"182.511481ms","start":"2026-04-22T00:26:41.42932Z","end":"2026-04-22T00:26:41.611831Z","steps":["trace[1256795183] 'agreement among raft nodes before linearized reading' (duration: 182.323259ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:26:41.612145Z","caller":"traceutil/trace.go:171","msg":"trace[447174882] transaction","detail":"{read_only:false; response_revision:2720; number_of_response:1; }","duration":"227.334874ms","start":"2026-04-22T00:26:41.384252Z","end":"2026-04-22T00:26:41.611587Z","steps":["trace[447174882] 'process raft request' (duration: 106.276151ms)","trace[447174882] 'compare' (duration: 120.539628ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:30:27.573577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.088812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cd4f95cb-ed25-4aa7-8795-54161f3e0dc6\" ","response":"range_response_count:1 size:3893"} {"level":"info","ts":"2026-04-22T00:30:27.573668Z","caller":"traceutil/trace.go:171","msg":"trace[117444109] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cd4f95cb-ed25-4aa7-8795-54161f3e0dc6; range_end:; response_count:1; response_revision:4530; }","duration":"153.216394ms","start":"2026-04-22T00:30:27.420435Z","end":"2026-04-22T00:30:27.573651Z","steps":["trace[117444109] 'range keys from in-memory index tree' (duration: 153.009191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:27.574292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.182649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194894"} {"level":"info","ts":"2026-04-22T00:30:27.574373Z","caller":"traceutil/trace.go:171","msg":"trace[1916718019] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4530; }","duration":"128.30279ms","start":"2026-04-22T00:30:27.446053Z","end":"2026-04-22T00:30:27.574356Z","steps":["trace[1916718019] 'range keys from in-memory index tree' (duration: 127.128033ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:28.502481Z","caller":"traceutil/trace.go:171","msg":"trace[479296403] transaction","detail":"{read_only:false; response_revision:4539; number_of_response:1; }","duration":"161.062092ms","start":"2026-04-22T00:30:28.341398Z","end":"2026-04-22T00:30:28.50246Z","steps":["trace[479296403] 'process raft request' (duration: 151.464464ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:28.503302Z","caller":"traceutil/trace.go:171","msg":"trace[739883811] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"145.31624ms","start":"2026-04-22T00:30:28.357946Z","end":"2026-04-22T00:30:28.503262Z","steps":["trace[739883811] 'process raft request' (duration: 144.904594ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:35.628743Z","caller":"traceutil/trace.go:171","msg":"trace[2044379297] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"108.54317ms","start":"2026-04-22T00:30:35.520175Z","end":"2026-04-22T00:30:35.628718Z","steps":["trace[2044379297] 'process raft request' (duration: 61.506495ms)","trace[2044379297] 'compare' (duration: 46.905933ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:35.635828Z","caller":"traceutil/trace.go:171","msg":"trace[319813866] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"115.509845ms","start":"2026-04-22T00:30:35.520291Z","end":"2026-04-22T00:30:35.635801Z","steps":["trace[319813866] 'process raft request' (duration: 115.290202ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:35.636039Z","caller":"traceutil/trace.go:171","msg":"trace[2031121657] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"115.559996ms","start":"2026-04-22T00:30:35.520467Z","end":"2026-04-22T00:30:35.636027Z","steps":["trace[2031121657] 'process raft request' (duration: 115.228081ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:35.636107Z","caller":"traceutil/trace.go:171","msg":"trace[821077447] linearizableReadLoop","detail":"{readStateIndex:4875; appliedIndex:4872; }","duration":"114.420779ms","start":"2026-04-22T00:30:35.521629Z","end":"2026-04-22T00:30:35.63605Z","steps":["trace[821077447] 'read index received' (duration: 60.064913ms)","trace[821077447] 'applied index is now lower than readState.Index' (duration: 54.355046ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:35.636222Z","caller":"traceutil/trace.go:171","msg":"trace[749685252] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"113.289651ms","start":"2026-04-22T00:30:35.522917Z","end":"2026-04-22T00:30:35.636207Z","steps":["trace[749685252] 'process raft request' (duration: 113.038757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:35.636797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.11433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-ndp4t.18a88665957d0140\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-04-22T00:30:35.637019Z","caller":"traceutil/trace.go:171","msg":"trace[1522707717] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-ndp4t.18a88665957d0140; range_end:; response_count:1; response_revision:4696; }","duration":"115.355344ms","start":"2026-04-22T00:30:35.521654Z","end":"2026-04-22T00:30:35.63701Z","steps":["trace[1522707717] 'agreement among raft nodes before linearized reading' (duration: 115.054849ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:35.636492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.846415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1321"} {"level":"info","ts":"2026-04-22T00:30:35.637212Z","caller":"traceutil/trace.go:171","msg":"trace[1913221974] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4696; }","duration":"115.586748ms","start":"2026-04-22T00:30:35.521617Z","end":"2026-04-22T00:30:35.637204Z","steps":["trace[1913221974] 'agreement among raft nodes before linearized reading' (duration: 114.772345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:35.636979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.805325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-04-22T00:30:35.640868Z","caller":"traceutil/trace.go:171","msg":"trace[54877052] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4696; }","duration":"116.704294ms","start":"2026-04-22T00:30:35.524151Z","end":"2026-04-22T00:30:35.640855Z","steps":["trace[54877052] 'agreement among raft nodes before linearized reading' (duration: 112.777425ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:35.934374Z","caller":"traceutil/trace.go:171","msg":"trace[132619075] transaction","detail":"{read_only:false; response_revision:4699; number_of_response:1; }","duration":"223.74511ms","start":"2026-04-22T00:30:35.7106Z","end":"2026-04-22T00:30:35.934345Z","steps":["trace[132619075] 'process raft request' (duration: 209.648806ms)","trace[132619075] 'compare' (duration: 13.958892ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:35.963449Z","caller":"traceutil/trace.go:171","msg":"trace[1968355661] linearizableReadLoop","detail":"{readStateIndex:4881; appliedIndex:4879; }","duration":"169.004357ms","start":"2026-04-22T00:30:35.794426Z","end":"2026-04-22T00:30:35.96343Z","steps":["trace[1968355661] 'read index received' (duration: 125.792081ms)","trace[1968355661] 'applied index is now lower than readState.Index' (duration: 43.211526ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:35.963603Z","caller":"traceutil/trace.go:171","msg":"trace[69727920] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"164.885886ms","start":"2026-04-22T00:30:35.798706Z","end":"2026-04-22T00:30:35.963592Z","steps":["trace[69727920] 'process raft request' (duration: 164.675493ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:35.963779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.659094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-22T00:30:35.963842Z","caller":"traceutil/trace.go:171","msg":"trace[1955628281] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4701; }","duration":"253.739235ms","start":"2026-04-22T00:30:35.710085Z","end":"2026-04-22T00:30:35.963825Z","steps":["trace[1955628281] 'agreement among raft nodes before linearized reading' (duration: 253.512652ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:35.963905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.243561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"warn","ts":"2026-04-22T00:30:35.96396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.931718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:35.963948Z","caller":"traceutil/trace.go:171","msg":"trace[1434511523] transaction","detail":"{read_only:false; response_revision:4700; number_of_response:1; }","duration":"185.334436ms","start":"2026-04-22T00:30:35.778494Z","end":"2026-04-22T00:30:35.963828Z","steps":["trace[1434511523] 'process raft request' (duration: 184.760208ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:35.963988Z","caller":"traceutil/trace.go:171","msg":"trace[389168159] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4701; }","duration":"163.366842ms","start":"2026-04-22T00:30:35.800605Z","end":"2026-04-22T00:30:35.963971Z","steps":["trace[389168159] 'agreement among raft nodes before linearized reading' (duration: 163.102759ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:35.963997Z","caller":"traceutil/trace.go:171","msg":"trace[269837944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4701; }","duration":"125.006279ms","start":"2026-04-22T00:30:35.83898Z","end":"2026-04-22T00:30:35.963987Z","steps":["trace[269837944] 'agreement among raft nodes before linearized reading' (duration: 124.951578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:35.964142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.691826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-04-22T00:30:35.964218Z","caller":"traceutil/trace.go:171","msg":"trace[2140309720] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4701; }","duration":"238.818329ms","start":"2026-04-22T00:30:35.72538Z","end":"2026-04-22T00:30:35.964199Z","steps":["trace[2140309720] 'agreement among raft nodes before linearized reading' (duration: 238.547255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:35.966595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.19234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194894"} {"level":"info","ts":"2026-04-22T00:30:35.966676Z","caller":"traceutil/trace.go:171","msg":"trace[1842969656] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4701; }","duration":"215.302801ms","start":"2026-04-22T00:30:35.751352Z","end":"2026-04-22T00:30:35.966655Z","steps":["trace[1842969656] 'agreement among raft nodes before linearized reading' (duration: 212.339776ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:36.561111Z","caller":"traceutil/trace.go:171","msg":"trace[986371848] transaction","detail":"{read_only:false; response_revision:4712; number_of_response:1; }","duration":"130.356828ms","start":"2026-04-22T00:30:36.430726Z","end":"2026-04-22T00:30:36.561083Z","steps":["trace[986371848] 'process raft request' (duration: 125.131019ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:36.589914Z","caller":"traceutil/trace.go:171","msg":"trace[661595936] linearizableReadLoop","detail":"{readStateIndex:4895; appliedIndex:4893; }","duration":"156.018918ms","start":"2026-04-22T00:30:36.433873Z","end":"2026-04-22T00:30:36.589892Z","steps":["trace[661595936] 'read index received' (duration: 121.993952ms)","trace[661595936] 'applied index is now lower than readState.Index' (duration: 34.024076ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:36.590074Z","caller":"traceutil/trace.go:171","msg":"trace[1618203450] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"156.581646ms","start":"2026-04-22T00:30:36.433463Z","end":"2026-04-22T00:30:36.590044Z","steps":["trace[1618203450] 'process raft request' (duration: 156.219131ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:36.590052Z","caller":"traceutil/trace.go:171","msg":"trace[995638152] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"132.258637ms","start":"2026-04-22T00:30:36.457766Z","end":"2026-04-22T00:30:36.590024Z","steps":["trace[995638152] 'process raft request' (duration: 132.022883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:36.591771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.879655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T00:30:36.59183Z","caller":"traceutil/trace.go:171","msg":"trace[2033915585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4715; }","duration":"157.997237ms","start":"2026-04-22T00:30:36.433819Z","end":"2026-04-22T00:30:36.591816Z","steps":["trace[2033915585] 'agreement among raft nodes before linearized reading' (duration: 156.298982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:36.627702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.041585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:36.627773Z","caller":"traceutil/trace.go:171","msg":"trace[1458223826] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:4717; }","duration":"111.152036ms","start":"2026-04-22T00:30:36.5166Z","end":"2026-04-22T00:30:36.627752Z","steps":["trace[1458223826] 'agreement among raft nodes before linearized reading' (duration: 111.036894ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:30:36.80219Z","caller":"traceutil/trace.go:171","msg":"trace[751140023] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"170.67203ms","start":"2026-04-22T00:30:36.631483Z","end":"2026-04-22T00:30:36.802155Z","steps":["trace[751140023] 'process raft request' (duration: 128.896486ms)","trace[751140023] 'compare' (duration: 41.106433ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T00:30:41.172299Z","caller":"traceutil/trace.go:171","msg":"trace[1677797287] transaction","detail":"{read_only:false; response_revision:4795; number_of_response:1; }","duration":"104.690319ms","start":"2026-04-22T00:30:41.067589Z","end":"2026-04-22T00:30:41.172279Z","steps":["trace[1677797287] 'process raft request' (duration: 104.567337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:48.973839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.552097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T00:30:48.973942Z","caller":"traceutil/trace.go:171","msg":"trace[1412432541] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4896; }","duration":"172.69787ms","start":"2026-04-22T00:30:48.801221Z","end":"2026-04-22T00:30:48.973919Z","steps":["trace[1412432541] 'range keys from in-memory index tree' (duration: 172.366694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:48.973937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.678197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T00:30:48.97401Z","caller":"traceutil/trace.go:171","msg":"trace[1684904303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4896; }","duration":"133.758718ms","start":"2026-04-22T00:30:48.840233Z","end":"2026-04-22T00:30:48.973991Z","steps":["trace[1684904303] 'range keys from in-memory index tree' (duration: 133.566816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T00:30:48.974313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.521311ms","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-22T00:30:48.974353Z","caller":"traceutil/trace.go:171","msg":"trace[1201457446] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4896; }","duration":"124.592962ms","start":"2026-04-22T00:30:48.84975Z","end":"2026-04-22T00:30:48.974343Z","steps":["trace[1201457446] 'range keys from in-memory index tree' (duration: 123.86516ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:19.352221Z","caller":"traceutil/trace.go:171","msg":"trace[1836041023] linearizableReadLoop","detail":"{readStateIndex:5385; appliedIndex:5384; }","duration":"135.277732ms","start":"2026-04-22T00:31:19.216919Z","end":"2026-04-22T00:31:19.352197Z","steps":["trace[1836041023] 'read index received' (duration: 135.106169ms)","trace[1836041023] 'applied index is now lower than readState.Index' (duration: 170.323µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T00:31:19.3526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.666068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-22T00:31:19.352632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.694997ms","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-22T00:31:19.35269Z","caller":"traceutil/trace.go:171","msg":"trace[216682733] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5189; }","duration":"133.797369ms","start":"2026-04-22T00:31:19.218879Z","end":"2026-04-22T00:31:19.352677Z","steps":["trace[216682733] 'agreement among raft nodes before linearized reading' (duration: 133.557256ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:19.352725Z","caller":"traceutil/trace.go:171","msg":"trace[1762494266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5189; }","duration":"135.84232ms","start":"2026-04-22T00:31:19.216864Z","end":"2026-04-22T00:31:19.352707Z","steps":["trace[1762494266] 'agreement among raft nodes before linearized reading' (duration: 135.548426ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:31:19.352975Z","caller":"traceutil/trace.go:171","msg":"trace[667724265] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"136.789362ms","start":"2026-04-22T00:31:19.216173Z","end":"2026-04-22T00:31:19.352963Z","steps":["trace[667724265] 'process raft request' (duration: 135.832989ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T00:32:23.743719Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2941} {"level":"info","ts":"2026-04-22T00:32:23.83144Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2941,"took":"86.419491ms","hash":1989402385,"current-db-size-bytes":54173696,"current-db-size":"54 MB","current-db-size-in-use-bytes":29638656,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-22T00:32:23.831835Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1989402385,"revision":2941,"compact-revision":-1} {"level":"info","ts":"2026-04-22T00:37:23.750922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5661} {"level":"info","ts":"2026-04-22T00:37:23.871447Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5661,"took":"119.401171ms","hash":2947808794,"current-db-size-bytes":54173696,"current-db-size":"54 MB","current-db-size-in-use-bytes":18362368,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-22T00:37:23.87149Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2947808794,"revision":5661,"compact-revision":2941}