{"level":"warn","ts":"2026-06-09T22:21:08.129384Z","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-09T22:21:08.1295Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-09T22:21:08.129584Z","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-09T22:21:08.129601Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-06-09T22:21:08.129626Z","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-09T22:21:08.130377Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-06-09T22:21:08.130461Z","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.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-09T22:21:08.133184Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.498668ms"} {"level":"info","ts":"2026-06-09T22:21:08.140224Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-06-09T22:21:08.140348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T22:21:08.140382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-06-09T22:21:08.140403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T22:21:08.140421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-06-09T22:21:08.140481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-06-09T22:21:08.145764Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T22:21:08.146925Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T22:21:08.148189Z","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-09T22:21:08.150365Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T22:21:08.151305Z","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-09T22:21:08.15141Z","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-09T22:21:08.151424Z","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-09T22:21:08.151343Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T22:21:08.153618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-06-09T22:21:08.153795Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-06-09T22:21:08.155242Z","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-09T22:21:08.155446Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-06-09T22:21:08.155546Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-06-09T22:21:08.155582Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T22:21:08.155633Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T22:21:08.540696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T22:21:08.540833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T22:21:08.540894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-06-09T22:21:08.540938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-06-09T22:21:08.540971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-06-09T22:21:08.541015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-06-09T22:21:08.54105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-06-09T22:21:08.54195Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:21:08.542747Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:21:08.54283Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T22:21:08.542765Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T22:21:08.54308Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T22:21:08.543149Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T22:21:08.545176Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-06-09T22:21:08.545816Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T22:21:08.545921Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:21:08.546023Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:21:08.546075Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T22:21:37.031158Z","caller":"traceutil/trace.go:171","msg":"trace[1711173465] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"107.482813ms","start":"2026-06-09T22:21:36.923652Z","end":"2026-06-09T22:21:37.031135Z","steps":["trace[1711173465] 'process raft request' (duration: 107.33663ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:21:55.84152Z","caller":"traceutil/trace.go:171","msg":"trace[480425869] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"114.625275ms","start":"2026-06-09T22:21:55.726867Z","end":"2026-06-09T22:21:55.841492Z","steps":["trace[480425869] 'read index received' (duration: 113.891881ms)","trace[480425869] 'applied index is now lower than readState.Index' (duration: 731.884µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:21:55.841681Z","caller":"traceutil/trace.go:171","msg":"trace[1715044729] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"175.521526ms","start":"2026-06-09T22:21:55.666119Z","end":"2026-06-09T22:21:55.84164Z","steps":["trace[1715044729] 'process raft request' (duration: 174.811593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:21:55.841809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.931401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-d6bxg\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-09T22:21:55.841907Z","caller":"traceutil/trace.go:171","msg":"trace[1379108169] range","detail":"{range_begin:/registry/pods/kube-system/cilium-d6bxg; range_end:; response_count:1; response_revision:644; }","duration":"115.095534ms","start":"2026-06-09T22:21:55.726796Z","end":"2026-06-09T22:21:55.841892Z","steps":["trace[1379108169] 'agreement among raft nodes before linearized reading' (duration: 114.84706ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:21:56.244812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.791057ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:21:56.245128Z","caller":"traceutil/trace.go:171","msg":"trace[184988399] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"336.19594ms","start":"2026-06-09T22:21:55.908886Z","end":"2026-06-09T22:21:56.245082Z","steps":["trace[184988399] 'process raft request' (duration: 336.036667ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:21:56.24517Z","caller":"traceutil/trace.go:171","msg":"trace[1664396169] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"383.819798ms","start":"2026-06-09T22:21:55.861317Z","end":"2026-06-09T22:21:56.245137Z","steps":["trace[1664396169] 'process raft request' (duration: 94.022443ms)","trace[1664396169] 'compare' (duration: 288.604343ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:21:56.245296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:21:55.908864Z","time spent":"336.354063ms","remote":"127.0.0.1:60910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-09T22:21:56.245348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:21:55.861297Z","time spent":"383.95555ms","remote":"127.0.0.1:60592","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:22:11.852522Z","caller":"traceutil/trace.go:171","msg":"trace[1001592836] linearizableReadLoop","detail":"{readStateIndex:844; appliedIndex:843; }","duration":"151.57662ms","start":"2026-06-09T22:22:11.700919Z","end":"2026-06-09T22:22:11.852496Z","steps":["trace[1001592836] 'read index received' (duration: 64.930079ms)","trace[1001592836] 'applied index is now lower than readState.Index' (duration: 86.644671ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:22:11.85286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.911467ms","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-06-09T22:22:11.852968Z","caller":"traceutil/trace.go:171","msg":"trace[190631105] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:811; }","duration":"152.09093ms","start":"2026-06-09T22:22:11.700852Z","end":"2026-06-09T22:22:11.852943Z","steps":["trace[190631105] 'agreement among raft nodes before linearized reading' (duration: 151.749114ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:27.135296Z","caller":"traceutil/trace.go:171","msg":"trace[560959309] linearizableReadLoop","detail":"{readStateIndex:1952; appliedIndex:1951; }","duration":"191.747486ms","start":"2026-06-09T22:23:26.94352Z","end":"2026-06-09T22:23:27.135268Z","steps":["trace[560959309] 'read index received' (duration: 103.864364ms)","trace[560959309] 'applied index is now lower than readState.Index' (duration: 87.881942ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:23:27.135494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.966411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T22:23:27.135615Z","caller":"traceutil/trace.go:171","msg":"trace[918539070] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1876; }","duration":"192.089633ms","start":"2026-06-09T22:23:26.943504Z","end":"2026-06-09T22:23:27.135594Z","steps":["trace[918539070] 'agreement among raft nodes before linearized reading' (duration: 191.856599ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:27.260073Z","caller":"traceutil/trace.go:171","msg":"trace[138381310] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"119.349657ms","start":"2026-06-09T22:23:27.140689Z","end":"2026-06-09T22:23:27.260039Z","steps":["trace[138381310] 'process raft request' (duration: 119.127383ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:27.333187Z","caller":"traceutil/trace.go:171","msg":"trace[1560825170] transaction","detail":"{read_only:false; response_revision:1878; number_of_response:1; }","duration":"192.295336ms","start":"2026-06-09T22:23:27.140866Z","end":"2026-06-09T22:23:27.333161Z","steps":["trace[1560825170] 'process raft request' (duration: 192.091303ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:27.333519Z","caller":"traceutil/trace.go:171","msg":"trace[956825099] transaction","detail":"{read_only:false; response_revision:1879; number_of_response:1; }","duration":"192.382838ms","start":"2026-06-09T22:23:27.141112Z","end":"2026-06-09T22:23:27.333495Z","steps":["trace[956825099] 'process raft request' (duration: 192.007142ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:23:27.333701Z","caller":"traceutil/trace.go:171","msg":"trace[474327967] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1952; }","duration":"129.420647ms","start":"2026-06-09T22:23:27.203982Z","end":"2026-06-09T22:23:27.333403Z","steps":["trace[474327967] 'read index received' (duration: 55.818975ms)","trace[474327967] 'applied index is now lower than readState.Index' (duration: 73.597052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:23:27.333763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.767164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:23:27.333888Z","caller":"traceutil/trace.go:171","msg":"trace[1515286611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1879; }","duration":"129.943738ms","start":"2026-06-09T22:23:27.203919Z","end":"2026-06-09T22:23:27.333863Z","steps":["trace[1515286611] 'agreement among raft nodes before linearized reading' (duration: 129.740863ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:24:18.288235Z","caller":"traceutil/trace.go:171","msg":"trace[830682332] linearizableReadLoop","detail":"{readStateIndex:2299; appliedIndex:2298; }","duration":"131.234223ms","start":"2026-06-09T22:24:18.156981Z","end":"2026-06-09T22:24:18.288215Z","steps":["trace[830682332] 'read index received' (duration: 131.165582ms)","trace[830682332] 'applied index is now lower than readState.Index' (duration: 66.821µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:24:18.288347Z","caller":"traceutil/trace.go:171","msg":"trace[62467471] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"189.070626ms","start":"2026-06-09T22:24:18.099245Z","end":"2026-06-09T22:24:18.288316Z","steps":["trace[62467471] 'process raft request' (duration: 188.810731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:24:18.288457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.467108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-09T22:24:18.288495Z","caller":"traceutil/trace.go:171","msg":"trace[740502759] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2212; }","duration":"131.571419ms","start":"2026-06-09T22:24:18.156914Z","end":"2026-06-09T22:24:18.288485Z","steps":["trace[740502759] 'agreement among raft nodes before linearized reading' (duration: 131.414126ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:24:18.907022Z","caller":"traceutil/trace.go:171","msg":"trace[556360696] linearizableReadLoop","detail":"{readStateIndex:2302; appliedIndex:2301; }","duration":"143.125049ms","start":"2026-06-09T22:24:18.763863Z","end":"2026-06-09T22:24:18.906988Z","steps":["trace[556360696] 'read index received' (duration: 142.852024ms)","trace[556360696] 'applied index is now lower than readState.Index' (duration: 271.115µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:24:18.907073Z","caller":"traceutil/trace.go:171","msg":"trace[1189516119] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"284.776101ms","start":"2026-06-09T22:24:18.622259Z","end":"2026-06-09T22:24:18.907035Z","steps":["trace[1189516119] 'process raft request' (duration: 284.496716ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:24:18.907253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.410745ms","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-06-09T22:24:18.907299Z","caller":"traceutil/trace.go:171","msg":"trace[610006158] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2215; }","duration":"143.535837ms","start":"2026-06-09T22:24:18.763755Z","end":"2026-06-09T22:24:18.907291Z","steps":["trace[610006158] 'agreement among raft nodes before linearized reading' (duration: 143.347163ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:48.201877Z","caller":"traceutil/trace.go:171","msg":"trace[1356442041] linearizableReadLoop","detail":"{readStateIndex:3001; appliedIndex:3000; }","duration":"111.364316ms","start":"2026-06-09T22:25:48.090494Z","end":"2026-06-09T22:25:48.201859Z","steps":["trace[1356442041] 'read index received' (duration: 111.204453ms)","trace[1356442041] 'applied index is now lower than readState.Index' (duration: 158.823µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:25:48.202152Z","caller":"traceutil/trace.go:171","msg":"trace[103006893] transaction","detail":"{read_only:false; response_revision:2888; number_of_response:1; }","duration":"118.467348ms","start":"2026-06-09T22:25:48.083673Z","end":"2026-06-09T22:25:48.202141Z","steps":["trace[103006893] 'process raft request' (duration: 118.079931ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:48.202362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.853664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-09T22:25:48.203549Z","caller":"traceutil/trace.go:171","msg":"trace[254184359] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2888; }","duration":"113.069707ms","start":"2026-06-09T22:25:48.090462Z","end":"2026-06-09T22:25:48.203532Z","steps":["trace[254184359] 'agreement among raft nodes before linearized reading' (duration: 111.824613ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:48.394202Z","caller":"traceutil/trace.go:171","msg":"trace[116915401] transaction","detail":"{read_only:false; response_revision:2889; number_of_response:1; }","duration":"187.461873ms","start":"2026-06-09T22:25:48.206696Z","end":"2026-06-09T22:25:48.394158Z","steps":["trace[116915401] 'process raft request' (duration: 157.266282ms)","trace[116915401] 'compare' (duration: 29.788603ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:25:48.424214Z","caller":"traceutil/trace.go:171","msg":"trace[1530356553] transaction","detail":"{read_only:false; response_revision:2890; number_of_response:1; }","duration":"216.834658ms","start":"2026-06-09T22:25:48.20734Z","end":"2026-06-09T22:25:48.424174Z","steps":["trace[1530356553] 'process raft request' (duration: 216.663725ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:48.424228Z","caller":"traceutil/trace.go:171","msg":"trace[1223499583] transaction","detail":"{read_only:false; response_revision:2891; number_of_response:1; }","duration":"188.311819ms","start":"2026-06-09T22:25:48.235891Z","end":"2026-06-09T22:25:48.424202Z","steps":["trace[1223499583] 'process raft request' (duration: 188.230237ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:25:48.424513Z","caller":"traceutil/trace.go:171","msg":"trace[1563902858] transaction","detail":"{read_only:false; response_revision:2892; number_of_response:1; }","duration":"186.82958ms","start":"2026-06-09T22:25:48.237619Z","end":"2026-06-09T22:25:48.424449Z","steps":["trace[1563902858] 'process raft request' (duration: 186.543075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:49.286367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.802126ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:25:49.286533Z","caller":"traceutil/trace.go:171","msg":"trace[749445497] linearizableReadLoop","detail":"{readStateIndex:3008; appliedIndex:3007; }","duration":"357.362204ms","start":"2026-06-09T22:25:48.929145Z","end":"2026-06-09T22:25:49.286508Z","steps":["trace[749445497] 'read index received' (duration: 166.247432ms)","trace[749445497] 'applied index is now lower than readState.Index' (duration: 191.112372ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:25:49.286717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.581759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-09T22:25:49.286755Z","caller":"traceutil/trace.go:171","msg":"trace[1537025495] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2895; }","duration":"357.674571ms","start":"2026-06-09T22:25:48.92907Z","end":"2026-06-09T22:25:49.286745Z","steps":["trace[1537025495] 'agreement among raft nodes before linearized reading' (duration: 357.500238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:49.28679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:48.92904Z","time spent":"357.741951ms","remote":"127.0.0.1:60608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-06-09T22:25:49.286769Z","caller":"traceutil/trace.go:171","msg":"trace[2073367727] transaction","detail":"{read_only:false; response_revision:2895; number_of_response:1; }","duration":"580.773297ms","start":"2026-06-09T22:25:48.70596Z","end":"2026-06-09T22:25:49.286734Z","steps":["trace[2073367727] 'process raft request' (duration: 389.523691ms)","trace[2073367727] 'compare' (duration: 190.685894ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:25:49.286959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:25:48.705938Z","time spent":"580.905649ms","remote":"127.0.0.1:60688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T22:25:49.459812Z","caller":"traceutil/trace.go:171","msg":"trace[1659154006] transaction","detail":"{read_only:false; response_revision:2896; number_of_response:1; }","duration":"176.451715ms","start":"2026-06-09T22:25:49.283323Z","end":"2026-06-09T22:25:49.459775Z","steps":["trace[1659154006] 'process raft request' (duration: 125.259508ms)","trace[1659154006] 'compare' (duration: 50.999164ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:25:49.45993Z","caller":"traceutil/trace.go:171","msg":"trace[1984812263] linearizableReadLoop","detail":"{readStateIndex:3009; appliedIndex:3008; }","duration":"170.45391ms","start":"2026-06-09T22:25:49.289428Z","end":"2026-06-09T22:25:49.459882Z","steps":["trace[1984812263] 'read index received' (duration: 119.160041ms)","trace[1984812263] 'applied index is now lower than readState.Index' (duration: 51.287299ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:25:49.459818Z","caller":"traceutil/trace.go:171","msg":"trace[256967857] transaction","detail":"{read_only:false; response_revision:2897; number_of_response:1; }","duration":"140.741019ms","start":"2026-06-09T22:25:49.319041Z","end":"2026-06-09T22:25:49.459782Z","steps":["trace[256967857] 'process raft request' (duration: 140.673908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:25:49.460142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.692736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1449"} {"level":"info","ts":"2026-06-09T22:25:49.460205Z","caller":"traceutil/trace.go:171","msg":"trace[800109793] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2897; }","duration":"170.796138ms","start":"2026-06-09T22:25:49.289388Z","end":"2026-06-09T22:25:49.460184Z","steps":["trace[800109793] 'agreement among raft nodes before linearized reading' (duration: 170.603854ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:28:30.287636Z","caller":"traceutil/trace.go:171","msg":"trace[1285532072] transaction","detail":"{read_only:false; response_revision:3945; number_of_response:1; }","duration":"205.265836ms","start":"2026-06-09T22:28:30.082334Z","end":"2026-06-09T22:28:30.2876Z","steps":["trace[1285532072] 'process raft request' (duration: 133.906159ms)","trace[1285532072] 'compare' (duration: 70.838118ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:30:02.031343Z","caller":"traceutil/trace.go:171","msg":"trace[516765358] linearizableReadLoop","detail":"{readStateIndex:5352; appliedIndex:5351; }","duration":"231.3381ms","start":"2026-06-09T22:30:01.799972Z","end":"2026-06-09T22:30:02.03131Z","steps":["trace[516765358] 'read index received' (duration: 178.171247ms)","trace[516765358] 'applied index is now lower than readState.Index' (duration: 53.164573ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:30:02.031449Z","caller":"traceutil/trace.go:171","msg":"trace[1080991181] transaction","detail":"{read_only:false; response_revision:5157; number_of_response:1; }","duration":"254.880495ms","start":"2026-06-09T22:30:01.77652Z","end":"2026-06-09T22:30:02.0314Z","steps":["trace[1080991181] 'process raft request' (duration: 201.513508ms)","trace[1080991181] 'compare' (duration: 52.934399ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:30:02.031593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.593834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:30:02.031641Z","caller":"traceutil/trace.go:171","msg":"trace[77718649] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:5157; }","duration":"231.703766ms","start":"2026-06-09T22:30:01.799922Z","end":"2026-06-09T22:30:02.031626Z","steps":["trace[77718649] 'agreement among raft nodes before linearized reading' (duration: 231.565954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:30:02.118018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.434112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-09T22:30:02.118104Z","caller":"traceutil/trace.go:171","msg":"trace[2062630491] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5158; }","duration":"251.579745ms","start":"2026-06-09T22:30:01.866506Z","end":"2026-06-09T22:30:02.118086Z","steps":["trace[2062630491] 'agreement among raft nodes before linearized reading' (duration: 251.34479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:30:02.118111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.996162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-09T22:30:02.118118Z","caller":"traceutil/trace.go:171","msg":"trace[649260376] transaction","detail":"{read_only:false; response_revision:5158; number_of_response:1; }","duration":"277.351852ms","start":"2026-06-09T22:30:01.840717Z","end":"2026-06-09T22:30:02.118069Z","steps":["trace[649260376] 'process raft request' (duration: 276.70381ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:30:02.118204Z","caller":"traceutil/trace.go:171","msg":"trace[1750204407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5158; }","duration":"305.143135ms","start":"2026-06-09T22:30:01.81304Z","end":"2026-06-09T22:30:02.118184Z","steps":["trace[1750204407] 'agreement among raft nodes before linearized reading' (duration: 304.864049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:30:02.118252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:30:01.813022Z","time spent":"305.222357ms","remote":"127.0.0.1:60688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-09T22:30:02.118559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.750722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-09T22:30:02.118634Z","caller":"traceutil/trace.go:171","msg":"trace[1016565927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5158; }","duration":"249.844124ms","start":"2026-06-09T22:30:01.868781Z","end":"2026-06-09T22:30:02.118625Z","steps":["trace[1016565927] 'agreement among raft nodes before linearized reading' (duration: 249.06816ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:30:16.159111Z","caller":"traceutil/trace.go:171","msg":"trace[887057103] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"138.09674ms","start":"2026-06-09T22:30:16.020984Z","end":"2026-06-09T22:30:16.159081Z","steps":["trace[887057103] 'process raft request' (duration: 137.837586ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:30:16.346698Z","caller":"traceutil/trace.go:171","msg":"trace[722083503] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"185.06137ms","start":"2026-06-09T22:30:16.161575Z","end":"2026-06-09T22:30:16.346636Z","steps":["trace[722083503] 'process raft request' (duration: 98.578974ms)","trace[722083503] 'compare' (duration: 86.235952ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:30:16.346743Z","caller":"traceutil/trace.go:171","msg":"trace[1661184458] linearizableReadLoop","detail":"{readStateIndex:5635; appliedIndex:5634; }","duration":"145.797259ms","start":"2026-06-09T22:30:16.20089Z","end":"2026-06-09T22:30:16.346687Z","steps":["trace[1661184458] 'read index received' (duration: 59.16569ms)","trace[1661184458] 'applied index is now lower than readState.Index' (duration: 86.622359ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:30:16.346943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.070674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:30:16.347007Z","caller":"traceutil/trace.go:171","msg":"trace[198522036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5433; }","duration":"146.221747ms","start":"2026-06-09T22:30:16.200769Z","end":"2026-06-09T22:30:16.346991Z","steps":["trace[198522036] 'agreement among raft nodes before linearized reading' (duration: 146.066555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:30:16.347344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.430477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-09T22:30:16.347385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.597827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-09T22:30:16.347388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.561856ms","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-09T22:30:16.347444Z","caller":"traceutil/trace.go:171","msg":"trace[11047469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5433; }","duration":"127.62222ms","start":"2026-06-09T22:30:16.219795Z","end":"2026-06-09T22:30:16.347417Z","steps":["trace[11047469] 'agreement among raft nodes before linearized reading' (duration: 127.369065ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:30:16.347485Z","caller":"traceutil/trace.go:171","msg":"trace[326452748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5433; }","duration":"113.75035ms","start":"2026-06-09T22:30:16.233715Z","end":"2026-06-09T22:30:16.347465Z","steps":["trace[326452748] 'agreement among raft nodes before linearized reading' (duration: 113.526126ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:30:16.347503Z","caller":"traceutil/trace.go:171","msg":"trace[1380779746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5433; }","duration":"113.722469ms","start":"2026-06-09T22:30:16.233757Z","end":"2026-06-09T22:30:16.34748Z","steps":["trace[1380779746] 'agreement among raft nodes before linearized reading' (duration: 113.431894ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:30:25.263789Z","caller":"traceutil/trace.go:171","msg":"trace[1212146980] transaction","detail":"{read_only:false; response_revision:5609; number_of_response:1; }","duration":"109.923416ms","start":"2026-06-09T22:30:25.153835Z","end":"2026-06-09T22:30:25.263758Z","steps":["trace[1212146980] 'process raft request' (duration: 43.878348ms)","trace[1212146980] 'compare' (duration: 65.849263ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:30:25.697998Z","caller":"traceutil/trace.go:171","msg":"trace[974821793] transaction","detail":"{read_only:false; response_revision:5611; number_of_response:1; }","duration":"123.750241ms","start":"2026-06-09T22:30:25.574218Z","end":"2026-06-09T22:30:25.697968Z","steps":["trace[974821793] 'process raft request' (duration: 123.567828ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:31:08.578957Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3004} {"level":"info","ts":"2026-06-09T22:31:08.664333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3004,"took":"83.407197ms","hash":2321545803,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":31277056,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-09T22:31:08.6644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2321545803,"revision":3004,"compact-revision":-1} {"level":"info","ts":"2026-06-09T22:36:08.586539Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6047} {"level":"info","ts":"2026-06-09T22:36:08.699969Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6047,"took":"110.225751ms","hash":1526584528,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":21897216,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-09T22:36:08.700039Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1526584528,"revision":6047,"compact-revision":3004} {"level":"info","ts":"2026-06-09T22:36:43.141442Z","caller":"traceutil/trace.go:171","msg":"trace[1733096791] transaction","detail":"{read_only:false; response_revision:8487; number_of_response:1; }","duration":"255.251646ms","start":"2026-06-09T22:36:42.886147Z","end":"2026-06-09T22:36:43.141399Z","steps":["trace[1733096791] 'process raft request' (duration: 255.081553ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:36:54.038378Z","caller":"traceutil/trace.go:171","msg":"trace[1348298198] transaction","detail":"{read_only:false; response_revision:8545; number_of_response:1; }","duration":"118.379108ms","start":"2026-06-09T22:36:53.919955Z","end":"2026-06-09T22:36:54.038334Z","steps":["trace[1348298198] 'process raft request' (duration: 118.145673ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:36:54.673509Z","caller":"traceutil/trace.go:171","msg":"trace[559832739] linearizableReadLoop","detail":"{readStateIndex:8853; appliedIndex:8852; }","duration":"135.969344ms","start":"2026-06-09T22:36:54.537519Z","end":"2026-06-09T22:36:54.673489Z","steps":["trace[559832739] 'read index received' (duration: 135.923383ms)","trace[559832739] 'applied index is now lower than readState.Index' (duration: 44.701µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:36:54.673606Z","caller":"traceutil/trace.go:171","msg":"trace[1140593132] transaction","detail":"{read_only:false; response_revision:8548; number_of_response:1; }","duration":"138.252908ms","start":"2026-06-09T22:36:54.535315Z","end":"2026-06-09T22:36:54.673568Z","steps":["trace[1140593132] 'process raft request' (duration: 138.011374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:36:54.673698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.155657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-09T22:36:54.673729Z","caller":"traceutil/trace.go:171","msg":"trace[602690278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8548; }","duration":"136.227909ms","start":"2026-06-09T22:36:54.537493Z","end":"2026-06-09T22:36:54.673721Z","steps":["trace[602690278] 'agreement among raft nodes before linearized reading' (duration: 136.095477ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:36:54.68109Z","caller":"traceutil/trace.go:171","msg":"trace[554781877] transaction","detail":"{read_only:false; response_revision:8549; number_of_response:1; }","duration":"142.200733ms","start":"2026-06-09T22:36:54.53886Z","end":"2026-06-09T22:36:54.68106Z","steps":["trace[554781877] 'process raft request' (duration: 141.596282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:36:55.524606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.856174ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:36:55.524738Z","caller":"traceutil/trace.go:171","msg":"trace[272506967] linearizableReadLoop","detail":"{readStateIndex:8857; appliedIndex:8856; }","duration":"108.4955ms","start":"2026-06-09T22:36:55.41623Z","end":"2026-06-09T22:36:55.524726Z","steps":["trace[272506967] 'read index received' (duration: 7.370431ms)","trace[272506967] 'applied index is now lower than readState.Index' (duration: 101.124129ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:36:55.524743Z","caller":"traceutil/trace.go:171","msg":"trace[86710098] transaction","detail":"{read_only:false; response_revision:8552; number_of_response:1; }","duration":"154.386045ms","start":"2026-06-09T22:36:55.370331Z","end":"2026-06-09T22:36:55.524717Z","steps":["trace[86710098] 'process raft request' (duration: 53.327857ms)","trace[86710098] 'compare' (duration: 100.755322ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:36:55.525075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.832486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:36:55.525134Z","caller":"traceutil/trace.go:171","msg":"trace[429301275] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:8552; }","duration":"108.939538ms","start":"2026-06-09T22:36:55.416183Z","end":"2026-06-09T22:36:55.525122Z","steps":["trace[429301275] 'agreement among raft nodes before linearized reading' (duration: 108.578302ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:36:56.31096Z","caller":"traceutil/trace.go:171","msg":"trace[1433981284] linearizableReadLoop","detail":"{readStateIndex:8861; appliedIndex:8859; }","duration":"154.231822ms","start":"2026-06-09T22:36:56.156687Z","end":"2026-06-09T22:36:56.310919Z","steps":["trace[1433981284] 'read index received' (duration: 153.879946ms)","trace[1433981284] 'applied index is now lower than readState.Index' (duration: 350.736µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:36:56.311017Z","caller":"traceutil/trace.go:171","msg":"trace[368468951] transaction","detail":"{read_only:false; response_revision:8555; number_of_response:1; }","duration":"261.213423ms","start":"2026-06-09T22:36:56.049779Z","end":"2026-06-09T22:36:56.310993Z","steps":["trace[368468951] 'process raft request' (duration: 260.916897ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:36:56.311113Z","caller":"traceutil/trace.go:171","msg":"trace[1045549912] transaction","detail":"{read_only:false; response_revision:8556; number_of_response:1; }","duration":"261.016409ms","start":"2026-06-09T22:36:56.050054Z","end":"2026-06-09T22:36:56.311071Z","steps":["trace[1045549912] 'process raft request' (duration: 260.811605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:36:56.311172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.508568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:36:56.31121Z","caller":"traceutil/trace.go:171","msg":"trace[1258213589] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:8556; }","duration":"154.62552ms","start":"2026-06-09T22:36:56.156574Z","end":"2026-06-09T22:36:56.311199Z","steps":["trace[1258213589] 'agreement among raft nodes before linearized reading' (duration: 154.529568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:36:56.311757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.182161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:36:56.311871Z","caller":"traceutil/trace.go:171","msg":"trace[1739730915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8556; }","duration":"111.353855ms","start":"2026-06-09T22:36:56.200476Z","end":"2026-06-09T22:36:56.31183Z","steps":["trace[1739730915] 'agreement among raft nodes before linearized reading' (duration: 110.697193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:37:27.912544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.37201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:37:27.912741Z","caller":"traceutil/trace.go:171","msg":"trace[1122492413] linearizableReadLoop","detail":"{readStateIndex:9094; appliedIndex:9092; }","duration":"216.4483ms","start":"2026-06-09T22:37:27.696276Z","end":"2026-06-09T22:37:27.912724Z","steps":["trace[1122492413] 'read index received' (duration: 122.726212ms)","trace[1122492413] 'applied index is now lower than readState.Index' (duration: 93.721048ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:37:27.912861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.598582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:37:27.912833Z","caller":"traceutil/trace.go:171","msg":"trace[306971507] transaction","detail":"{read_only:false; response_revision:8778; number_of_response:1; }","duration":"266.972914ms","start":"2026-06-09T22:37:27.645813Z","end":"2026-06-09T22:37:27.912786Z","steps":["trace[306971507] 'process raft request' (duration: 40.264839ms)","trace[306971507] 'compare' (duration: 226.256757ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:37:27.912851Z","caller":"traceutil/trace.go:171","msg":"trace[941101243] transaction","detail":"{read_only:false; response_revision:8779; number_of_response:1; }","duration":"264.971815ms","start":"2026-06-09T22:37:27.647822Z","end":"2026-06-09T22:37:27.912794Z","steps":["trace[941101243] 'process raft request' (duration: 264.844113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:37:27.912996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.18871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:37:27.912905Z","caller":"traceutil/trace.go:171","msg":"trace[1603391504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8779; }","duration":"216.694644ms","start":"2026-06-09T22:37:27.696197Z","end":"2026-06-09T22:37:27.912892Z","steps":["trace[1603391504] 'agreement among raft nodes before linearized reading' (duration: 216.623473ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:37:27.913055Z","caller":"traceutil/trace.go:171","msg":"trace[50917210] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:8779; }","duration":"156.313422ms","start":"2026-06-09T22:37:27.756728Z","end":"2026-06-09T22:37:27.913042Z","steps":["trace[50917210] 'agreement among raft nodes before linearized reading' (duration: 156.21501ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:37:36.759081Z","caller":"traceutil/trace.go:171","msg":"trace[1870748035] transaction","detail":"{read_only:false; response_revision:8868; number_of_response:1; }","duration":"201.044734ms","start":"2026-06-09T22:37:36.558012Z","end":"2026-06-09T22:37:36.759057Z","steps":["trace[1870748035] 'process raft request' (duration: 200.894272ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:37:36.834972Z","caller":"traceutil/trace.go:171","msg":"trace[1480202232] transaction","detail":"{read_only:false; response_revision:8869; number_of_response:1; }","duration":"269.571232ms","start":"2026-06-09T22:37:36.565368Z","end":"2026-06-09T22:37:36.834939Z","steps":["trace[1480202232] 'process raft request' (duration: 269.351268ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:37:37.443735Z","caller":"traceutil/trace.go:171","msg":"trace[377746757] transaction","detail":"{read_only:false; response_revision:8873; number_of_response:1; }","duration":"157.691008ms","start":"2026-06-09T22:37:37.286015Z","end":"2026-06-09T22:37:37.443706Z","steps":["trace[377746757] 'process raft request' (duration: 157.495204ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:37:56.203852Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024c8.wal"} {"level":"info","ts":"2026-06-09T22:38:56.421602Z","caller":"traceutil/trace.go:171","msg":"trace[1309101217] transaction","detail":"{read_only:false; response_revision:9636; number_of_response:1; }","duration":"185.053801ms","start":"2026-06-09T22:38:56.236521Z","end":"2026-06-09T22:38:56.421575Z","steps":["trace[1309101217] 'process raft request' (duration: 139.205376ms)","trace[1309101217] 'compare' (duration: 45.716962ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:39:00.43793Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T22:39:00.444623Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-09T22:39:00.444834Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-09T22:41:08.597861Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8131} {"level":"info","ts":"2026-06-09T22:41:08.667768Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8131,"took":"67.28299ms","hash":4013833839,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":28704768,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-09T22:41:08.667896Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4013833839,"revision":8131,"compact-revision":6047} {"level":"info","ts":"2026-06-09T22:44:32.893575Z","caller":"traceutil/trace.go:171","msg":"trace[210357321] transaction","detail":"{read_only:false; response_revision:12059; number_of_response:1; }","duration":"111.907219ms","start":"2026-06-09T22:44:32.781642Z","end":"2026-06-09T22:44:32.89355Z","steps":["trace[210357321] 'process raft request' (duration: 82.274425ms)","trace[210357321] 'compare' (duration: 29.524762ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:44:34.237075Z","caller":"traceutil/trace.go:171","msg":"trace[667090219] transaction","detail":"{read_only:false; response_revision:12066; number_of_response:1; }","duration":"104.961507ms","start":"2026-06-09T22:44:34.13207Z","end":"2026-06-09T22:44:34.237032Z","steps":["trace[667090219] 'process raft request' (duration: 104.762563ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:44:34.253754Z","caller":"traceutil/trace.go:171","msg":"trace[1203943171] transaction","detail":"{read_only:false; response_revision:12067; number_of_response:1; }","duration":"121.575343ms","start":"2026-06-09T22:44:34.132132Z","end":"2026-06-09T22:44:34.253708Z","steps":["trace[1203943171] 'process raft request' (duration: 121.270337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:44:34.253798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.129955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:44:34.254547Z","caller":"traceutil/trace.go:171","msg":"trace[712763629] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:12067; }","duration":"100.968131ms","start":"2026-06-09T22:44:34.153555Z","end":"2026-06-09T22:44:34.254523Z","steps":["trace[712763629] 'agreement among raft nodes before linearized reading' (duration: 100.075384ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:46:08.604272Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10538} {"level":"info","ts":"2026-06-09T22:46:08.689166Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10538,"took":"81.779282ms","hash":880673834,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":26558464,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-09T22:46:08.68925Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":880673834,"revision":10538,"compact-revision":8131} {"level":"info","ts":"2026-06-09T22:51:08.803485Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12701} {"level":"info","ts":"2026-06-09T22:51:08.803586Z","caller":"traceutil/trace.go:171","msg":"trace[1288703516] compact","detail":"{revision:12701; response_revision:14690; }","duration":"162.387176ms","start":"2026-06-09T22:51:08.641165Z","end":"2026-06-09T22:51:08.803552Z","steps":["trace[1288703516] 'process raft request' (duration: 117.864512ms)","trace[1288703516] 'check and update compact revision' (duration: 44.33315ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:51:08.880434Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12701,"took":"73.837828ms","hash":4267049819,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":27095040,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-09T22:51:08.880514Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4267049819,"revision":12701,"compact-revision":10538} {"level":"warn","ts":"2026-06-09T22:51:17.669592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.183463ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:51:17.669844Z","caller":"traceutil/trace.go:171","msg":"trace[1320583271] transaction","detail":"{read_only:false; response_revision:14753; number_of_response:1; }","duration":"245.5419ms","start":"2026-06-09T22:51:17.424212Z","end":"2026-06-09T22:51:17.669754Z","steps":["trace[1320583271] 'process raft request' (duration: 47.098032ms)","trace[1320583271] 'compare' (duration: 198.018571ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:51:27.860454Z","caller":"traceutil/trace.go:171","msg":"trace[376739247] transaction","detail":"{read_only:false; response_revision:14924; number_of_response:1; }","duration":"108.81774ms","start":"2026-06-09T22:51:27.7516Z","end":"2026-06-09T22:51:27.860418Z","steps":["trace[376739247] 'process raft request' (duration: 108.602857ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:51:28.032649Z","caller":"traceutil/trace.go:171","msg":"trace[1428005475] transaction","detail":"{read_only:false; response_revision:14925; number_of_response:1; }","duration":"120.064663ms","start":"2026-06-09T22:51:27.912548Z","end":"2026-06-09T22:51:28.032612Z","steps":["trace[1428005475] 'process raft request' (duration: 80.890031ms)","trace[1428005475] 'compare' (duration: 39.004449ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:51:28.042026Z","caller":"traceutil/trace.go:171","msg":"trace[1008015491] transaction","detail":"{read_only:false; response_revision:14926; number_of_response:1; }","duration":"128.101806ms","start":"2026-06-09T22:51:27.913882Z","end":"2026-06-09T22:51:28.041984Z","steps":["trace[1008015491] 'process raft request' (duration: 127.214578ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:53:04.090459Z","caller":"traceutil/trace.go:171","msg":"trace[500572998] transaction","detail":"{read_only:false; response_revision:15990; number_of_response:1; }","duration":"119.881264ms","start":"2026-06-09T22:53:03.970549Z","end":"2026-06-09T22:53:04.090431Z","steps":["trace[500572998] 'process raft request' (duration: 119.679219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:53:04.313413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.402209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T22:53:04.313559Z","caller":"traceutil/trace.go:171","msg":"trace[1885341609] linearizableReadLoop","detail":"{readStateIndex:16541; appliedIndex:16538; }","duration":"240.47643ms","start":"2026-06-09T22:53:04.073067Z","end":"2026-06-09T22:53:04.313543Z","steps":["trace[1885341609] 'read index received' (duration: 17.142915ms)","trace[1885341609] 'applied index is now lower than readState.Index' (duration: 223.332665ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:53:04.313763Z","caller":"traceutil/trace.go:171","msg":"trace[152582943] transaction","detail":"{read_only:false; response_revision:15991; number_of_response:1; }","duration":"338.583051ms","start":"2026-06-09T22:53:03.975165Z","end":"2026-06-09T22:53:04.313748Z","steps":["trace[152582943] 'process raft request' (duration: 203.767975ms)","trace[152582943] 'compare' (duration: 134.284536ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:53:04.313828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T22:53:03.975148Z","time spent":"338.649402ms","remote":"127.0.0.1:60688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T22:53:04.313983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.848184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T22:53:04.314009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.034827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:53:04.314041Z","caller":"traceutil/trace.go:171","msg":"trace[886960280] transaction","detail":"{read_only:false; response_revision:15992; number_of_response:1; }","duration":"286.765057ms","start":"2026-06-09T22:53:04.027262Z","end":"2026-06-09T22:53:04.314027Z","steps":["trace[886960280] 'process raft request' (duration: 286.228607ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:53:04.314054Z","caller":"traceutil/trace.go:171","msg":"trace[1083249572] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15992; }","duration":"138.107638ms","start":"2026-06-09T22:53:04.175935Z","end":"2026-06-09T22:53:04.314042Z","steps":["trace[1083249572] 'agreement among raft nodes before linearized reading' (duration: 138.023107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:53:04.314102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.140864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T22:53:04.314046Z","caller":"traceutil/trace.go:171","msg":"trace[1385331561] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:0; response_revision:15992; }","duration":"137.930495ms","start":"2026-06-09T22:53:04.176101Z","end":"2026-06-09T22:53:04.314032Z","steps":["trace[1385331561] 'agreement among raft nodes before linearized reading' (duration: 137.819503ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:53:04.314137Z","caller":"traceutil/trace.go:171","msg":"trace[282478491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15992; }","duration":"113.217676ms","start":"2026-06-09T22:53:04.20091Z","end":"2026-06-09T22:53:04.314128Z","steps":["trace[282478491] 'agreement among raft nodes before linearized reading' (duration: 113.157325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:53:04.31415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.09865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:666"} {"level":"warn","ts":"2026-06-09T22:53:04.314206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.49119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-09T22:53:04.314247Z","caller":"traceutil/trace.go:171","msg":"trace[59026805] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15992; }","duration":"137.270683ms","start":"2026-06-09T22:53:04.176953Z","end":"2026-06-09T22:53:04.314224Z","steps":["trace[59026805] 'agreement among raft nodes before linearized reading' (duration: 136.949248ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:53:04.314292Z","caller":"traceutil/trace.go:171","msg":"trace[1981797230] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15992; }","duration":"183.615282ms","start":"2026-06-09T22:53:04.130648Z","end":"2026-06-09T22:53:04.314264Z","steps":["trace[1981797230] 'agreement among raft nodes before linearized reading' (duration: 183.428229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:53:04.314318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.63861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-metadata\" ","response":"range_response_count:1 size:681"} {"level":"info","ts":"2026-06-09T22:53:04.314437Z","caller":"traceutil/trace.go:171","msg":"trace[693951676] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-metadata; range_end:; response_count:1; response_revision:15992; }","duration":"137.826114ms","start":"2026-06-09T22:53:04.176588Z","end":"2026-06-09T22:53:04.314414Z","steps":["trace[693951676] 'agreement among raft nodes before linearized reading' (duration: 137.342674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:53:04.314467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.424091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-06-09T22:53:04.314515Z","caller":"traceutil/trace.go:171","msg":"trace[1619163329] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15992; }","duration":"133.496993ms","start":"2026-06-09T22:53:04.181007Z","end":"2026-06-09T22:53:04.314504Z","steps":["trace[1619163329] 'agreement among raft nodes before linearized reading' (duration: 133.34565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:53:04.313993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.915449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:53:04.314615Z","caller":"traceutil/trace.go:171","msg":"trace[217340451] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:15992; }","duration":"241.585551ms","start":"2026-06-09T22:53:04.073009Z","end":"2026-06-09T22:53:04.314595Z","steps":["trace[217340451] 'agreement among raft nodes before linearized reading' (duration: 240.909378ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T22:53:04.313993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.444626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T22:53:04.314698Z","caller":"traceutil/trace.go:171","msg":"trace[1869625379] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:15992; }","duration":"224.239702ms","start":"2026-06-09T22:53:04.090441Z","end":"2026-06-09T22:53:04.314681Z","steps":["trace[1869625379] 'agreement among raft nodes before linearized reading' (duration: 223.419306ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:56:08.811041Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14690} {"level":"info","ts":"2026-06-09T22:56:08.88994Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14690,"took":"74.322852ms","hash":1265789432,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":33792000,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-09T22:56:08.890003Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1265789432,"revision":14690,"compact-revision":12701} {"level":"warn","ts":"2026-06-09T22:58:46.400454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.902627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-09T22:58:46.400578Z","caller":"traceutil/trace.go:171","msg":"trace[110082483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18505; }","duration":"117.083011ms","start":"2026-06-09T22:58:46.283471Z","end":"2026-06-09T22:58:46.400554Z","steps":["trace[110082483] 'range keys from in-memory index tree' (duration: 116.676663ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T22:58:52.358645Z","caller":"traceutil/trace.go:171","msg":"trace[1103290064] transaction","detail":"{read_only:false; response_revision:18545; number_of_response:1; }","duration":"145.932968ms","start":"2026-06-09T22:58:52.212662Z","end":"2026-06-09T22:58:52.358595Z","steps":["trace[1103290064] 'process raft request' (duration: 121.144157ms)","trace[1103290064] 'compare' (duration: 24.421284ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T22:58:52.649648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.229259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-09T22:58:52.649859Z","caller":"traceutil/trace.go:171","msg":"trace[1378389775] transaction","detail":"{read_only:false; response_revision:18547; number_of_response:1; }","duration":"201.675986ms","start":"2026-06-09T22:58:52.448142Z","end":"2026-06-09T22:58:52.649818Z","steps":["trace[1378389775] 'process raft request' (duration: 99.172372ms)","trace[1378389775] 'compare' (duration: 102.030245ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:58:52.811747Z","caller":"traceutil/trace.go:171","msg":"trace[485365480] transaction","detail":"{read_only:false; response_revision:18548; number_of_response:1; }","duration":"158.832913ms","start":"2026-06-09T22:58:52.652879Z","end":"2026-06-09T22:58:52.811712Z","steps":["trace[485365480] 'process raft request' (duration: 124.012672ms)","trace[485365480] 'compare' (duration: 34.542785ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T22:58:52.812Z","caller":"traceutil/trace.go:171","msg":"trace[2036531170] transaction","detail":"{read_only:false; response_revision:18549; number_of_response:1; }","duration":"156.580221ms","start":"2026-06-09T22:58:52.655367Z","end":"2026-06-09T22:58:52.811947Z","steps":["trace[2036531170] 'process raft request' (duration: 156.273945ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T23:00:55.027933Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a31e123290fcf0df","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-09T23:00:55.036311Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-09T23:00:55.036691Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-09T23:01:08.81996Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17436} {"level":"info","ts":"2026-06-09T23:01:08.91912Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17436,"took":"95.146854ms","hash":3300321736,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":32088064,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-09T23:01:08.919173Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3300321736,"revision":17436,"compact-revision":14690} {"level":"info","ts":"2026-06-09T23:06:08.837737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19411} {"level":"info","ts":"2026-06-09T23:06:08.934567Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19411,"took":"92.240209ms","hash":2842510481,"current-db-size-bytes":57475072,"current-db-size":"58 MB","current-db-size-in-use-bytes":27054080,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-09T23:06:08.934625Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2842510481,"revision":19411,"compact-revision":17436}