{"level":"warn","ts":"2026-04-20T11:51:33.418553Z","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-20T11:51:33.418647Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250: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-20T11:51:33.418723Z","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-20T11:51:33.418741Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-20T11:51:33.418763Z","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-20T11:51:33.419507Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-04-20T11:51:33.419583Z","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.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250: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-20T11:51:33.432871Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"13.08753ms"} {"level":"info","ts":"2026-04-20T11:51:33.444016Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-04-20T11:51:33.444114Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T11:51:33.444138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-04-20T11:51:33.444149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T11:51:33.44416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-04-20T11:51:33.444246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-04-20T11:51:33.455082Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T11:51:33.456341Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T11:51:33.457355Z","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-20T11:51:33.459312Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T11:51:33.459415Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T11:51:33.4596Z","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-20T11:51:33.459717Z","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-20T11:51:33.459759Z","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-20T11:51:33.461559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-04-20T11:51:33.461673Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-20T11:51:33.463537Z","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-20T11:51:33.463744Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T11:51:33.463782Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T11:51:33.463883Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-20T11:51:33.463905Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-20T11:51:34.245025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T11:51:34.245187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T11:51:34.245237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-04-20T11:51:34.245281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-04-20T11:51:34.245322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-20T11:51:34.245361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-04-20T11:51:34.245466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-20T11:51:34.246857Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T11:51:34.246911Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:51:34.246938Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T11:51:34.247258Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T11:51:34.24731Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T11:51:34.24733Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:51:34.250369Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-04-20T11:51:34.250592Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T11:51:34.256761Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:51:34.256865Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:51:34.256896Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T11:51:46.607007Z","caller":"traceutil/trace.go:171","msg":"trace[1819714091] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"191.033478ms","start":"2026-04-20T11:51:46.415945Z","end":"2026-04-20T11:51:46.606978Z","steps":["trace[1819714091] 'process raft request' (duration: 190.890875ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:09.941381Z","caller":"traceutil/trace.go:171","msg":"trace[1300067333] linearizableReadLoop","detail":"{readStateIndex:682; appliedIndex:681; }","duration":"256.979117ms","start":"2026-04-20T11:52:09.684378Z","end":"2026-04-20T11:52:09.941357Z","steps":["trace[1300067333] 'read index received' (duration: 256.758203ms)","trace[1300067333] 'applied index is now lower than readState.Index' (duration: 220.134µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:52:09.9415Z","caller":"traceutil/trace.go:171","msg":"trace[379748882] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"257.595198ms","start":"2026-04-20T11:52:09.683889Z","end":"2026-04-20T11:52:09.941485Z","steps":["trace[379748882] 'process raft request' (duration: 257.250222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:52:09.941633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.222121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:52:09.941731Z","caller":"traceutil/trace.go:171","msg":"trace[1546507715] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:660; }","duration":"257.347954ms","start":"2026-04-20T11:52:09.684364Z","end":"2026-04-20T11:52:09.941712Z","steps":["trace[1546507715] 'agreement among raft nodes before linearized reading' (duration: 257.203421ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:10.115908Z","caller":"traceutil/trace.go:171","msg":"trace[683455788] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"368.083317ms","start":"2026-04-20T11:52:09.747722Z","end":"2026-04-20T11:52:10.115805Z","steps":["trace[683455788] 'process raft request' (duration: 353.248074ms)","trace[683455788] 'compare' (duration: 11.346677ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:52:10.116124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.169457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:52:10.116163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.654332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:52:10.116255Z","caller":"traceutil/trace.go:171","msg":"trace[183982865] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:661; }","duration":"431.754404ms","start":"2026-04-20T11:52:09.684469Z","end":"2026-04-20T11:52:10.116224Z","steps":["trace[183982865] 'agreement among raft nodes before linearized reading' (duration: 431.5244ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:10.116261Z","caller":"traceutil/trace.go:171","msg":"trace[201956973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:661; }","duration":"217.293389ms","start":"2026-04-20T11:52:09.898914Z","end":"2026-04-20T11:52:10.116208Z","steps":["trace[201956973] 'agreement among raft nodes before linearized reading' (duration: 217.152896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:52:10.116358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.649263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-20T11:52:10.116123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.990364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:52:10.116369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.684424Z","time spent":"431.925127ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T11:52:10.11645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.862688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:52:10.116355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.711145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:52:10.116535Z","caller":"traceutil/trace.go:171","msg":"trace[1385837248] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:661; }","duration":"297.949109ms","start":"2026-04-20T11:52:09.818554Z","end":"2026-04-20T11:52:10.116503Z","steps":["trace[1385837248] 'agreement among raft nodes before linearized reading' (duration: 297.831927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:52:10.116281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.163853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:52:10.116454Z","caller":"traceutil/trace.go:171","msg":"trace[1815908811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:661; }","duration":"242.764825ms","start":"2026-04-20T11:52:09.873663Z","end":"2026-04-20T11:52:10.116428Z","steps":["trace[1815908811] 'agreement among raft nodes before linearized reading' (duration: 242.538891ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:10.116598Z","caller":"traceutil/trace.go:171","msg":"trace[1429595468] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:661; }","duration":"297.938529ms","start":"2026-04-20T11:52:09.818608Z","end":"2026-04-20T11:52:10.116546Z","steps":["trace[1429595468] 'agreement among raft nodes before linearized reading' (duration: 297.676454ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:10.116454Z","caller":"traceutil/trace.go:171","msg":"trace[729064126] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:661; }","duration":"326.362972ms","start":"2026-04-20T11:52:09.790063Z","end":"2026-04-20T11:52:10.116426Z","steps":["trace[729064126] 'agreement among raft nodes before linearized reading' (duration: 325.900412ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:10.116651Z","caller":"traceutil/trace.go:171","msg":"trace[1735680270] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:661; }","duration":"297.551411ms","start":"2026-04-20T11:52:09.819057Z","end":"2026-04-20T11:52:10.116609Z","steps":["trace[1735680270] 'agreement among raft nodes before linearized reading' (duration: 297.136953ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:10.116024Z","caller":"traceutil/trace.go:171","msg":"trace[587124600] linearizableReadLoop","detail":"{readStateIndex:683; appliedIndex:682; }","duration":"174.482751ms","start":"2026-04-20T11:52:09.941455Z","end":"2026-04-20T11:52:10.115938Z","steps":["trace[587124600] 'read index received' (duration: 159.602367ms)","trace[587124600] 'applied index is now lower than readState.Index' (duration: 14.869653ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:52:10.116743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.790047Z","time spent":"326.633106ms","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 "} {"level":"warn","ts":"2026-04-20T11:52:10.117013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.627366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:52:10.117095Z","caller":"traceutil/trace.go:171","msg":"trace[1179747856] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:661; }","duration":"327.556604ms","start":"2026-04-20T11:52:09.789503Z","end":"2026-04-20T11:52:10.11706Z","steps":["trace[1179747856] 'agreement among raft nodes before linearized reading' (duration: 326.561225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:52:10.117141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.789481Z","time spent":"327.647416ms","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 "} {"level":"warn","ts":"2026-04-20T11:52:10.119203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.578705ms","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-20T11:52:10.119261Z","caller":"traceutil/trace.go:171","msg":"trace[694778151] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:661; }","duration":"348.676097ms","start":"2026-04-20T11:52:09.770566Z","end":"2026-04-20T11:52:10.119242Z","steps":["trace[694778151] 'agreement among raft nodes before linearized reading' (duration: 345.856454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:52:10.119296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.770541Z","time spent":"348.747699ms","remote":"127.0.0.1:49920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-20T11:52:10.119376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.859568ms","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:5"} {"level":"info","ts":"2026-04-20T11:52:10.119465Z","caller":"traceutil/trace.go:171","msg":"trace[2034122900] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:661; }","duration":"329.9747ms","start":"2026-04-20T11:52:09.789452Z","end":"2026-04-20T11:52:10.119427Z","steps":["trace[2034122900] 'agreement among raft nodes before linearized reading' (duration: 326.976903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:52:10.119554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.789441Z","time spent":"330.101103ms","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-04-20T11:52:10.119499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.516605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:52:10.119552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.007694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:52:10.119597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.559867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T11:52:10.119985Z","caller":"traceutil/trace.go:171","msg":"trace[547747794] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:661; }","duration":"434.947314ms","start":"2026-04-20T11:52:09.685016Z","end":"2026-04-20T11:52:10.119963Z","steps":["trace[547747794] 'agreement among raft nodes before linearized reading' (duration: 431.428987ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:10.12001Z","caller":"traceutil/trace.go:171","msg":"trace[610691274] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:661; }","duration":"349.410742ms","start":"2026-04-20T11:52:09.770534Z","end":"2026-04-20T11:52:10.119945Z","steps":["trace[610691274] 'agreement among raft nodes before linearized reading' (duration: 345.905505ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:52:10.120157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.770492Z","time spent":"349.650686ms","remote":"127.0.0.1:49920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-20T11:52:10.119874Z","caller":"traceutil/trace.go:171","msg":"trace[1673730732] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:661; }","duration":"348.856341ms","start":"2026-04-20T11:52:09.770937Z","end":"2026-04-20T11:52:10.119794Z","steps":["trace[1673730732] 'agreement among raft nodes before linearized reading' (duration: 345.497037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:52:10.120254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.770926Z","time spent":"349.315909ms","remote":"127.0.0.1:49920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-04-20T11:52:10.120077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.747702Z","time spent":"368.400964ms","remote":"127.0.0.1:44420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4617,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:52:10.12008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:52:09.685009Z","time spent":"435.025515ms","remote":"127.0.0.1:49904","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 "} {"level":"info","ts":"2026-04-20T11:52:10.122123Z","caller":"traceutil/trace.go:171","msg":"trace[348643716] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"164.911909ms","start":"2026-04-20T11:52:09.957175Z","end":"2026-04-20T11:52:10.122087Z","steps":["trace[348643716] 'process raft request' (duration: 163.175455ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:52:13.264054Z","caller":"traceutil/trace.go:171","msg":"trace[1890531631] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"222.153611ms","start":"2026-04-20T11:52:13.041866Z","end":"2026-04-20T11:52:13.26402Z","steps":["trace[1890531631] 'read index received' (duration: 157.397095ms)","trace[1890531631] 'applied index is now lower than readState.Index' (duration: 64.755396ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:52:13.264122Z","caller":"traceutil/trace.go:171","msg":"trace[679948465] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"299.341836ms","start":"2026-04-20T11:52:12.964764Z","end":"2026-04-20T11:52:13.264106Z","steps":["trace[679948465] 'process raft request' (duration: 234.598859ms)","trace[679948465] 'compare' (duration: 64.493282ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:52:13.264281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.382816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T11:52:13.264391Z","caller":"traceutil/trace.go:171","msg":"trace[338247414] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:683; }","duration":"222.552689ms","start":"2026-04-20T11:52:13.041809Z","end":"2026-04-20T11:52:13.264361Z","steps":["trace[338247414] 'agreement among raft nodes before linearized reading' (duration: 222.339375ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:53:06.551648Z","caller":"traceutil/trace.go:171","msg":"trace[1673033184] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"136.558277ms","start":"2026-04-20T11:53:06.415063Z","end":"2026-04-20T11:53:06.551621Z","steps":["trace[1673033184] 'process raft request' (duration: 136.416525ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:53:25.417591Z","caller":"traceutil/trace.go:171","msg":"trace[135499998] transaction","detail":"{read_only:false; response_revision:1464; number_of_response:1; }","duration":"113.458954ms","start":"2026-04-20T11:53:25.304089Z","end":"2026-04-20T11:53:25.417548Z","steps":["trace[135499998] 'process raft request' (duration: 113.151788ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:53:48.502813Z","caller":"traceutil/trace.go:171","msg":"trace[1073830996] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1938; }","duration":"146.167413ms","start":"2026-04-20T11:53:48.356616Z","end":"2026-04-20T11:53:48.502783Z","steps":["trace[1073830996] 'read index received' (duration: 145.942818ms)","trace[1073830996] 'applied index is now lower than readState.Index' (duration: 223.295µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:53:48.502924Z","caller":"traceutil/trace.go:171","msg":"trace[494511410] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"324.31647ms","start":"2026-04-20T11:53:48.178583Z","end":"2026-04-20T11:53:48.5029Z","steps":["trace[494511410] 'process raft request' (duration: 323.984623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:53:48.503081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T11:53:48.178548Z","time spent":"324.428811ms","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T11:53:48.5032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.532119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8f13142a-5e38-4499-bfd5-48606e8f376e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-20T11:53:48.503309Z","caller":"traceutil/trace.go:171","msg":"trace[1998549931] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8f13142a-5e38-4499-bfd5-48606e8f376e; range_end:; response_count:1; response_revision:1863; }","duration":"146.748634ms","start":"2026-04-20T11:53:48.356536Z","end":"2026-04-20T11:53:48.503285Z","steps":["trace[1998549931] 'agreement among raft nodes before linearized reading' (duration: 146.406098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:02.775584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.523075ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-20T11:54:39.059778Z","caller":"traceutil/trace.go:171","msg":"trace[694909098] linearizableReadLoop","detail":"{readStateIndex:2280; appliedIndex:2279; }","duration":"192.747411ms","start":"2026-04-20T11:54:38.867002Z","end":"2026-04-20T11:54:39.05975Z","steps":["trace[694909098] 'read index received' (duration: 151.436883ms)","trace[694909098] 'applied index is now lower than readState.Index' (duration: 41.309598ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:54:39.059864Z","caller":"traceutil/trace.go:171","msg":"trace[1657849208] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"200.550486ms","start":"2026-04-20T11:54:38.859277Z","end":"2026-04-20T11:54:39.059827Z","steps":["trace[1657849208] 'process raft request' (duration: 159.181957ms)","trace[1657849208] 'compare' (duration: 41.181286ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T11:54:39.059965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.556598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T11:54:39.05999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.844621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T11:54:39.060039Z","caller":"traceutil/trace.go:171","msg":"trace[394714172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2193; }","duration":"156.687151ms","start":"2026-04-20T11:54:38.903335Z","end":"2026-04-20T11:54:39.060022Z","steps":["trace[394714172] 'agreement among raft nodes before linearized reading' (duration: 156.574459ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:54:39.060084Z","caller":"traceutil/trace.go:171","msg":"trace[2093915059] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2193; }","duration":"109.990674ms","start":"2026-04-20T11:54:38.950075Z","end":"2026-04-20T11:54:39.060065Z","steps":["trace[2093915059] 'agreement among raft nodes before linearized reading' (duration: 109.838841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T11:54:39.060014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.982165ms","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-20T11:54:39.060211Z","caller":"traceutil/trace.go:171","msg":"trace[2027626088] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2193; }","duration":"193.212ms","start":"2026-04-20T11:54:38.866965Z","end":"2026-04-20T11:54:39.060177Z","steps":["trace[2027626088] 'agreement among raft nodes before linearized reading' (duration: 192.883564ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:56.430863Z","caller":"traceutil/trace.go:171","msg":"trace[1615535095] transaction","detail":"{read_only:false; response_revision:2661; number_of_response:1; }","duration":"101.705308ms","start":"2026-04-20T11:55:56.329133Z","end":"2026-04-20T11:55:56.430838Z","steps":["trace[1615535095] 'process raft request' (duration: 101.28279ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:56.598026Z","caller":"traceutil/trace.go:171","msg":"trace[473643144] transaction","detail":"{read_only:false; response_revision:2662; number_of_response:1; }","duration":"161.947666ms","start":"2026-04-20T11:55:56.436035Z","end":"2026-04-20T11:55:56.597982Z","steps":["trace[473643144] 'process raft request' (duration: 133.304444ms)","trace[473643144] 'compare' (duration: 28.477149ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T11:55:56.600009Z","caller":"traceutil/trace.go:171","msg":"trace[2083185863] transaction","detail":"{read_only:false; response_revision:2663; number_of_response:1; }","duration":"162.589518ms","start":"2026-04-20T11:55:56.437385Z","end":"2026-04-20T11:55:56.599974Z","steps":["trace[2083185863] 'process raft request' (duration: 162.277532ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:56.60018Z","caller":"traceutil/trace.go:171","msg":"trace[211625249] transaction","detail":"{read_only:false; response_revision:2665; number_of_response:1; }","duration":"161.875884ms","start":"2026-04-20T11:55:56.438281Z","end":"2026-04-20T11:55:56.600157Z","steps":["trace[211625249] 'process raft request' (duration: 161.833233ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:55:56.600279Z","caller":"traceutil/trace.go:171","msg":"trace[174272889] transaction","detail":"{read_only:false; response_revision:2664; number_of_response:1; }","duration":"162.280683ms","start":"2026-04-20T11:55:56.437959Z","end":"2026-04-20T11:55:56.60024Z","steps":["trace[174272889] 'process raft request' (duration: 161.852385ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T11:56:01.797068Z","caller":"traceutil/trace.go:171","msg":"trace[2128663866] transaction","detail":"{read_only:false; response_revision:2690; number_of_response:1; }","duration":"101.626308ms","start":"2026-04-20T11:56:01.6954Z","end":"2026-04-20T11:56:01.797027Z","steps":["trace[2128663866] 'process raft request' (duration: 101.407893ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:00:33.001419Z","caller":"traceutil/trace.go:171","msg":"trace[1133694723] linearizableReadLoop","detail":"{readStateIndex:5396; appliedIndex:5394; }","duration":"103.318537ms","start":"2026-04-20T12:00:32.898065Z","end":"2026-04-20T12:00:33.001384Z","steps":["trace[1133694723] 'read index received' (duration: 102.95277ms)","trace[1133694723] 'applied index is now lower than readState.Index' (duration: 364.547µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:00:33.001473Z","caller":"traceutil/trace.go:171","msg":"trace[1004599389] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"117.016015ms","start":"2026-04-20T12:00:32.884417Z","end":"2026-04-20T12:00:33.001432Z","steps":["trace[1004599389] 'process raft request' (duration: 116.682529ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:00:33.001617Z","caller":"traceutil/trace.go:171","msg":"trace[1935338229] transaction","detail":"{read_only:false; response_revision:5196; number_of_response:1; }","duration":"117.169788ms","start":"2026-04-20T12:00:32.884425Z","end":"2026-04-20T12:00:33.001595Z","steps":["trace[1935338229] 'process raft request' (duration: 116.894073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:00:33.001895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.808666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T12:00:33.001957Z","caller":"traceutil/trace.go:171","msg":"trace[547549043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5196; }","duration":"103.911868ms","start":"2026-04-20T12:00:32.89803Z","end":"2026-04-20T12:00:33.001942Z","steps":["trace[547549043] 'agreement among raft nodes before linearized reading' (duration: 103.797105ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:00:33.144146Z","caller":"traceutil/trace.go:171","msg":"trace[447258215] transaction","detail":"{read_only:false; response_revision:5197; number_of_response:1; }","duration":"119.563563ms","start":"2026-04-20T12:00:33.024541Z","end":"2026-04-20T12:00:33.144105Z","steps":["trace[447258215] 'process raft request' (duration: 72.948254ms)","trace[447258215] 'compare' (duration: 46.343594ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:00:33.487955Z","caller":"traceutil/trace.go:171","msg":"trace[136188521] transaction","detail":"{read_only:false; response_revision:5198; number_of_response:1; }","duration":"107.561097ms","start":"2026-04-20T12:00:33.380363Z","end":"2026-04-20T12:00:33.487924Z","steps":["trace[136188521] 'process raft request' (duration: 107.377784ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:01:12.561808Z","caller":"traceutil/trace.go:171","msg":"trace[192140502] linearizableReadLoop","detail":"{readStateIndex:5777; appliedIndex:5776; }","duration":"202.614336ms","start":"2026-04-20T12:01:12.359172Z","end":"2026-04-20T12:01:12.561786Z","steps":["trace[192140502] 'read index received' (duration: 202.375542ms)","trace[192140502] 'applied index is now lower than readState.Index' (duration: 238.074µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:01:12.561985Z","caller":"traceutil/trace.go:171","msg":"trace[85803805] transaction","detail":"{read_only:false; response_revision:5566; number_of_response:1; }","duration":"205.612333ms","start":"2026-04-20T12:01:12.356316Z","end":"2026-04-20T12:01:12.561928Z","steps":["trace[85803805] 'process raft request' (duration: 205.319977ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:01:12.562047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.85965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T12:01:12.562246Z","caller":"traceutil/trace.go:171","msg":"trace[52890690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5566; }","duration":"203.094955ms","start":"2026-04-20T12:01:12.359127Z","end":"2026-04-20T12:01:12.562222Z","steps":["trace[52890690] 'agreement among raft nodes before linearized reading' (duration: 202.775519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:01:12.562257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.720455ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T12:01:12.562262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.480184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-20T12:01:12.562373Z","caller":"traceutil/trace.go:171","msg":"trace[1666111882] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:5566; }","duration":"145.925318ms","start":"2026-04-20T12:01:12.416419Z","end":"2026-04-20T12:01:12.562345Z","steps":["trace[1666111882] 'agreement among raft nodes before linearized reading' (duration: 145.645543ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:01:12.562385Z","caller":"traceutil/trace.go:171","msg":"trace[1637379872] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5566; }","duration":"202.642237ms","start":"2026-04-20T12:01:12.359718Z","end":"2026-04-20T12:01:12.562361Z","steps":["trace[1637379872] 'agreement among raft nodes before linearized reading' (duration: 202.3013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:01:13.084908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.036215ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T12:01:13.085159Z","caller":"traceutil/trace.go:171","msg":"trace[188684679] transaction","detail":"{read_only:false; response_revision:5567; number_of_response:1; }","duration":"518.70291ms","start":"2026-04-20T12:01:12.566431Z","end":"2026-04-20T12:01:13.085134Z","steps":["trace[188684679] 'process raft request' (duration: 255.35115ms)","trace[188684679] 'compare' (duration: 262.879891ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:01:13.085288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:01:12.566406Z","time spent":"518.833682ms","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T12:01:13.085171Z","caller":"traceutil/trace.go:171","msg":"trace[997911687] transaction","detail":"{read_only:false; response_revision:5568; number_of_response:1; }","duration":"518.15551ms","start":"2026-04-20T12:01:12.56698Z","end":"2026-04-20T12:01:13.085135Z","steps":["trace[997911687] 'process raft request' (duration: 518.044398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:01:13.085649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:01:12.56695Z","time spent":"518.539777ms","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T12:01:13.11146Z","caller":"traceutil/trace.go:171","msg":"trace[159054862] linearizableReadLoop","detail":"{readStateIndex:5780; appliedIndex:5777; }","duration":"414.403746ms","start":"2026-04-20T12:01:12.69703Z","end":"2026-04-20T12:01:13.111434Z","steps":["trace[159054862] 'read index received' (duration: 124.908874ms)","trace[159054862] 'applied index is now lower than readState.Index' (duration: 289.492882ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:01:13.111682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.64497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-04-20T12:01:13.111759Z","caller":"traceutil/trace.go:171","msg":"trace[1279644302] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5568; }","duration":"414.724942ms","start":"2026-04-20T12:01:12.697015Z","end":"2026-04-20T12:01:13.11174Z","steps":["trace[1279644302] 'agreement among raft nodes before linearized reading' (duration: 414.500428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:01:13.111769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.552244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T12:01:13.111798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.425046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-95p6f\" ","response":"range_response_count:1 size:6524"} {"level":"warn","ts":"2026-04-20T12:01:13.111841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.241046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T12:01:13.111873Z","caller":"traceutil/trace.go:171","msg":"trace[990618795] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5568; }","duration":"211.718038ms","start":"2026-04-20T12:01:12.900128Z","end":"2026-04-20T12:01:13.111846Z","steps":["trace[990618795] 'agreement among raft nodes before linearized reading' (duration: 211.501904ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:01:13.111868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.469572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-20T12:01:13.111897Z","caller":"traceutil/trace.go:171","msg":"trace[9930431] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5568; }","duration":"308.352268ms","start":"2026-04-20T12:01:12.80353Z","end":"2026-04-20T12:01:13.111882Z","steps":["trace[9930431] 'agreement among raft nodes before linearized reading' (duration: 308.172235ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:01:13.11194Z","caller":"traceutil/trace.go:171","msg":"trace[817623388] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5568; }","duration":"409.597065ms","start":"2026-04-20T12:01:12.702325Z","end":"2026-04-20T12:01:13.111922Z","steps":["trace[817623388] 'agreement among raft nodes before linearized reading' (duration: 409.293519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:01:13.111944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:01:12.803503Z","time spent":"308.428549ms","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T12:01:13.111987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:01:12.702301Z","time spent":"409.673897ms","remote":"127.0.0.1:44396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-04-20T12:01:13.111881Z","caller":"traceutil/trace.go:171","msg":"trace[2126816583] range","detail":"{range_begin:/registry/pods/openstack/keepalived-95p6f; range_end:; response_count:1; response_revision:5568; }","duration":"259.505038ms","start":"2026-04-20T12:01:12.852352Z","end":"2026-04-20T12:01:13.111857Z","steps":["trace[2126816583] 'agreement among raft nodes before linearized reading' (duration: 259.313664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:01:13.111811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:01:12.696955Z","time spent":"414.842604ms","remote":"127.0.0.1:44422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10416,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-04-20T12:01:34.281415Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2860} {"level":"info","ts":"2026-04-20T12:01:34.342053Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2860,"took":"59.239966ms","hash":3100595529,"current-db-size-bytes":55013376,"current-db-size":"55 MB","current-db-size-in-use-bytes":31621120,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-20T12:01:34.342129Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3100595529,"revision":2860,"compact-revision":-1} {"level":"info","ts":"2026-04-20T12:06:34.28945Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5761} {"level":"info","ts":"2026-04-20T12:06:34.366819Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5761,"took":"75.396508ms","hash":1353115080,"current-db-size-bytes":55013376,"current-db-size":"55 MB","current-db-size-in-use-bytes":24649728,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-20T12:06:34.366878Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1353115080,"revision":5761,"compact-revision":2860} {"level":"info","ts":"2026-04-20T12:06:52.945921Z","caller":"traceutil/trace.go:171","msg":"trace[1061701482] linearizableReadLoop","detail":"{readStateIndex:8508; appliedIndex:8507; }","duration":"198.708139ms","start":"2026-04-20T12:06:52.747191Z","end":"2026-04-20T12:06:52.945899Z","steps":["trace[1061701482] 'read index received' (duration: 165.338381ms)","trace[1061701482] 'applied index is now lower than readState.Index' (duration: 33.367378ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T12:06:52.946099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.612128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T12:06:52.946134Z","caller":"traceutil/trace.go:171","msg":"trace[397333285] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8213; }","duration":"197.67418ms","start":"2026-04-20T12:06:52.74845Z","end":"2026-04-20T12:06:52.946125Z","steps":["trace[397333285] 'agreement among raft nodes before linearized reading' (duration: 197.562378ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:06:52.946172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.961793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-20T12:06:52.946238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.368135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-20T12:06:52.946288Z","caller":"traceutil/trace.go:171","msg":"trace[939044578] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8213; }","duration":"199.118976ms","start":"2026-04-20T12:06:52.747143Z","end":"2026-04-20T12:06:52.946262Z","steps":["trace[939044578] 'agreement among raft nodes before linearized reading' (duration: 198.838381ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:06:52.946328Z","caller":"traceutil/trace.go:171","msg":"trace[1423281293] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8213; }","duration":"146.486027ms","start":"2026-04-20T12:06:52.799822Z","end":"2026-04-20T12:06:52.946308Z","steps":["trace[1423281293] 'agreement among raft nodes before linearized reading' (duration: 146.296384ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:05.179834Z","caller":"traceutil/trace.go:171","msg":"trace[184363000] linearizableReadLoop","detail":"{readStateIndex:8573; appliedIndex:8572; }","duration":"179.550358ms","start":"2026-04-20T12:07:05.000254Z","end":"2026-04-20T12:07:05.179805Z","steps":["trace[184363000] 'read index received' (duration: 179.352595ms)","trace[184363000] 'applied index is now lower than readState.Index' (duration: 196.563µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:07:05.179931Z","caller":"traceutil/trace.go:171","msg":"trace[750020517] transaction","detail":"{read_only:false; response_revision:8274; number_of_response:1; }","duration":"196.512458ms","start":"2026-04-20T12:07:04.983368Z","end":"2026-04-20T12:07:05.179881Z","steps":["trace[750020517] 'process raft request' (duration: 196.207712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:05.180174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.854168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-04-20T12:07:05.180234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.138339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T12:07:05.180247Z","caller":"traceutil/trace.go:171","msg":"trace[1534977855] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8274; }","duration":"177.048781ms","start":"2026-04-20T12:07:05.003179Z","end":"2026-04-20T12:07:05.180228Z","steps":["trace[1534977855] 'agreement among raft nodes before linearized reading' (duration: 176.805717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:05.180224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.546657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-20T12:07:05.180272Z","caller":"traceutil/trace.go:171","msg":"trace[1234805478] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8274; }","duration":"172.204181ms","start":"2026-04-20T12:07:05.008058Z","end":"2026-04-20T12:07:05.180262Z","steps":["trace[1234805478] 'agreement among raft nodes before linearized reading' (duration: 172.093289ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:05.180337Z","caller":"traceutil/trace.go:171","msg":"trace[1547354112] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:8274; }","duration":"163.698771ms","start":"2026-04-20T12:07:05.016614Z","end":"2026-04-20T12:07:05.180313Z","steps":["trace[1547354112] 'agreement among raft nodes before linearized reading' (duration: 163.438966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:05.180518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.553694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T12:07:05.180566Z","caller":"traceutil/trace.go:171","msg":"trace[928282067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8274; }","duration":"175.645875ms","start":"2026-04-20T12:07:05.004907Z","end":"2026-04-20T12:07:05.180552Z","steps":["trace[928282067] 'agreement among raft nodes before linearized reading' (duration: 175.412351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:05.180568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.545507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-95p6f\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-04-20T12:07:05.180654Z","caller":"traceutil/trace.go:171","msg":"trace[1638882967] range","detail":"{range_begin:/registry/pods/openstack/keepalived-95p6f; range_end:; response_count:1; response_revision:8274; }","duration":"130.67287ms","start":"2026-04-20T12:07:05.04996Z","end":"2026-04-20T12:07:05.180633Z","steps":["trace[1638882967] 'agreement among raft nodes before linearized reading' (duration: 130.306363ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:05.181047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.788931ms","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-04-20T12:07:05.181095Z","caller":"traceutil/trace.go:171","msg":"trace[1859378561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8274; }","duration":"180.903693ms","start":"2026-04-20T12:07:05.000178Z","end":"2026-04-20T12:07:05.181082Z","steps":["trace[1859378561] 'agreement among raft nodes before linearized reading' (duration: 179.776322ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:05.316286Z","caller":"traceutil/trace.go:171","msg":"trace[10566272] linearizableReadLoop","detail":"{readStateIndex:8574; appliedIndex:8573; }","duration":"131.092336ms","start":"2026-04-20T12:07:05.185171Z","end":"2026-04-20T12:07:05.316263Z","steps":["trace[10566272] 'read index received' (duration: 130.986894ms)","trace[10566272] 'applied index is now lower than readState.Index' (duration: 104.462µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:07:05.316388Z","caller":"traceutil/trace.go:171","msg":"trace[1739108368] transaction","detail":"{read_only:false; response_revision:8275; number_of_response:1; }","duration":"131.411882ms","start":"2026-04-20T12:07:05.184942Z","end":"2026-04-20T12:07:05.316354Z","steps":["trace[1739108368] 'process raft request' (duration: 131.172658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:05.316719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.502943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:24 size:207037"} {"level":"info","ts":"2026-04-20T12:07:05.316768Z","caller":"traceutil/trace.go:171","msg":"trace[909912134] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:24; response_revision:8275; }","duration":"131.588866ms","start":"2026-04-20T12:07:05.185165Z","end":"2026-04-20T12:07:05.316754Z","steps":["trace[909912134] 'agreement among raft nodes before linearized reading' (duration: 131.200968ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:05.323976Z","caller":"traceutil/trace.go:171","msg":"trace[965974064] transaction","detail":"{read_only:false; response_revision:8276; number_of_response:1; }","duration":"138.618338ms","start":"2026-04-20T12:07:05.18534Z","end":"2026-04-20T12:07:05.323958Z","steps":["trace[965974064] 'process raft request' (duration: 138.444255ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:05.324302Z","caller":"traceutil/trace.go:171","msg":"trace[146249060] transaction","detail":"{read_only:false; response_revision:8277; number_of_response:1; }","duration":"138.862002ms","start":"2026-04-20T12:07:05.18541Z","end":"2026-04-20T12:07:05.324272Z","steps":["trace[146249060] 'process raft request' (duration: 138.503375ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:05.324343Z","caller":"traceutil/trace.go:171","msg":"trace[1521259735] transaction","detail":"{read_only:false; response_revision:8278; number_of_response:1; }","duration":"138.446175ms","start":"2026-04-20T12:07:05.185875Z","end":"2026-04-20T12:07:05.324321Z","steps":["trace[1521259735] 'process raft request' (duration: 138.271051ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:05.324347Z","caller":"traceutil/trace.go:171","msg":"trace[1312161590] transaction","detail":"{read_only:false; response_revision:8279; number_of_response:1; }","duration":"138.17968ms","start":"2026-04-20T12:07:05.186146Z","end":"2026-04-20T12:07:05.324325Z","steps":["trace[1312161590] 'process raft request' (duration: 138.112358ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:32.870478Z","caller":"traceutil/trace.go:171","msg":"trace[1006801465] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"411.064206ms","start":"2026-04-20T12:07:32.459393Z","end":"2026-04-20T12:07:32.870457Z","steps":["trace[1006801465] 'process raft request' (duration: 410.943204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:32.870606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:07:32.459367Z","time spent":"411.176118ms","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T12:07:32.874166Z","caller":"traceutil/trace.go:171","msg":"trace[1009828348] transaction","detail":"{read_only:false; response_revision:8479; number_of_response:1; }","duration":"102.343144ms","start":"2026-04-20T12:07:32.77181Z","end":"2026-04-20T12:07:32.874153Z","steps":["trace[1009828348] 'process raft request' (duration: 102.172531ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:45.94497Z","caller":"traceutil/trace.go:171","msg":"trace[1630214391] linearizableReadLoop","detail":"{readStateIndex:8901; appliedIndex:8900; }","duration":"108.596321ms","start":"2026-04-20T12:07:45.836347Z","end":"2026-04-20T12:07:45.944943Z","steps":["trace[1630214391] 'read index received' (duration: 100.936367ms)","trace[1630214391] 'applied index is now lower than readState.Index' (duration: 7.658844ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:07:45.944991Z","caller":"traceutil/trace.go:171","msg":"trace[358703450] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"124.340596ms","start":"2026-04-20T12:07:45.820618Z","end":"2026-04-20T12:07:45.944959Z","steps":["trace[358703450] 'process raft request' (duration: 116.649392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:45.945333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.929697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-wp4dx\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-04-20T12:07:45.945379Z","caller":"traceutil/trace.go:171","msg":"trace[2108090196] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-wp4dx; range_end:; response_count:1; response_revision:8590; }","duration":"109.058089ms","start":"2026-04-20T12:07:45.836309Z","end":"2026-04-20T12:07:45.945367Z","steps":["trace[2108090196] 'agreement among raft nodes before linearized reading' (duration: 108.767354ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:45.963085Z","caller":"traceutil/trace.go:171","msg":"trace[874611726] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"123.265725ms","start":"2026-04-20T12:07:45.839792Z","end":"2026-04-20T12:07:45.963058Z","steps":["trace[874611726] 'process raft request' (duration: 123.111732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:45.963168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.323042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-04-20T12:07:45.963219Z","caller":"traceutil/trace.go:171","msg":"trace[1632042266] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:8591; }","duration":"103.409864ms","start":"2026-04-20T12:07:45.859792Z","end":"2026-04-20T12:07:45.963202Z","steps":["trace[1632042266] 'agreement among raft nodes before linearized reading' (duration: 103.260481ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:46.660573Z","caller":"traceutil/trace.go:171","msg":"trace[1385535332] transaction","detail":"{read_only:false; response_revision:8592; number_of_response:1; }","duration":"324.229413ms","start":"2026-04-20T12:07:46.33631Z","end":"2026-04-20T12:07:46.660539Z","steps":["trace[1385535332] 'process raft request' (duration: 324.025919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:46.660818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T12:07:46.33629Z","time spent":"324.414916ms","remote":"127.0.0.1:44492","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T12:07:47.41848Z","caller":"traceutil/trace.go:171","msg":"trace[1059397648] transaction","detail":"{read_only:false; response_revision:8597; number_of_response:1; }","duration":"230.96538ms","start":"2026-04-20T12:07:47.18747Z","end":"2026-04-20T12:07:47.418435Z","steps":["trace[1059397648] 'process raft request' (duration: 230.738275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T12:07:47.419288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.265755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.250\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T12:07:47.419379Z","caller":"traceutil/trace.go:171","msg":"trace[930350278] range","detail":"{range_begin:/registry/masterleases/199.204.45.250; range_end:; response_count:1; response_revision:8597; }","duration":"208.410038ms","start":"2026-04-20T12:07:47.210949Z","end":"2026-04-20T12:07:47.419359Z","steps":["trace[930350278] 'agreement among raft nodes before linearized reading' (duration: 207.573082ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:07:47.418482Z","caller":"traceutil/trace.go:171","msg":"trace[654574252] linearizableReadLoop","detail":"{readStateIndex:8908; appliedIndex:8907; }","duration":"207.414099ms","start":"2026-04-20T12:07:47.210996Z","end":"2026-04-20T12:07:47.41841Z","steps":["trace[654574252] 'read index received' (duration: 207.339797ms)","trace[654574252] 'applied index is now lower than readState.Index' (duration: 73.122µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T12:07:47.481479Z","caller":"traceutil/trace.go:171","msg":"trace[1968501913] transaction","detail":"{read_only:false; response_revision:8598; number_of_response:1; }","duration":"128.618575ms","start":"2026-04-20T12:07:47.352808Z","end":"2026-04-20T12:07:47.481427Z","steps":["trace[1968501913] 'process raft request' (duration: 124.232143ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T12:08:23.689253Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243a.wal"} {"level":"info","ts":"2026-04-20T12:09:40.90964Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d98d5f2c752cc52d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T12:09:40.917507Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T12:09:40.917588Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T12:11:34.295689Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7938} {"level":"info","ts":"2026-04-20T12:11:34.358796Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7938,"took":"60.82982ms","hash":631059663,"current-db-size-bytes":55013376,"current-db-size":"55 MB","current-db-size-in-use-bytes":28987392,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T12:11:34.358884Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":631059663,"revision":7938,"compact-revision":5761} {"level":"info","ts":"2026-04-20T12:16:34.301461Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10546} {"level":"info","ts":"2026-04-20T12:16:34.381516Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10546,"took":"77.730726ms","hash":3506069469,"current-db-size-bytes":55013376,"current-db-size":"55 MB","current-db-size-in-use-bytes":21225472,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-20T12:16:34.381581Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3506069469,"revision":10546,"compact-revision":7938}