{"level":"warn","ts":"2026-06-28T19:49:20.69127Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T19:49:20.691367Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-28T19:49:20.691451Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-28T19:49:20.691463Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-06-28T19:49:20.691492Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-28T19:49:20.694032Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-06-28T19:49:20.694149Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-28T19:49:20.70848Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.057788ms"} {"level":"info","ts":"2026-06-28T19:49:20.744809Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-06-28T19:49:20.744917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-06-28T19:49:20.744946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-06-28T19:49:20.744962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-28T19:49:20.744976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-06-28T19:49:20.745043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-06-28T19:49:20.774873Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-28T19:49:20.781415Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-28T19:49:20.789389Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-28T19:49:20.796515Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-28T19:49:20.79668Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-28T19:49:20.798905Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-28T19:49:20.799059Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-28T19:49:20.799132Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-28T19:49:20.806853Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-28T19:49:20.806964Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-06-28T19:49:20.807095Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-28T19:49:20.807108Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-06-28T19:49:20.807169Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-28T19:49:20.807406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-06-28T19:49:20.807585Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-06-28T19:49:21.045834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-06-28T19:49:21.045897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-28T19:49:21.045935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-06-28T19:49:21.045954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-06-28T19:49:21.045964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-06-28T19:49:21.045979Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-06-28T19:49:21.045991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-06-28T19:49:21.047152Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:49:21.048359Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-06-28T19:49:21.04863Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:49:21.048642Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-28T19:49:21.048858Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-28T19:49:21.048877Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-28T19:49:21.050684Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-06-28T19:49:21.051959Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-28T19:49:21.053407Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:49:21.053578Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-28T19:49:21.053673Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-06-28T19:49:43.899385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.611155ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:49:43.899611Z","caller":"traceutil/trace.go:171","msg":"trace[446858629] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:394; }","duration":"165.851612ms","start":"2026-06-28T19:49:43.733734Z","end":"2026-06-28T19:49:43.899586Z","steps":["trace[446858629] 'range keys from in-memory index tree' (duration: 165.587784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:49:43.900263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.244473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:49:43.900508Z","caller":"traceutil/trace.go:171","msg":"trace[1190527655] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"224.790017ms","start":"2026-06-28T19:49:43.675702Z","end":"2026-06-28T19:49:43.900492Z","steps":["trace[1190527655] 'process raft request' (duration: 224.749814ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:43.900577Z","caller":"traceutil/trace.go:171","msg":"trace[2019379042] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"224.955909ms","start":"2026-06-28T19:49:43.675589Z","end":"2026-06-28T19:49:43.900544Z","steps":["trace[2019379042] 'process raft request' (duration: 224.796527ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:49:43.900632Z","caller":"traceutil/trace.go:171","msg":"trace[2001291467] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"227.50814ms","start":"2026-06-28T19:49:43.673088Z","end":"2026-06-28T19:49:43.900596Z","steps":["trace[2001291467] 'process raft request' (duration: 92.300689ms)","trace[2001291467] 'compare' (duration: 134.071421ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:50:03.128261Z","caller":"traceutil/trace.go:171","msg":"trace[1335109660] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"316.447468ms","start":"2026-06-28T19:50:02.811786Z","end":"2026-06-28T19:50:03.128233Z","steps":["trace[1335109660] 'read index received' (duration: 314.464384ms)","trace[1335109660] 'applied index is now lower than readState.Index' (duration: 1.982114ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:50:03.128306Z","caller":"traceutil/trace.go:171","msg":"trace[2132036211] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"344.614425ms","start":"2026-06-28T19:50:02.783675Z","end":"2026-06-28T19:50:03.128289Z","steps":["trace[2132036211] 'process raft request' (duration: 342.860276ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:50:03.129789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.209712ms","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-06-28T19:50:03.129874Z","caller":"traceutil/trace.go:171","msg":"trace[1339228885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:590; }","duration":"237.326519ms","start":"2026-06-28T19:50:02.892523Z","end":"2026-06-28T19:50:03.12985Z","steps":["trace[1339228885] 'agreement among raft nodes before linearized reading' (duration: 235.888662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:50:03.129756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.932264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-mfqtj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-28T19:50:03.130264Z","caller":"traceutil/trace.go:171","msg":"trace[1311245771] range","detail":"{range_begin:/registry/pods/kube-system/cilium-mfqtj; range_end:; response_count:1; response_revision:590; }","duration":"318.484932ms","start":"2026-06-28T19:50:02.811755Z","end":"2026-06-28T19:50:03.13024Z","steps":["trace[1311245771] 'agreement among raft nodes before linearized reading' (duration: 316.605215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:50:03.130312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:50:02.811741Z","time spent":"318.558379ms","remote":"127.0.0.1:35396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-mfqtj\" "} {"level":"warn","ts":"2026-06-28T19:50:03.130993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:50:02.783653Z","time spent":"344.692424ms","remote":"127.0.0.1:35318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:50:03.616326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.166998ms","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-06-28T19:50:03.6164Z","caller":"traceutil/trace.go:171","msg":"trace[1743347685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"132.286655ms","start":"2026-06-28T19:50:03.484096Z","end":"2026-06-28T19:50:03.616383Z","steps":["trace[1743347685] 'range keys from in-memory index tree' (duration: 132.004881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:50:17.690254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.902306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:50:17.69037Z","caller":"traceutil/trace.go:171","msg":"trace[2115974714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:754; }","duration":"144.026425ms","start":"2026-06-28T19:50:17.546313Z","end":"2026-06-28T19:50:17.690339Z","steps":["trace[2115974714] 'range keys from in-memory index tree' (duration: 143.741926ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:45.543472Z","caller":"traceutil/trace.go:171","msg":"trace[205932289] transaction","detail":"{read_only:false; response_revision:1146; number_of_response:1; }","duration":"150.642967ms","start":"2026-06-28T19:50:45.39279Z","end":"2026-06-28T19:50:45.543433Z","steps":["trace[205932289] 'process raft request' (duration: 150.409623ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:50:45.5449Z","caller":"traceutil/trace.go:171","msg":"trace[1705476887] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"151.301919ms","start":"2026-06-28T19:50:45.39357Z","end":"2026-06-28T19:50:45.544872Z","steps":["trace[1705476887] 'process raft request' (duration: 151.083635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:51:09.314279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.07654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-28T19:51:09.314382Z","caller":"traceutil/trace.go:171","msg":"trace[249858897] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1409; }","duration":"103.242465ms","start":"2026-06-28T19:51:09.211119Z","end":"2026-06-28T19:51:09.314362Z","steps":["trace[249858897] 'range keys from in-memory index tree' (duration: 102.881283ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:09.431085Z","caller":"traceutil/trace.go:171","msg":"trace[714214926] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"111.970111ms","start":"2026-06-28T19:51:09.319081Z","end":"2026-06-28T19:51:09.431051Z","steps":["trace[714214926] 'process raft request' (duration: 111.797745ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:39.81266Z","caller":"traceutil/trace.go:171","msg":"trace[415698394] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"211.110592ms","start":"2026-06-28T19:51:39.601524Z","end":"2026-06-28T19:51:39.812635Z","steps":["trace[415698394] 'process raft request' (duration: 210.932174ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:39.974156Z","caller":"traceutil/trace.go:171","msg":"trace[458445126] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"156.337525ms","start":"2026-06-28T19:51:39.817794Z","end":"2026-06-28T19:51:39.974131Z","steps":["trace[458445126] 'process raft request' (duration: 156.141937ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:39.987232Z","caller":"traceutil/trace.go:171","msg":"trace[1723505920] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"167.664775ms","start":"2026-06-28T19:51:39.819543Z","end":"2026-06-28T19:51:39.987208Z","steps":["trace[1723505920] 'process raft request' (duration: 167.025817ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:51:40.349951Z","caller":"traceutil/trace.go:171","msg":"trace[735261277] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"100.826277ms","start":"2026-06-28T19:51:40.249097Z","end":"2026-06-28T19:51:40.349923Z","steps":["trace[735261277] 'process raft request' (duration: 100.622438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:52:15.593554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.752053ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:52:15.593677Z","caller":"traceutil/trace.go:171","msg":"trace[1670164901] transaction","detail":"{read_only:false; response_revision:2082; number_of_response:1; }","duration":"170.197051ms","start":"2026-06-28T19:52:15.423461Z","end":"2026-06-28T19:52:15.593658Z","steps":["trace[1670164901] 'compare' (duration: 163.644148ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:52:15.613874Z","caller":"traceutil/trace.go:171","msg":"trace[1109630832] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"110.464674ms","start":"2026-06-28T19:52:15.503394Z","end":"2026-06-28T19:52:15.613859Z","steps":["trace[1109630832] 'process raft request' (duration: 109.971028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:53:52.229898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.839878ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-28T19:53:52.23003Z","caller":"traceutil/trace.go:171","msg":"trace[529087548] transaction","detail":"{read_only:false; response_revision:2711; number_of_response:1; }","duration":"250.399067ms","start":"2026-06-28T19:53:51.97961Z","end":"2026-06-28T19:53:52.23001Z","steps":["trace[529087548] 'process raft request' (duration: 118.352956ms)","trace[529087548] 'compare' (duration: 131.69212ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:40.306239Z","caller":"traceutil/trace.go:171","msg":"trace[673134439] transaction","detail":"{read_only:false; response_revision:4528; number_of_response:1; }","duration":"121.179026ms","start":"2026-06-28T19:57:40.185042Z","end":"2026-06-28T19:57:40.306221Z","steps":["trace[673134439] 'process raft request' (duration: 121.043011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:50.47834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.08356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-28T19:57:50.478452Z","caller":"traceutil/trace.go:171","msg":"trace[1031035805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4727; }","duration":"121.266928ms","start":"2026-06-28T19:57:50.357163Z","end":"2026-06-28T19:57:50.47843Z","steps":["trace[1031035805] 'range keys from in-memory index tree' (duration: 120.878302ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:50.585803Z","caller":"traceutil/trace.go:171","msg":"trace[886949444] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"101.50684ms","start":"2026-06-28T19:57:50.484269Z","end":"2026-06-28T19:57:50.585776Z","steps":["trace[886949444] 'process raft request' (duration: 101.358104ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:50.656435Z","caller":"traceutil/trace.go:171","msg":"trace[85232591] transaction","detail":"{read_only:false; response_revision:4729; number_of_response:1; }","duration":"163.590959ms","start":"2026-06-28T19:57:50.492819Z","end":"2026-06-28T19:57:50.65641Z","steps":["trace[85232591] 'process raft request' (duration: 163.441393ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:51.014613Z","caller":"traceutil/trace.go:171","msg":"trace[1923711789] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"177.173182ms","start":"2026-06-28T19:57:50.837407Z","end":"2026-06-28T19:57:51.014581Z","steps":["trace[1923711789] 'process raft request' (duration: 97.482873ms)","trace[1923711789] 'compare' (duration: 79.552963ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:51.056978Z","caller":"traceutil/trace.go:171","msg":"trace[937570505] transaction","detail":"{read_only:false; response_revision:4732; number_of_response:1; }","duration":"174.223765ms","start":"2026-06-28T19:57:50.882733Z","end":"2026-06-28T19:57:51.056957Z","steps":["trace[937570505] 'process raft request' (duration: 174.091139ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:57:51.057203Z","caller":"traceutil/trace.go:171","msg":"trace[61762056] linearizableReadLoop","detail":"{readStateIndex:4916; appliedIndex:4913; }","duration":"158.173291ms","start":"2026-06-28T19:57:50.899003Z","end":"2026-06-28T19:57:51.057177Z","steps":["trace[61762056] 'read index received' (duration: 35.891835ms)","trace[61762056] 'applied index is now lower than readState.Index' (duration: 122.279136ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:57:51.057324Z","caller":"traceutil/trace.go:171","msg":"trace[891324440] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"167.624361ms","start":"2026-06-28T19:57:50.889676Z","end":"2026-06-28T19:57:51.0573Z","steps":["trace[891324440] 'process raft request' (duration: 167.237155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:51.057555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.526025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-28T19:57:51.057645Z","caller":"traceutil/trace.go:171","msg":"trace[1562016274] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4733; }","duration":"158.63558ms","start":"2026-06-28T19:57:50.898975Z","end":"2026-06-28T19:57:51.05761Z","steps":["trace[1562016274] 'agreement among raft nodes before linearized reading' (duration: 158.363008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:57:51.062074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.721392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:57:51.062132Z","caller":"traceutil/trace.go:171","msg":"trace[17526766] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:4734; }","duration":"142.806935ms","start":"2026-06-28T19:57:50.91931Z","end":"2026-06-28T19:57:51.062116Z","steps":["trace[17526766] 'agreement among raft nodes before linearized reading' (duration: 142.359986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:03.86235Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398341691695240553,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-28T19:58:04.044993Z","caller":"traceutil/trace.go:171","msg":"trace[2065235692] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"726.922078ms","start":"2026-06-28T19:58:03.318045Z","end":"2026-06-28T19:58:04.044967Z","steps":["trace[2065235692] 'process raft request' (duration: 726.709409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:04.045162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:03.318011Z","time spent":"727.063565ms","remote":"127.0.0.1:35396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-28T19:58:04.050801Z","caller":"traceutil/trace.go:171","msg":"trace[429744516] linearizableReadLoop","detail":"{readStateIndex:5103; appliedIndex:5101; }","duration":"688.563523ms","start":"2026-06-28T19:58:03.362205Z","end":"2026-06-28T19:58:04.050769Z","steps":["trace[429744516] 'read index received' (duration: 682.535466ms)","trace[429744516] 'applied index is now lower than readState.Index' (duration: 6.026407ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:04.051213Z","caller":"traceutil/trace.go:171","msg":"trace[1430984603] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"427.316184ms","start":"2026-06-28T19:58:03.623878Z","end":"2026-06-28T19:58:04.051195Z","steps":["trace[1430984603] 'process raft request' (duration: 426.728179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:04.051369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:03.623854Z","time spent":"427.414469ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-28T19:58:04.051654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.437021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-28T19:58:04.05171Z","caller":"traceutil/trace.go:171","msg":"trace[612835814] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:4916; }","duration":"689.523215ms","start":"2026-06-28T19:58:03.362172Z","end":"2026-06-28T19:58:04.051695Z","steps":["trace[612835814] 'agreement among raft nodes before linearized reading' (duration: 689.436941ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:04.051789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:03.362155Z","time spent":"689.615249ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true "} {"level":"warn","ts":"2026-06-28T19:58:04.05253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.669683ms","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-06-28T19:58:04.05264Z","caller":"traceutil/trace.go:171","msg":"trace[1682751756] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4916; }","duration":"129.781028ms","start":"2026-06-28T19:58:03.922832Z","end":"2026-06-28T19:58:04.052614Z","steps":["trace[1682751756] 'agreement among raft nodes before linearized reading' (duration: 129.547868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:04.052547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.205035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-28T19:58:04.052891Z","caller":"traceutil/trace.go:171","msg":"trace[99784601] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4916; }","duration":"357.594421ms","start":"2026-06-28T19:58:03.695283Z","end":"2026-06-28T19:58:04.052878Z","steps":["trace[99784601] 'agreement among raft nodes before linearized reading' (duration: 357.114271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:04.052955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:03.695271Z","time spent":"357.657314ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-28T19:58:04.053181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.319788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-28T19:58:04.054105Z","caller":"traceutil/trace.go:171","msg":"trace[1584875440] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4916; }","duration":"682.432942ms","start":"2026-06-28T19:58:03.370817Z","end":"2026-06-28T19:58:04.05325Z","steps":["trace[1584875440] 'agreement among raft nodes before linearized reading' (duration: 681.146007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:04.054148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-28T19:58:03.370799Z","time spent":"683.339191ms","remote":"127.0.0.1:35368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-28T19:58:04.245304Z","caller":"traceutil/trace.go:171","msg":"trace[1028526897] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"190.611414ms","start":"2026-06-28T19:58:04.054639Z","end":"2026-06-28T19:58:04.24525Z","steps":["trace[1028526897] 'process raft request' (duration: 143.650328ms)","trace[1028526897] 'compare' (duration: 46.652683ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:04.278591Z","caller":"traceutil/trace.go:171","msg":"trace[368665526] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"223.799953ms","start":"2026-06-28T19:58:04.054769Z","end":"2026-06-28T19:58:04.278569Z","steps":["trace[368665526] 'process raft request' (duration: 223.606445ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:04.27902Z","caller":"traceutil/trace.go:171","msg":"trace[387814119] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"222.488757ms","start":"2026-06-28T19:58:04.056517Z","end":"2026-06-28T19:58:04.279006Z","steps":["trace[387814119] 'process raft request' (duration: 222.378242ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:04.279117Z","caller":"traceutil/trace.go:171","msg":"trace[886417235] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"221.815078ms","start":"2026-06-28T19:58:04.057295Z","end":"2026-06-28T19:58:04.27911Z","steps":["trace[886417235] 'process raft request' (duration: 221.645251ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:04.279088Z","caller":"traceutil/trace.go:171","msg":"trace[591632120] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"222.726477ms","start":"2026-06-28T19:58:04.056334Z","end":"2026-06-28T19:58:04.27906Z","steps":["trace[591632120] 'process raft request' (duration: 222.178304ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:04.279016Z","caller":"traceutil/trace.go:171","msg":"trace[371004884] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"222.57553ms","start":"2026-06-28T19:58:04.056415Z","end":"2026-06-28T19:58:04.278991Z","steps":["trace[371004884] 'process raft request' (duration: 222.354091ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:04.279424Z","caller":"traceutil/trace.go:171","msg":"trace[1250688850] linearizableReadLoop","detail":"{readStateIndex:5109; appliedIndex:5103; }","duration":"221.956694ms","start":"2026-06-28T19:58:04.057456Z","end":"2026-06-28T19:58:04.279413Z","steps":["trace[1250688850] 'read index received' (duration: 140.908801ms)","trace[1250688850] 'applied index is now lower than readState.Index' (duration: 81.046813ms)"],"step_count":2} {"level":"info","ts":"2026-06-28T19:58:04.279492Z","caller":"traceutil/trace.go:171","msg":"trace[1296948623] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"220.179368ms","start":"2026-06-28T19:58:04.059305Z","end":"2026-06-28T19:58:04.279484Z","steps":["trace[1296948623] 'process raft request' (duration: 220.057623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:04.279703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.30968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-06-28T19:58:04.279757Z","caller":"traceutil/trace.go:171","msg":"trace[1634797163] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4924; }","duration":"211.388372ms","start":"2026-06-28T19:58:04.068355Z","end":"2026-06-28T19:58:04.279744Z","steps":["trace[1634797163] 'agreement among raft nodes before linearized reading' (duration: 211.240076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-28T19:58:04.280026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.549969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-f2c72961-6181-44e4-9acb-9444e93065a0\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-28T19:58:04.280064Z","caller":"traceutil/trace.go:171","msg":"trace[1442557823] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"221.63169ms","start":"2026-06-28T19:58:04.058416Z","end":"2026-06-28T19:58:04.280048Z","steps":["trace[1442557823] 'process raft request' (duration: 220.667319ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:58:04.280083Z","caller":"traceutil/trace.go:171","msg":"trace[2134485639] range","detail":"{range_begin:/registry/persistentvolumes/pvc-f2c72961-6181-44e4-9acb-9444e93065a0; range_end:; response_count:1; response_revision:4924; }","duration":"222.662584ms","start":"2026-06-28T19:58:04.057403Z","end":"2026-06-28T19:58:04.280066Z","steps":["trace[2134485639] 'agreement among raft nodes before linearized reading' (duration: 222.232586ms)"],"step_count":1} {"level":"info","ts":"2026-06-28T19:59:21.295377Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2864} {"level":"info","ts":"2026-06-28T19:59:21.376716Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2864,"took":"80.130888ms","hash":1070289950,"current-db-size-bytes":54276096,"current-db-size":"54 MB","current-db-size-in-use-bytes":29315072,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-28T19:59:21.376831Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1070289950,"revision":2864,"compact-revision":-1} {"level":"info","ts":"2026-06-28T20:04:21.303039Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5549} {"level":"info","ts":"2026-06-28T20:04:21.383274Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5549,"took":"79.099608ms","hash":2557763272,"current-db-size-bytes":54276096,"current-db-size":"54 MB","current-db-size-in-use-bytes":18272256,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-28T20:04:21.383342Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2557763272,"revision":5549,"compact-revision":2864}