{"level":"warn","ts":"2026-04-08T10:47:27.828795Z","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-08T10:47:27.828896Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.69: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.69:2380","--initial-cluster=instance=https://199.204.45.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.69: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-08T10:47:27.829004Z","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-08T10:47:27.829015Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-04-08T10:47:27.829039Z","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-08T10:47:27.8298Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"]} {"level":"info","ts":"2026-04-08T10:47:27.829888Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.69: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-08T10:47:27.833846Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.69114ms"} {"level":"info","ts":"2026-04-08T10:47:27.847196Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe334179879fd0aa","cluster-id":"d79a8cccc23ced73"} {"level":"info","ts":"2026-04-08T10:47:27.847331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T10:47:27.847369Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 0"} {"level":"info","ts":"2026-04-08T10:47:27.847394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fe334179879fd0aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T10:47:27.847417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 1"} {"level":"info","ts":"2026-04-08T10:47:27.847484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"warn","ts":"2026-04-08T10:47:27.854998Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T10:47:27.856526Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T10:47:27.85783Z","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-08T10:47:27.861032Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fe334179879fd0aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T10:47:27.861182Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fe334179879fd0aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T10:47:27.861468Z","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-08T10:47:27.861558Z","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-08T10:47:27.861576Z","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-08T10:47:27.862356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"info","ts":"2026-04-08T10:47:27.862475Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","added-peer-id":"fe334179879fd0aa","added-peer-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-04-08T10:47:27.867301Z","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-08T10:47:27.867408Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-04-08T10:47:27.867438Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-04-08T10:47:27.867673Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fe334179879fd0aa","initial-advertise-peer-urls":["https://199.204.45.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T10:47:27.86772Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T10:47:28.14823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T10:47:28.148298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T10:47:28.148334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgPreVoteResp from fe334179879fd0aa at term 1"} {"level":"info","ts":"2026-04-08T10:47:28.148353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became candidate at term 2"} {"level":"info","ts":"2026-04-08T10:47:28.148374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgVoteResp from fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-04-08T10:47:28.148396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became leader at term 2"} {"level":"info","ts":"2026-04-08T10:47:28.14841Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe334179879fd0aa elected leader fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-04-08T10:47:28.149659Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fe334179879fd0aa","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.69:2379]}","request-path":"/0/members/fe334179879fd0aa/attributes","cluster-id":"d79a8cccc23ced73","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T10:47:28.149743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T10:47:28.150057Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T10:47:28.150235Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T10:47:28.150277Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T10:47:28.150228Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:28.152348Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:28.15246Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:28.152499Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T10:47:28.15325Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T10:47:28.158718Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.69:2379"} {"level":"warn","ts":"2026-04-08T10:47:46.829162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.817107ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-08T10:47:46.829305Z","caller":"traceutil/trace.go:171","msg":"trace[677065444] linearizableReadLoop","detail":"{readStateIndex:461; appliedIndex:460; }","duration":"201.238205ms","start":"2026-04-08T10:47:46.628049Z","end":"2026-04-08T10:47:46.829287Z","steps":["trace[677065444] 'read index received' (duration: 35.041µs)","trace[677065444] 'applied index is now lower than readState.Index' (duration: 201.201784ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:47:46.829427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.373537ms","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-08T10:47:46.82946Z","caller":"traceutil/trace.go:171","msg":"trace[2133136694] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:447; }","duration":"201.44183ms","start":"2026-04-08T10:47:46.628009Z","end":"2026-04-08T10:47:46.829451Z","steps":["trace[2133136694] 'agreement among raft nodes before linearized reading' (duration: 201.359797ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:47:46.829548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.84555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-04-08T10:47:46.82964Z","caller":"traceutil/trace.go:171","msg":"trace[2036647572] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:447; }","duration":"167.986233ms","start":"2026-04-08T10:47:46.661634Z","end":"2026-04-08T10:47:46.82962Z","steps":["trace[2036647572] 'agreement among raft nodes before linearized reading' (duration: 167.796598ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:47:56.627826Z","caller":"traceutil/trace.go:171","msg":"trace[970050453] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"129.332773ms","start":"2026-04-08T10:47:56.498453Z","end":"2026-04-08T10:47:56.627786Z","steps":["trace[970050453] 'process raft request' (duration: 88.543639ms)","trace[970050453] 'compare' (duration: 40.549489ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:47:56.638802Z","caller":"traceutil/trace.go:171","msg":"trace[71733844] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"102.448797ms","start":"2026-04-08T10:47:56.536312Z","end":"2026-04-08T10:47:56.638761Z","steps":["trace[71733844] 'process raft request' (duration: 102.15438ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:47:56.639049Z","caller":"traceutil/trace.go:171","msg":"trace[1112907076] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"102.547069ms","start":"2026-04-08T10:47:56.536476Z","end":"2026-04-08T10:47:56.639023Z","steps":["trace[1112907076] 'process raft request' (duration: 102.172631ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:47:56.639233Z","caller":"traceutil/trace.go:171","msg":"trace[1012918968] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"102.737073ms","start":"2026-04-08T10:47:56.536477Z","end":"2026-04-08T10:47:56.639214Z","steps":["trace[1012918968] 'process raft request' (duration: 102.11537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:47:56.639466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.977586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/cilium-operator\" ","response":"range_response_count:1 size:4335"} {"level":"info","ts":"2026-04-08T10:47:56.639545Z","caller":"traceutil/trace.go:171","msg":"trace[1037357755] range","detail":"{range_begin:/registry/deployments/kube-system/cilium-operator; range_end:; response_count:1; response_revision:498; }","duration":"101.087928ms","start":"2026-04-08T10:47:56.538436Z","end":"2026-04-08T10:47:56.639524Z","steps":["trace[1037357755] 'agreement among raft nodes before linearized reading' (duration: 100.702249ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:47:58.684184Z","caller":"traceutil/trace.go:171","msg":"trace[943032491] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"100.943885ms","start":"2026-04-08T10:47:58.583155Z","end":"2026-04-08T10:47:58.684099Z","steps":["trace[943032491] 'process raft request' (duration: 100.736711ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:47:58.684252Z","caller":"traceutil/trace.go:171","msg":"trace[125442723] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"100.871134ms","start":"2026-04-08T10:47:58.583313Z","end":"2026-04-08T10:47:58.684184Z","steps":["trace[125442723] 'process raft request' (duration: 100.21733ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:47:58.694315Z","caller":"traceutil/trace.go:171","msg":"trace[2030207178] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"100.573227ms","start":"2026-04-08T10:47:58.593673Z","end":"2026-04-08T10:47:58.694246Z","steps":["trace[2030207178] 'process raft request' (duration: 96.726694ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:04.933392Z","caller":"traceutil/trace.go:171","msg":"trace[644001744] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"121.176309ms","start":"2026-04-08T10:48:04.812181Z","end":"2026-04-08T10:48:04.933358Z","steps":["trace[644001744] 'process raft request' (duration: 120.454993ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:05.199595Z","caller":"traceutil/trace.go:171","msg":"trace[802088500] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"209.673736ms","start":"2026-04-08T10:48:04.989883Z","end":"2026-04-08T10:48:05.199557Z","steps":["trace[802088500] 'process raft request' (duration: 181.41814ms)","trace[802088500] 'compare' (duration: 27.937519ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:48:05.19987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.435525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T10:48:05.199931Z","caller":"traceutil/trace.go:171","msg":"trace[2044368436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"170.541086ms","start":"2026-04-08T10:48:05.029372Z","end":"2026-04-08T10:48:05.199913Z","steps":["trace[2044368436] 'agreement among raft nodes before linearized reading' (duration: 170.328062ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:05.200021Z","caller":"traceutil/trace.go:171","msg":"trace[983634840] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"170.073877ms","start":"2026-04-08T10:48:05.029428Z","end":"2026-04-08T10:48:05.199502Z","steps":["trace[983634840] 'read index received' (duration: 141.870322ms)","trace[983634840] 'applied index is now lower than readState.Index' (duration: 28.201555ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:48:05.797741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.792799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qkxfn\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-08T10:48:05.797839Z","caller":"traceutil/trace.go:171","msg":"trace[1332050884] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qkxfn; range_end:; response_count:1; response_revision:620; }","duration":"486.952413ms","start":"2026-04-08T10:48:05.310861Z","end":"2026-04-08T10:48:05.797814Z","steps":["trace[1332050884] 'range keys from in-memory index tree' (duration: 486.565165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:48:05.797883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:48:05.310837Z","time spent":"487.036605ms","remote":"127.0.0.1:51592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16985,"request content":"key:\"/registry/pods/kube-system/cilium-qkxfn\" "} {"level":"info","ts":"2026-04-08T10:48:05.804649Z","caller":"traceutil/trace.go:171","msg":"trace[715424963] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"201.818998ms","start":"2026-04-08T10:48:05.602804Z","end":"2026-04-08T10:48:05.804623Z","steps":["trace[715424963] 'process raft request' (duration: 201.223986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:48:21.483905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.775334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.69\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-08T10:48:21.483995Z","caller":"traceutil/trace.go:171","msg":"trace[1692354639] range","detail":"{range_begin:/registry/masterleases/199.204.45.69; range_end:; response_count:1; response_revision:784; }","duration":"227.908387ms","start":"2026-04-08T10:48:21.256066Z","end":"2026-04-08T10:48:21.483974Z","steps":["trace[1692354639] 'range keys from in-memory index tree' (duration: 227.614621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:48:21.483991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.036865ms","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-08T10:48:21.484161Z","caller":"traceutil/trace.go:171","msg":"trace[165958728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:784; }","duration":"197.206759ms","start":"2026-04-08T10:48:21.286892Z","end":"2026-04-08T10:48:21.484099Z","steps":["trace[165958728] 'range keys from in-memory index tree' (duration: 196.899812ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:50.295143Z","caller":"traceutil/trace.go:171","msg":"trace[400927045] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"117.192193ms","start":"2026-04-08T10:48:50.177924Z","end":"2026-04-08T10:48:50.295116Z","steps":["trace[400927045] 'process raft request' (duration: 117.02954ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:48:50.352538Z","caller":"traceutil/trace.go:171","msg":"trace[2024579852] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"173.51094ms","start":"2026-04-08T10:48:50.178995Z","end":"2026-04-08T10:48:50.352506Z","steps":["trace[2024579852] 'process raft request' (duration: 172.422437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:49:35.443505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.007684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:569"} {"level":"info","ts":"2026-04-08T10:49:35.443638Z","caller":"traceutil/trace.go:171","msg":"trace[1285847358] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1844; }","duration":"251.187318ms","start":"2026-04-08T10:49:35.192416Z","end":"2026-04-08T10:49:35.443603Z","steps":["trace[1285847358] 'range keys from in-memory index tree' (duration: 250.726039ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:49:35.625507Z","caller":"traceutil/trace.go:171","msg":"trace[1279812345] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"104.968382ms","start":"2026-04-08T10:49:35.520503Z","end":"2026-04-08T10:49:35.625471Z","steps":["trace[1279812345] 'process raft request' (duration: 38.728953ms)","trace[1279812345] 'compare' (duration: 66.050986ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:49:35.98539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.351845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1d955922-2b1f-4c9c-8cf9-c14bad4f1bba\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-04-08T10:49:35.985438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.824353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T10:49:35.985496Z","caller":"traceutil/trace.go:171","msg":"trace[35938435] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1849; }","duration":"212.924285ms","start":"2026-04-08T10:49:35.772555Z","end":"2026-04-08T10:49:35.985479Z","steps":["trace[35938435] 'count revisions from in-memory index tree' (duration: 212.695491ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:49:35.985498Z","caller":"traceutil/trace.go:171","msg":"trace[805771123] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1d955922-2b1f-4c9c-8cf9-c14bad4f1bba; range_end:; response_count:1; response_revision:1849; }","duration":"173.496188ms","start":"2026-04-08T10:49:35.811977Z","end":"2026-04-08T10:49:35.985473Z","steps":["trace[805771123] 'range keys from in-memory index tree' (duration: 173.169521ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:49:47.96773Z","caller":"traceutil/trace.go:171","msg":"trace[207957690] linearizableReadLoop","detail":"{readStateIndex:2026; appliedIndex:2025; }","duration":"245.867591ms","start":"2026-04-08T10:49:47.721835Z","end":"2026-04-08T10:49:47.967703Z","steps":["trace[207957690] 'read index received' (duration: 210.857534ms)","trace[207957690] 'applied index is now lower than readState.Index' (duration: 35.008957ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:49:47.967775Z","caller":"traceutil/trace.go:171","msg":"trace[604959910] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"252.013125ms","start":"2026-04-08T10:49:47.715729Z","end":"2026-04-08T10:49:47.967742Z","steps":["trace[604959910] 'process raft request' (duration: 216.965117ms)","trace[604959910] 'compare' (duration: 34.886055ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:49:47.967978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.137956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-08T10:49:47.96804Z","caller":"traceutil/trace.go:171","msg":"trace[68023491] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1952; }","duration":"246.265179ms","start":"2026-04-08T10:49:47.721758Z","end":"2026-04-08T10:49:47.968023Z","steps":["trace[68023491] 'agreement among raft nodes before linearized reading' (duration: 246.095345ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:50:25.194194Z","caller":"traceutil/trace.go:171","msg":"trace[2116687710] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"121.255842ms","start":"2026-04-08T10:50:25.07291Z","end":"2026-04-08T10:50:25.194166Z","steps":["trace[2116687710] 'process raft request' (duration: 121.10475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:50:25.491819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.19134ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T10:50:25.491962Z","caller":"traceutil/trace.go:171","msg":"trace[592878587] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"295.101007ms","start":"2026-04-08T10:50:25.19684Z","end":"2026-04-08T10:50:25.491941Z","steps":["trace[592878587] 'read index received' (duration: 109.134002ms)","trace[592878587] 'applied index is now lower than readState.Index' (duration: 185.965195ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T10:50:25.492006Z","caller":"traceutil/trace.go:171","msg":"trace[304495650] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"385.70528ms","start":"2026-04-08T10:50:25.106255Z","end":"2026-04-08T10:50:25.49196Z","steps":["trace[304495650] 'process raft request' (duration: 199.712745ms)","trace[304495650] 'compare' (duration: 185.005727ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:50:25.492168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.27837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T10:50:25.49224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.010137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-04-08T10:50:25.49223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T10:50:25.106218Z","time spent":"385.894293ms","remote":"127.0.0.1:51684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T10:50:25.49229Z","caller":"traceutil/trace.go:171","msg":"trace[1906807805] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2165; }","duration":"176.114049ms","start":"2026-04-08T10:50:25.316158Z","end":"2026-04-08T10:50:25.492272Z","steps":["trace[1906807805] 'agreement among raft nodes before linearized reading' (duration: 175.918245ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:50:25.492316Z","caller":"traceutil/trace.go:171","msg":"trace[752131173] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:2165; }","duration":"295.471173ms","start":"2026-04-08T10:50:25.196787Z","end":"2026-04-08T10:50:25.492258Z","steps":["trace[752131173] 'agreement among raft nodes before linearized reading' (duration: 295.224699ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:51:37.685049Z","caller":"traceutil/trace.go:171","msg":"trace[1512907390] transaction","detail":"{read_only:false; response_revision:2609; number_of_response:1; }","duration":"102.260493ms","start":"2026-04-08T10:51:37.582752Z","end":"2026-04-08T10:51:37.685013Z","steps":["trace[1512907390] 'process raft request' (duration: 102.11385ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:54:24.225103Z","caller":"traceutil/trace.go:171","msg":"trace[1101736592] transaction","detail":"{read_only:false; response_revision:3671; number_of_response:1; }","duration":"240.659976ms","start":"2026-04-08T10:54:23.984417Z","end":"2026-04-08T10:54:24.225077Z","steps":["trace[1101736592] 'process raft request' (duration: 240.411572ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:55:46.82725Z","caller":"traceutil/trace.go:171","msg":"trace[1940662484] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"128.286961ms","start":"2026-04-08T10:55:46.698935Z","end":"2026-04-08T10:55:46.827222Z","steps":["trace[1940662484] 'process raft request' (duration: 128.23874ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:55:46.82735Z","caller":"traceutil/trace.go:171","msg":"trace[1306715060] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"128.792511ms","start":"2026-04-08T10:55:46.698517Z","end":"2026-04-08T10:55:46.827309Z","steps":["trace[1306715060] 'process raft request' (duration: 128.513385ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:55:46.845191Z","caller":"traceutil/trace.go:171","msg":"trace[374177664] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"105.730895ms","start":"2026-04-08T10:55:46.739434Z","end":"2026-04-08T10:55:46.845164Z","steps":["trace[374177664] 'process raft request' (duration: 105.557262ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:55:57.969105Z","caller":"traceutil/trace.go:171","msg":"trace[1732814545] linearizableReadLoop","detail":"{readStateIndex:5230; appliedIndex:5229; }","duration":"235.077418ms","start":"2026-04-08T10:55:57.734Z","end":"2026-04-08T10:55:57.969077Z","steps":["trace[1732814545] 'read index received' (duration: 234.873144ms)","trace[1732814545] 'applied index is now lower than readState.Index' (duration: 200.674µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T10:55:57.969408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.377584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-08T10:55:57.969259Z","caller":"traceutil/trace.go:171","msg":"trace[1513554027] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"237.201232ms","start":"2026-04-08T10:55:57.731999Z","end":"2026-04-08T10:55:57.969201Z","steps":["trace[1513554027] 'process raft request' (duration: 236.911006ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:55:57.96948Z","caller":"traceutil/trace.go:171","msg":"trace[866704721] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5041; }","duration":"235.492287ms","start":"2026-04-08T10:55:57.733962Z","end":"2026-04-08T10:55:57.969454Z","steps":["trace[866704721] 'agreement among raft nodes before linearized reading' (duration: 235.265222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:55:57.96967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.520996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-08T10:55:57.9698Z","caller":"traceutil/trace.go:171","msg":"trace[1555326588] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5041; }","duration":"182.71259ms","start":"2026-04-08T10:55:57.787058Z","end":"2026-04-08T10:55:57.969771Z","steps":["trace[1555326588] 'agreement among raft nodes before linearized reading' (duration: 182.324862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T10:55:58.958679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.95052ms","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-08T10:55:58.959528Z","caller":"traceutil/trace.go:171","msg":"trace[638337993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5051; }","duration":"161.882429ms","start":"2026-04-08T10:55:58.797609Z","end":"2026-04-08T10:55:58.959491Z","steps":["trace[638337993] 'range keys from in-memory index tree' (duration: 160.706705ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T10:57:28.209942Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2877} {"level":"info","ts":"2026-04-08T10:57:28.282108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2877,"took":"70.520634ms","hash":3355772384,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":33173504,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-08T10:57:28.282166Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3355772384,"revision":2877,"compact-revision":-1} {"level":"info","ts":"2026-04-08T11:02:28.219923Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5973} {"level":"info","ts":"2026-04-08T11:02:28.324548Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5973,"took":"101.752338ms","hash":851214144,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":20516864,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-08T11:02:28.324625Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":851214144,"revision":5973,"compact-revision":2877} {"level":"info","ts":"2026-04-08T11:02:43.748534Z","caller":"traceutil/trace.go:171","msg":"trace[1177458717] transaction","detail":"{read_only:false; response_revision:8218; number_of_response:1; }","duration":"275.182794ms","start":"2026-04-08T11:02:43.473293Z","end":"2026-04-08T11:02:43.748476Z","steps":["trace[1177458717] 'process raft request' (duration: 274.99455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:02:55.632166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.23493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T11:02:55.632282Z","caller":"traceutil/trace.go:171","msg":"trace[324651777] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:8279; }","duration":"128.422373ms","start":"2026-04-08T11:02:55.503836Z","end":"2026-04-08T11:02:55.632259Z","steps":["trace[324651777] 'count revisions from in-memory index tree' (duration: 128.053886ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:02:56.546323Z","caller":"traceutil/trace.go:171","msg":"trace[521053633] linearizableReadLoop","detail":"{readStateIndex:8573; appliedIndex:8572; }","duration":"227.521519ms","start":"2026-04-08T11:02:56.318744Z","end":"2026-04-08T11:02:56.546265Z","steps":["trace[521053633] 'read index received' (duration: 227.361126ms)","trace[521053633] 'applied index is now lower than readState.Index' (duration: 158.823µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:02:56.546399Z","caller":"traceutil/trace.go:171","msg":"trace[1418443446] transaction","detail":"{read_only:false; response_revision:8281; number_of_response:1; }","duration":"240.801374ms","start":"2026-04-08T11:02:56.305544Z","end":"2026-04-08T11:02:56.546345Z","steps":["trace[1418443446] 'process raft request' (duration: 240.505189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:02:56.546622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.858845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T11:02:56.546674Z","caller":"traceutil/trace.go:171","msg":"trace[1028981699] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8281; }","duration":"227.997508ms","start":"2026-04-08T11:02:56.318665Z","end":"2026-04-08T11:02:56.546663Z","steps":["trace[1028981699] 'agreement among raft nodes before linearized reading' (duration: 227.779933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:02:56.611403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.451865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T11:02:56.611436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.728903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagerconfigs/\" range_end:\"/registry/monitoring.coreos.com/alertmanagerconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T11:02:56.611515Z","caller":"traceutil/trace.go:171","msg":"trace[833455055] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8281; }","duration":"174.592328ms","start":"2026-04-08T11:02:56.436892Z","end":"2026-04-08T11:02:56.611484Z","steps":["trace[833455055] 'agreement among raft nodes before linearized reading' (duration: 174.412334ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:02:56.611533Z","caller":"traceutil/trace.go:171","msg":"trace[200360350] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagerconfigs/; range_end:/registry/monitoring.coreos.com/alertmanagerconfigs0; response_count:0; response_revision:8281; }","duration":"225.924266ms","start":"2026-04-08T11:02:56.385583Z","end":"2026-04-08T11:02:56.611507Z","steps":["trace[200360350] 'agreement among raft nodes before linearized reading' (duration: 225.726952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:02:56.611545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.488099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-04-08T11:02:56.611889Z","caller":"traceutil/trace.go:171","msg":"trace[751089720] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8282; }","duration":"279.902978ms","start":"2026-04-08T11:02:56.331969Z","end":"2026-04-08T11:02:56.611872Z","steps":["trace[751089720] 'agreement among raft nodes before linearized reading' (duration: 279.376237ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:02:56.863539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.300311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T11:02:56.863659Z","caller":"traceutil/trace.go:171","msg":"trace[897537503] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:8285; }","duration":"152.506945ms","start":"2026-04-08T11:02:56.711127Z","end":"2026-04-08T11:02:56.863633Z","steps":["trace[897537503] 'count revisions from in-memory index tree' (duration: 152.156589ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:02:57.462576Z","caller":"traceutil/trace.go:171","msg":"trace[167071539] transaction","detail":"{read_only:false; response_revision:8288; number_of_response:1; }","duration":"159.445245ms","start":"2026-04-08T11:02:57.303096Z","end":"2026-04-08T11:02:57.462541Z","steps":["trace[167071539] 'process raft request' (duration: 82.549814ms)","trace[167071539] 'compare' (duration: 76.590805ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:02:57.462944Z","caller":"traceutil/trace.go:171","msg":"trace[129210512] transaction","detail":"{read_only:false; response_revision:8289; number_of_response:1; }","duration":"159.755801ms","start":"2026-04-08T11:02:57.303146Z","end":"2026-04-08T11:02:57.462902Z","steps":["trace[129210512] 'process raft request' (duration: 159.292032ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:24.178829Z","caller":"traceutil/trace.go:171","msg":"trace[1917744862] transaction","detail":"{read_only:false; response_revision:8482; number_of_response:1; }","duration":"181.814886ms","start":"2026-04-08T11:03:23.99698Z","end":"2026-04-08T11:03:24.178794Z","steps":["trace[1917744862] 'process raft request' (duration: 181.613082ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:37.636112Z","caller":"traceutil/trace.go:171","msg":"trace[1866148042] transaction","detail":"{read_only:false; response_revision:8595; number_of_response:1; }","duration":"105.286371ms","start":"2026-04-08T11:03:37.530772Z","end":"2026-04-08T11:03:37.636058Z","steps":["trace[1866148042] 'process raft request' (duration: 104.828412ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:37.649691Z","caller":"traceutil/trace.go:171","msg":"trace[1361359135] transaction","detail":"{read_only:false; response_revision:8596; number_of_response:1; }","duration":"111.184929ms","start":"2026-04-08T11:03:37.538473Z","end":"2026-04-08T11:03:37.649658Z","steps":["trace[1361359135] 'process raft request' (duration: 111.004366ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:38.681305Z","caller":"traceutil/trace.go:171","msg":"trace[1685188100] linearizableReadLoop","detail":"{readStateIndex:8907; appliedIndex:8906; }","duration":"142.340604ms","start":"2026-04-08T11:03:38.538929Z","end":"2026-04-08T11:03:38.681269Z","steps":["trace[1685188100] 'read index received' (duration: 98.305431ms)","trace[1685188100] 'applied index is now lower than readState.Index' (duration: 44.034133ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:03:38.681417Z","caller":"traceutil/trace.go:171","msg":"trace[1861737246] transaction","detail":"{read_only:false; response_revision:8601; number_of_response:1; }","duration":"246.037554ms","start":"2026-04-08T11:03:38.435329Z","end":"2026-04-08T11:03:38.681366Z","steps":["trace[1861737246] 'process raft request' (duration: 201.929639ms)","trace[1861737246] 'compare' (duration: 43.85131ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T11:03:38.681605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.588089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T11:03:38.681658Z","caller":"traceutil/trace.go:171","msg":"trace[1309793462] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:8601; }","duration":"142.747083ms","start":"2026-04-08T11:03:38.538899Z","end":"2026-04-08T11:03:38.681646Z","steps":["trace[1309793462] 'agreement among raft nodes before linearized reading' (duration: 142.508618ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:03:38.962112Z","caller":"traceutil/trace.go:171","msg":"trace[1603766682] transaction","detail":"{read_only:false; response_revision:8604; number_of_response:1; }","duration":"105.494634ms","start":"2026-04-08T11:03:38.856515Z","end":"2026-04-08T11:03:38.96201Z","steps":["trace[1603766682] 'process raft request' (duration: 70.527094ms)","trace[1603766682] 'compare' (duration: 34.732995ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:04:23.243319Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024aa.wal"} {"level":"warn","ts":"2026-04-08T11:04:58.494321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.050179ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T11:04:58.494635Z","caller":"traceutil/trace.go:171","msg":"trace[1785418626] transaction","detail":"{read_only:false; response_revision:9303; number_of_response:1; }","duration":"352.386479ms","start":"2026-04-08T11:04:58.1422Z","end":"2026-04-08T11:04:58.494586Z","steps":["trace[1785418626] 'process raft request' (duration: 102.902221ms)","trace[1785418626] 'compare' (duration: 248.815575ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T11:04:58.49514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:04:58.142191Z","time spent":"352.544443ms","remote":"127.0.0.1:51684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T11:05:37.365193Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"fe334179879fd0aa","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T11:05:37.371665Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T11:05:37.371778Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T11:07:28.228016Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8006} {"level":"info","ts":"2026-04-08T11:07:28.297127Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8006,"took":"66.394188ms","hash":1247870798,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":27787264,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-08T11:07:28.297203Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1247870798,"revision":8006,"compact-revision":5973} {"level":"info","ts":"2026-04-08T11:12:28.236438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10390} {"level":"info","ts":"2026-04-08T11:12:28.31926Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10390,"took":"80.107496ms","hash":47995840,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":21274624,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-08T11:12:28.319345Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":47995840,"revision":10390,"compact-revision":8006} {"level":"info","ts":"2026-04-08T11:14:07.572316Z","caller":"traceutil/trace.go:171","msg":"trace[1959085968] linearizableReadLoop","detail":"{readStateIndex:13065; appliedIndex:13064; }","duration":"408.99417ms","start":"2026-04-08T11:14:07.163286Z","end":"2026-04-08T11:14:07.57228Z","steps":["trace[1959085968] 'read index received' (duration: 408.925818ms)","trace[1959085968] 'applied index is now lower than readState.Index' (duration: 67.092µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T11:14:07.572394Z","caller":"traceutil/trace.go:171","msg":"trace[1978217840] transaction","detail":"{read_only:false; response_revision:12615; number_of_response:1; }","duration":"484.595131ms","start":"2026-04-08T11:14:07.087774Z","end":"2026-04-08T11:14:07.572369Z","steps":["trace[1978217840] 'process raft request' (duration: 484.277505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:14:07.572535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:14:07.087756Z","time spent":"484.679516ms","remote":"127.0.0.1:51684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T11:14:07.5727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.404599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T11:14:07.572757Z","caller":"traceutil/trace.go:171","msg":"trace[1519653705] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:12615; }","duration":"409.497981ms","start":"2026-04-08T11:14:07.163247Z","end":"2026-04-08T11:14:07.572745Z","steps":["trace[1519653705] 'agreement among raft nodes before linearized reading' (duration: 409.207155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:14:07.572796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:14:07.163235Z","time spent":"409.548532ms","remote":"127.0.0.1:51878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":29,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-04-08T11:14:07.573411Z","caller":"traceutil/trace.go:171","msg":"trace[585254938] transaction","detail":"{read_only:false; response_revision:12616; number_of_response:1; }","duration":"149.144314ms","start":"2026-04-08T11:14:07.424241Z","end":"2026-04-08T11:14:07.573386Z","steps":["trace[585254938] 'process raft request' (duration: 148.967701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:14:07.573859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.355804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/staffeln-db-sync\" ","response":"range_response_count:1 size:5129"} {"level":"info","ts":"2026-04-08T11:14:07.573603Z","caller":"traceutil/trace.go:171","msg":"trace[1021843205] transaction","detail":"{read_only:false; response_revision:12617; number_of_response:1; }","duration":"149.182135ms","start":"2026-04-08T11:14:07.424388Z","end":"2026-04-08T11:14:07.57357Z","steps":["trace[1021843205] 'process raft request' (duration: 148.958791ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T11:14:07.573882Z","caller":"traceutil/trace.go:171","msg":"trace[1274211199] range","detail":"{range_begin:/registry/jobs/openstack/staffeln-db-sync; range_end:; response_count:1; response_revision:12617; }","duration":"345.380865ms","start":"2026-04-08T11:14:07.228496Z","end":"2026-04-08T11:14:07.573876Z","steps":["trace[1274211199] 'agreement among raft nodes before linearized reading' (duration: 345.079669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:14:07.573898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:14:07.228407Z","time spent":"345.487977ms","remote":"127.0.0.1:51658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":5153,"request content":"key:\"/registry/jobs/openstack/staffeln-db-sync\" "} {"level":"warn","ts":"2026-04-08T11:14:07.574108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.442705ms","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-08T11:14:07.574227Z","caller":"traceutil/trace.go:171","msg":"trace[110134528] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:12617; }","duration":"366.607647ms","start":"2026-04-08T11:14:07.207594Z","end":"2026-04-08T11:14:07.574202Z","steps":["trace[110134528] 'agreement among raft nodes before linearized reading' (duration: 366.24218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T11:14:07.574311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T11:14:07.207583Z","time spent":"366.68877ms","remote":"127.0.0.1:51684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}