{"level":"warn","ts":"2026-06-12T01:16:35.326648Z","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-12T01:16:35.326736Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-12T01:16:35.326806Z","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-12T01:16:35.326822Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-12T01:16:35.326838Z","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-12T01:16:35.327473Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-06-12T01:16:35.327553Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-12T01:16:35.3329Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.141374ms"} {"level":"info","ts":"2026-06-12T01:16:35.338529Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-06-12T01:16:35.33883Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-06-12T01:16:35.339063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-06-12T01:16:35.339786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-12T01:16:35.339815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-06-12T01:16:35.340048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-06-12T01:16:35.349045Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-12T01:16:35.350143Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-12T01:16:35.351222Z","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-12T01:16:35.353638Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-12T01:16:35.353992Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-12T01:16:35.354002Z","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-12T01:16:35.355031Z","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-12T01:16:35.355127Z","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-12T01:16:35.355245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-06-12T01:16:35.355813Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-12T01:16:35.359697Z","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-12T01:16:35.359875Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-12T01:16:35.359924Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-12T01:16:35.360113Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-12T01:16:35.360167Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-12T01:16:35.441472Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-06-12T01:16:35.441655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-12T01:16:35.441732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-06-12T01:16:35.441811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-06-12T01:16:35.441849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-12T01:16:35.441938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-06-12T01:16:35.441982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-12T01:16:35.443494Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T01:16:35.444462Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-06-12T01:16:35.444478Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-12T01:16:35.444873Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T01:16:35.444511Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-12T01:16:35.445095Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T01:16:35.445105Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-12T01:16:35.445302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-12T01:16:35.445302Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-12T01:16:35.448485Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-06-12T01:16:35.448485Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-12T01:16:49.576476Z","caller":"traceutil/trace.go:171","msg":"trace[1973951365] linearizableReadLoop","detail":"{readStateIndex:416; appliedIndex:415; }","duration":"140.821501ms","start":"2026-06-12T01:16:49.435625Z","end":"2026-06-12T01:16:49.576446Z","steps":["trace[1973951365] 'read index received' (duration: 140.630826ms)","trace[1973951365] 'applied index is now lower than readState.Index' (duration: 189.355µs)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:16:49.577001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.333365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:16:49.577053Z","caller":"traceutil/trace.go:171","msg":"trace[571481652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:401; }","duration":"141.419727ms","start":"2026-06-12T01:16:49.435621Z","end":"2026-06-12T01:16:49.57704Z","steps":["trace[571481652] 'agreement among raft nodes before linearized reading' (duration: 141.305284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:16:49.577251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.603386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4318"} {"level":"info","ts":"2026-06-12T01:16:49.577284Z","caller":"traceutil/trace.go:171","msg":"trace[822129876] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:401; }","duration":"140.680237ms","start":"2026-06-12T01:16:49.436595Z","end":"2026-06-12T01:16:49.577275Z","steps":["trace[822129876] 'agreement among raft nodes before linearized reading' (duration: 140.593575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:16:49.577682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.246382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-12T01:16:49.57773Z","caller":"traceutil/trace.go:171","msg":"trace[1912036880] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:401; }","duration":"102.320165ms","start":"2026-06-12T01:16:49.475398Z","end":"2026-06-12T01:16:49.577718Z","steps":["trace[1912036880] 'agreement among raft nodes before linearized reading' (duration: 102.244513ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:16:49.712433Z","caller":"traceutil/trace.go:171","msg":"trace[672977795] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"132.827892ms","start":"2026-06-12T01:16:49.579565Z","end":"2026-06-12T01:16:49.712392Z","steps":["trace[672977795] 'process raft request' (duration: 130.436509ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:16:49.716914Z","caller":"traceutil/trace.go:171","msg":"trace[1318186795] linearizableReadLoop","detail":"{readStateIndex:420; appliedIndex:416; }","duration":"108.957447ms","start":"2026-06-12T01:16:49.60794Z","end":"2026-06-12T01:16:49.716898Z","steps":["trace[1318186795] 'read index received' (duration: 102.15387ms)","trace[1318186795] 'applied index is now lower than readState.Index' (duration: 6.802277ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:16:49.717191Z","caller":"traceutil/trace.go:171","msg":"trace[963193818] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"134.128936ms","start":"2026-06-12T01:16:49.583051Z","end":"2026-06-12T01:16:49.71718Z","steps":["trace[963193818] 'process raft request' (duration: 133.632483ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:16:49.71734Z","caller":"traceutil/trace.go:171","msg":"trace[1022225205] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"134.045394ms","start":"2026-06-12T01:16:49.583285Z","end":"2026-06-12T01:16:49.717331Z","steps":["trace[1022225205] 'process raft request' (duration: 133.488339ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:16:49.717633Z","caller":"traceutil/trace.go:171","msg":"trace[1620997790] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"132.181475ms","start":"2026-06-12T01:16:49.585441Z","end":"2026-06-12T01:16:49.717623Z","steps":["trace[1620997790] 'process raft request' (duration: 131.391045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:16:49.717826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.869702ms","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-12T01:16:49.71793Z","caller":"traceutil/trace.go:171","msg":"trace[790530380] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:405; }","duration":"110.022086ms","start":"2026-06-12T01:16:49.607885Z","end":"2026-06-12T01:16:49.717907Z","steps":["trace[790530380] 'agreement among raft nodes before linearized reading' (duration: 109.831791ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:16:49.718118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.876286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-12T01:16:49.718153Z","caller":"traceutil/trace.go:171","msg":"trace[28889477] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:405; }","duration":"108.950708ms","start":"2026-06-12T01:16:49.609193Z","end":"2026-06-12T01:16:49.718144Z","steps":["trace[28889477] 'agreement among raft nodes before linearized reading' (duration: 108.891596ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:16:59.419187Z","caller":"traceutil/trace.go:171","msg":"trace[2032513359] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"113.802106ms","start":"2026-06-12T01:16:59.305307Z","end":"2026-06-12T01:16:59.419109Z","steps":["trace[2032513359] 'process raft request' (duration: 95.711444ms)","trace[2032513359] 'compare' (duration: 17.904028ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:17:13.415843Z","caller":"traceutil/trace.go:171","msg":"trace[1489557161] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:649; }","duration":"417.109937ms","start":"2026-06-12T01:17:12.99872Z","end":"2026-06-12T01:17:13.41583Z","steps":["trace[1489557161] 'read index received' (duration: 417.097476ms)","trace[1489557161] 'applied index is now lower than readState.Index' (duration: 11.121µs)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:17:13.416252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.507965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:23081"} {"level":"info","ts":"2026-06-12T01:17:13.416319Z","caller":"traceutil/trace.go:171","msg":"trace[947427902] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:624; }","duration":"417.599087ms","start":"2026-06-12T01:17:12.998708Z","end":"2026-06-12T01:17:13.416307Z","steps":["trace[947427902] 'agreement among raft nodes before linearized reading' (duration: 417.234089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:13.416387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:17:12.998702Z","time spent":"417.675658ms","remote":"127.0.0.1:47946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":1,"response size":23104,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xbackendtrafficpolicies.gateway.networking.x-k8s.io\" "} {"level":"info","ts":"2026-06-12T01:17:13.415743Z","caller":"traceutil/trace.go:171","msg":"trace[793585242] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"420.380986ms","start":"2026-06-12T01:17:12.995291Z","end":"2026-06-12T01:17:13.415671Z","steps":["trace[793585242] 'process raft request' (duration: 420.227953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:13.417005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:17:12.99527Z","time spent":"421.351428ms","remote":"127.0.0.1:47946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-12T01:17:13.428271Z","caller":"traceutil/trace.go:171","msg":"trace[10091464] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"236.95528ms","start":"2026-06-12T01:17:13.1913Z","end":"2026-06-12T01:17:13.428256Z","steps":["trace[10091464] 'process raft request' (duration: 236.878009ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:13.428305Z","caller":"traceutil/trace.go:171","msg":"trace[1970311202] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"397.302195ms","start":"2026-06-12T01:17:13.030969Z","end":"2026-06-12T01:17:13.428271Z","steps":["trace[1970311202] 'process raft request' (duration: 397.054359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:13.428647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.115443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:17:13.428679Z","caller":"traceutil/trace.go:171","msg":"trace[148146783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"277.219335ms","start":"2026-06-12T01:17:13.151449Z","end":"2026-06-12T01:17:13.428668Z","steps":["trace[148146783] 'agreement among raft nodes before linearized reading' (duration: 277.121023ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:13.429056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:17:13.030933Z","time spent":"397.624352ms","remote":"127.0.0.1:47946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:17:17.257547Z","caller":"traceutil/trace.go:171","msg":"trace[84452834] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"131.796302ms","start":"2026-06-12T01:17:17.125714Z","end":"2026-06-12T01:17:17.25751Z","steps":["trace[84452834] 'read index received' (duration: 130.410793ms)","trace[84452834] 'applied index is now lower than readState.Index' (duration: 1.383989ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:17:17.257756Z","caller":"traceutil/trace.go:171","msg":"trace[733848857] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"137.122982ms","start":"2026-06-12T01:17:17.120588Z","end":"2026-06-12T01:17:17.257711Z","steps":["trace[733848857] 'process raft request' (duration: 135.893997ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:17.258104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.244151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T01:17:17.258156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.396634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:17:17.258226Z","caller":"traceutil/trace.go:171","msg":"trace[2029609629] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:668; }","duration":"132.386524ms","start":"2026-06-12T01:17:17.1258Z","end":"2026-06-12T01:17:17.258186Z","steps":["trace[2029609629] 'agreement among raft nodes before linearized reading' (duration: 132.19122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:17.258243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.084172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:17:17.258239Z","caller":"traceutil/trace.go:171","msg":"trace[1850382763] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:668; }","duration":"132.542037ms","start":"2026-06-12T01:17:17.125677Z","end":"2026-06-12T01:17:17.258219Z","steps":["trace[1850382763] 'agreement among raft nodes before linearized reading' (duration: 132.17664ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:17.258291Z","caller":"traceutil/trace.go:171","msg":"trace[926591617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"105.191075ms","start":"2026-06-12T01:17:17.153085Z","end":"2026-06-12T01:17:17.258276Z","steps":["trace[926591617] 'agreement among raft nodes before linearized reading' (duration: 105.040251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:17.258405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.343289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:17:17.258476Z","caller":"traceutil/trace.go:171","msg":"trace[874798418] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:668; }","duration":"106.43532ms","start":"2026-06-12T01:17:17.152018Z","end":"2026-06-12T01:17:17.258454Z","steps":["trace[874798418] 'agreement among raft nodes before linearized reading' (duration: 106.305018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:17.258472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.895304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:17:17.258525Z","caller":"traceutil/trace.go:171","msg":"trace[1234464231] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:668; }","duration":"131.974275ms","start":"2026-06-12T01:17:17.126536Z","end":"2026-06-12T01:17:17.25851Z","steps":["trace[1234464231] 'agreement among raft nodes before linearized reading' (duration: 131.883794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:17.25868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.42593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:17:17.258724Z","caller":"traceutil/trace.go:171","msg":"trace[969293763] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:668; }","duration":"105.471971ms","start":"2026-06-12T01:17:17.153239Z","end":"2026-06-12T01:17:17.258711Z","steps":["trace[969293763] 'agreement among raft nodes before linearized reading' (duration: 105.409009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:17.258692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.450101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:17:17.258879Z","caller":"traceutil/trace.go:171","msg":"trace[1428777861] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:668; }","duration":"106.663905ms","start":"2026-06-12T01:17:17.152206Z","end":"2026-06-12T01:17:17.25887Z","steps":["trace[1428777861] 'agreement among raft nodes before linearized reading' (duration: 106.457561ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:20.092756Z","caller":"traceutil/trace.go:171","msg":"trace[1706876795] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"195.203872ms","start":"2026-06-12T01:17:19.897506Z","end":"2026-06-12T01:17:20.092709Z","steps":["trace[1706876795] 'process raft request' (duration: 194.973278ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:20.240929Z","caller":"traceutil/trace.go:171","msg":"trace[1901773012] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"343.274141ms","start":"2026-06-12T01:17:19.89763Z","end":"2026-06-12T01:17:20.240904Z","steps":["trace[1901773012] 'process raft request' (duration: 343.071507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:20.241201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:17:19.897609Z","time spent":"343.478175ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:17:20.24132Z","caller":"traceutil/trace.go:171","msg":"trace[754151334] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"340.970724ms","start":"2026-06-12T01:17:19.90031Z","end":"2026-06-12T01:17:20.241281Z","steps":["trace[754151334] 'process raft request' (duration: 340.553655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:20.241521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:17:19.900294Z","time spent":"341.115937ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:17:20.241674Z","caller":"traceutil/trace.go:171","msg":"trace[53654900] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"340.80625ms","start":"2026-06-12T01:17:19.900849Z","end":"2026-06-12T01:17:20.241655Z","steps":["trace[53654900] 'process raft request' (duration: 340.27528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:20.241745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:17:19.900834Z","time spent":"340.879853ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:17:22.011529Z","caller":"traceutil/trace.go:171","msg":"trace[1295192683] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"339.594409ms","start":"2026-06-12T01:17:21.671907Z","end":"2026-06-12T01:17:22.011502Z","steps":["trace[1295192683] 'process raft request' (duration: 339.436676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:22.011771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:17:21.671881Z","time spent":"339.723562ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:17:38.355734Z","caller":"traceutil/trace.go:171","msg":"trace[1528865657] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"156.416896ms","start":"2026-06-12T01:17:38.199278Z","end":"2026-06-12T01:17:38.355695Z","steps":["trace[1528865657] 'process raft request' (duration: 156.167102ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:42.858459Z","caller":"traceutil/trace.go:171","msg":"trace[671659862] transaction","detail":"{read_only:false; response_revision:879; number_of_response:1; }","duration":"207.268308ms","start":"2026-06-12T01:17:42.651166Z","end":"2026-06-12T01:17:42.858434Z","steps":["trace[671659862] 'process raft request' (duration: 207.150166ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:44.550653Z","caller":"traceutil/trace.go:171","msg":"trace[800734642] linearizableReadLoop","detail":"{readStateIndex:923; appliedIndex:921; }","duration":"112.602606ms","start":"2026-06-12T01:17:44.438022Z","end":"2026-06-12T01:17:44.550625Z","steps":["trace[800734642] 'read index received' (duration: 30.961009ms)","trace[800734642] 'applied index is now lower than readState.Index' (duration: 81.639817ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:17:44.624375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.516281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-12T01:17:44.624435Z","caller":"traceutil/trace.go:171","msg":"trace[1994081629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:890; }","duration":"110.598032ms","start":"2026-06-12T01:17:44.513824Z","end":"2026-06-12T01:17:44.624422Z","steps":["trace[1994081629] 'agreement among raft nodes before linearized reading' (duration: 37.108545ms)","trace[1994081629] 'range keys from in-memory index tree' (duration: 73.337034ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:17:44.624657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.632992ms","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-12T01:17:44.624673Z","caller":"traceutil/trace.go:171","msg":"trace[423778125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:890; }","duration":"186.668923ms","start":"2026-06-12T01:17:44.438Z","end":"2026-06-12T01:17:44.624669Z","steps":["trace[423778125] 'agreement among raft nodes before linearized reading' (duration: 112.883101ms)","trace[423778125] 'range keys from in-memory index tree' (duration: 73.729301ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:17:44.624762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.834195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-12T01:17:44.624776Z","caller":"traceutil/trace.go:171","msg":"trace[1643481574] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:890; }","duration":"110.877447ms","start":"2026-06-12T01:17:44.513893Z","end":"2026-06-12T01:17:44.624771Z","steps":["trace[1643481574] 'agreement among raft nodes before linearized reading' (duration: 37.026764ms)","trace[1643481574] 'range keys from in-memory index tree' (duration: 73.813402ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:17:44.624877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.70896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-12T01:17:44.624893Z","caller":"traceutil/trace.go:171","msg":"trace[2047982300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:890; }","duration":"111.746661ms","start":"2026-06-12T01:17:44.513142Z","end":"2026-06-12T01:17:44.624888Z","steps":["trace[2047982300] 'agreement among raft nodes before linearized reading' (duration: 37.773246ms)","trace[2047982300] 'range keys from in-memory index tree' (duration: 73.929844ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:17:44.624982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.917117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-12T01:17:44.624997Z","caller":"traceutil/trace.go:171","msg":"trace[465786470] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:890; }","duration":"110.957487ms","start":"2026-06-12T01:17:44.514035Z","end":"2026-06-12T01:17:44.624993Z","steps":["trace[465786470] 'agreement among raft nodes before linearized reading' (duration: 36.890261ms)","trace[465786470] 'range keys from in-memory index tree' (duration: 74.028896ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:17:44.761891Z","caller":"traceutil/trace.go:171","msg":"trace[286227047] transaction","detail":"{read_only:false; response_revision:892; number_of_response:1; }","duration":"133.119936ms","start":"2026-06-12T01:17:44.628756Z","end":"2026-06-12T01:17:44.761876Z","steps":["trace[286227047] 'process raft request' (duration: 98.860031ms)","trace[286227047] 'compare' (duration: 34.158324ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:17:44.762163Z","caller":"traceutil/trace.go:171","msg":"trace[1742921276] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"133.299879ms","start":"2026-06-12T01:17:44.628849Z","end":"2026-06-12T01:17:44.762149Z","steps":["trace[1742921276] 'process raft request' (duration: 133.005614ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:44.762242Z","caller":"traceutil/trace.go:171","msg":"trace[1123860239] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"132.78683ms","start":"2026-06-12T01:17:44.629429Z","end":"2026-06-12T01:17:44.762216Z","steps":["trace[1123860239] 'process raft request' (duration: 132.738819ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:44.762309Z","caller":"traceutil/trace.go:171","msg":"trace[612945227] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"133.181177ms","start":"2026-06-12T01:17:44.629093Z","end":"2026-06-12T01:17:44.762275Z","steps":["trace[612945227] 'process raft request' (duration: 132.975944ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.370998Z","caller":"traceutil/trace.go:171","msg":"trace[1168336431] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"138.193079ms","start":"2026-06-12T01:17:55.232778Z","end":"2026-06-12T01:17:55.370971Z","steps":["trace[1168336431] 'process raft request' (duration: 138.018216ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.371113Z","caller":"traceutil/trace.go:171","msg":"trace[224003355] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"135.982664ms","start":"2026-06-12T01:17:55.235089Z","end":"2026-06-12T01:17:55.371072Z","steps":["trace[224003355] 'process raft request' (duration: 135.885812ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.37115Z","caller":"traceutil/trace.go:171","msg":"trace[1098335146] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"136.684415ms","start":"2026-06-12T01:17:55.234436Z","end":"2026-06-12T01:17:55.37112Z","steps":["trace[1098335146] 'process raft request' (duration: 136.497402ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.371271Z","caller":"traceutil/trace.go:171","msg":"trace[1965810128] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"136.044474ms","start":"2026-06-12T01:17:55.235184Z","end":"2026-06-12T01:17:55.371228Z","steps":["trace[1965810128] 'process raft request' (duration: 135.815411ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.5711Z","caller":"traceutil/trace.go:171","msg":"trace[1305991582] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"121.706735ms","start":"2026-06-12T01:17:55.449365Z","end":"2026-06-12T01:17:55.571072Z","steps":["trace[1305991582] 'process raft request' (duration: 114.081022ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.571357Z","caller":"traceutil/trace.go:171","msg":"trace[321788379] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"116.674504ms","start":"2026-06-12T01:17:55.454672Z","end":"2026-06-12T01:17:55.571346Z","steps":["trace[321788379] 'process raft request' (duration: 116.630603ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.571545Z","caller":"traceutil/trace.go:171","msg":"trace[1602300468] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"120.861451ms","start":"2026-06-12T01:17:55.450672Z","end":"2026-06-12T01:17:55.571533Z","steps":["trace[1602300468] 'process raft request' (duration: 120.528676ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.571659Z","caller":"traceutil/trace.go:171","msg":"trace[403455923] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"120.921152ms","start":"2026-06-12T01:17:55.45073Z","end":"2026-06-12T01:17:55.571651Z","steps":["trace[403455923] 'process raft request' (duration: 120.511875ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.572131Z","caller":"traceutil/trace.go:171","msg":"trace[1079916994] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"120.714338ms","start":"2026-06-12T01:17:55.451407Z","end":"2026-06-12T01:17:55.572122Z","steps":["trace[1079916994] 'process raft request' (duration: 119.853245ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.571307Z","caller":"traceutil/trace.go:171","msg":"trace[1681870063] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"121.630574ms","start":"2026-06-12T01:17:55.449639Z","end":"2026-06-12T01:17:55.57127Z","steps":["trace[1681870063] 'process raft request' (duration: 121.343059ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.572252Z","caller":"traceutil/trace.go:171","msg":"trace[1071818067] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"120.673878ms","start":"2026-06-12T01:17:55.451569Z","end":"2026-06-12T01:17:55.572243Z","steps":["trace[1071818067] 'process raft request' (duration: 119.710653ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.58307Z","caller":"traceutil/trace.go:171","msg":"trace[1624607254] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1112; }","duration":"118.205908ms","start":"2026-06-12T01:17:55.464854Z","end":"2026-06-12T01:17:55.58306Z","steps":["trace[1624607254] 'read index received' (duration: 98.721125ms)","trace[1624607254] 'applied index is now lower than readState.Index' (duration: 19.484273ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:17:55.583127Z","caller":"traceutil/trace.go:171","msg":"trace[2068035622] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"123.694996ms","start":"2026-06-12T01:17:55.459427Z","end":"2026-06-12T01:17:55.583122Z","steps":["trace[2068035622] 'process raft request' (duration: 123.476282ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:55.583248Z","caller":"traceutil/trace.go:171","msg":"trace[967927835] transaction","detail":"{read_only:false; response_revision:1084; number_of_response:1; }","duration":"108.248259ms","start":"2026-06-12T01:17:55.47499Z","end":"2026-06-12T01:17:55.583238Z","steps":["trace[967927835] 'process raft request' (duration: 107.992295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:17:55.58336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.436792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:17:55.5834Z","caller":"traceutil/trace.go:171","msg":"trace[548259029] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1085; }","duration":"118.563774ms","start":"2026-06-12T01:17:55.464826Z","end":"2026-06-12T01:17:55.58339Z","steps":["trace[548259029] 'agreement among raft nodes before linearized reading' (duration: 118.433842ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:56.22737Z","caller":"traceutil/trace.go:171","msg":"trace[2082131001] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"152.660779ms","start":"2026-06-12T01:17:56.074669Z","end":"2026-06-12T01:17:56.22733Z","steps":["trace[2082131001] 'process raft request' (duration: 152.331363ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:17:56.530109Z","caller":"traceutil/trace.go:171","msg":"trace[1949615126] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"144.858664ms","start":"2026-06-12T01:17:56.38523Z","end":"2026-06-12T01:17:56.530088Z","steps":["trace[1949615126] 'process raft request' (duration: 144.647481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:09.636758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.101499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T01:18:09.636943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.882487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-12T01:18:09.63709Z","caller":"traceutil/trace.go:171","msg":"trace[638687967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1217; }","duration":"648.09131ms","start":"2026-06-12T01:18:08.988957Z","end":"2026-06-12T01:18:09.637048Z","steps":["trace[638687967] 'range keys from in-memory index tree' (duration: 647.595243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:09.637156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:18:08.988944Z","time spent":"648.201132ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-12T01:18:09.637116Z","caller":"traceutil/trace.go:171","msg":"trace[313489180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1217; }","duration":"521.426924ms","start":"2026-06-12T01:18:09.115602Z","end":"2026-06-12T01:18:09.637029Z","steps":["trace[313489180] 'range keys from in-memory index tree' (duration: 521.032668ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:09.637331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:18:09.115591Z","time spent":"521.724709ms","remote":"127.0.0.1:47916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T01:18:09.637692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.937685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-12T01:18:09.637727Z","caller":"traceutil/trace.go:171","msg":"trace[1495407290] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:1217; }","duration":"297.006495ms","start":"2026-06-12T01:18:09.34071Z","end":"2026-06-12T01:18:09.637717Z","steps":["trace[1495407290] 'range keys from in-memory index tree' (duration: 296.769762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:09.638055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.08395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-12T01:18:09.638138Z","caller":"traceutil/trace.go:171","msg":"trace[817250214] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1217; }","duration":"616.213622ms","start":"2026-06-12T01:18:09.021909Z","end":"2026-06-12T01:18:09.638123Z","steps":["trace[817250214] 'range keys from in-memory index tree' (duration: 615.956178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:09.637402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.907267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:18:09.638191Z","caller":"traceutil/trace.go:171","msg":"trace[1527591590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1217; }","duration":"485.72234ms","start":"2026-06-12T01:18:09.152459Z","end":"2026-06-12T01:18:09.638181Z","steps":["trace[1527591590] 'range keys from in-memory index tree' (duration: 484.845197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:09.638176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:18:09.021886Z","time spent":"616.280503ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-12T01:18:09.638249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:18:09.152414Z","time spent":"485.826001ms","remote":"127.0.0.1:47910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-12T01:18:26.06467Z","caller":"traceutil/trace.go:171","msg":"trace[715630136] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"205.676842ms","start":"2026-06-12T01:18:25.858959Z","end":"2026-06-12T01:18:26.064636Z","steps":["trace[715630136] 'process raft request' (duration: 203.675584ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:18:30.488639Z","caller":"traceutil/trace.go:171","msg":"trace[1750984137] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"118.503726ms","start":"2026-06-12T01:18:30.370105Z","end":"2026-06-12T01:18:30.488608Z","steps":["trace[1750984137] 'process raft request' (duration: 39.585073ms)","trace[1750984137] 'compare' (duration: 78.775661ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:18:30.734276Z","caller":"traceutil/trace.go:171","msg":"trace[1328097319] transaction","detail":"{read_only:false; response_revision:1458; number_of_response:1; }","duration":"151.045493ms","start":"2026-06-12T01:18:30.583206Z","end":"2026-06-12T01:18:30.734251Z","steps":["trace[1328097319] 'process raft request' (duration: 132.680011ms)","trace[1328097319] 'compare' (duration: 18.21918ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:18:31.893547Z","caller":"traceutil/trace.go:171","msg":"trace[756438018] transaction","detail":"{read_only:false; response_revision:1474; number_of_response:1; }","duration":"100.456674ms","start":"2026-06-12T01:18:31.793066Z","end":"2026-06-12T01:18:31.893523Z","steps":["trace[756438018] 'process raft request' (duration: 100.268222ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:18:35.095567Z","caller":"traceutil/trace.go:171","msg":"trace[738420252] transaction","detail":"{read_only:false; response_revision:1489; number_of_response:1; }","duration":"126.179513ms","start":"2026-06-12T01:18:34.969371Z","end":"2026-06-12T01:18:35.09555Z","steps":["trace[738420252] 'process raft request' (duration: 126.064992ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:18:59.724074Z","caller":"traceutil/trace.go:171","msg":"trace[1922591904] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1979; }","duration":"508.780508ms","start":"2026-06-12T01:18:59.21525Z","end":"2026-06-12T01:18:59.724031Z","steps":["trace[1922591904] 'read index received' (duration: 106.461µs)","trace[1922591904] 'applied index is now lower than readState.Index' (duration: 508.672387ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:18:59.724366Z","caller":"traceutil/trace.go:171","msg":"trace[1645286765] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"509.152373ms","start":"2026-06-12T01:18:59.215199Z","end":"2026-06-12T01:18:59.724351Z","steps":["trace[1645286765] 'process raft request' (duration: 508.623327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:59.72457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:18:59.215148Z","time spent":"509.297795ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:18:59.724641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.948689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-12T01:18:59.724737Z","caller":"traceutil/trace.go:171","msg":"trace[1964197578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1905; }","duration":"442.070771ms","start":"2026-06-12T01:18:59.28264Z","end":"2026-06-12T01:18:59.724711Z","steps":["trace[1964197578] 'agreement among raft nodes before linearized reading' (duration: 441.833428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:59.724798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:18:59.28263Z","time spent":"442.149462ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T01:18:59.72525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.995593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-12T01:18:59.725351Z","caller":"traceutil/trace.go:171","msg":"trace[110647186] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1905; }","duration":"510.119185ms","start":"2026-06-12T01:18:59.215218Z","end":"2026-06-12T01:18:59.725337Z","steps":["trace[110647186] 'agreement among raft nodes before linearized reading' (duration: 509.69898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:59.725431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:18:59.2152Z","time spent":"510.220047ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T01:18:59.725666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.943573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.4\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-12T01:18:59.725761Z","caller":"traceutil/trace.go:171","msg":"trace[2100514123] range","detail":"{range_begin:/registry/masterleases/199.204.45.4; range_end:; response_count:1; response_revision:1905; }","duration":"373.082265ms","start":"2026-06-12T01:18:59.352657Z","end":"2026-06-12T01:18:59.725739Z","steps":["trace[2100514123] 'agreement among raft nodes before linearized reading' (duration: 372.293125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:18:59.725808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:18:59.352646Z","time spent":"373.153105ms","remote":"127.0.0.1:47938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":154,"request content":"key:\"/registry/masterleases/199.204.45.4\" "} {"level":"info","ts":"2026-06-12T01:18:59.931971Z","caller":"traceutil/trace.go:171","msg":"trace[931270234] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1981; }","duration":"127.37407ms","start":"2026-06-12T01:18:59.804567Z","end":"2026-06-12T01:18:59.931941Z","steps":["trace[931270234] 'read index received' (duration: 37.093076ms)","trace[931270234] 'applied index is now lower than readState.Index' (duration: 90.279824ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:18:59.932112Z","caller":"traceutil/trace.go:171","msg":"trace[269763618] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"202.606374ms","start":"2026-06-12T01:18:59.729475Z","end":"2026-06-12T01:18:59.932081Z","steps":["trace[269763618] 'process raft request' (duration: 112.160668ms)","trace[269763618] 'compare' (duration: 90.028321ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:18:59.932244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.654663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5e5da17e-03a1-49d8-8943-7930d2f79eed\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-06-12T01:18:59.932288Z","caller":"traceutil/trace.go:171","msg":"trace[312871826] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5e5da17e-03a1-49d8-8943-7930d2f79eed; range_end:; response_count:1; response_revision:1908; }","duration":"127.760395ms","start":"2026-06-12T01:18:59.804516Z","end":"2026-06-12T01:18:59.932276Z","steps":["trace[312871826] 'agreement among raft nodes before linearized reading' (duration: 127.537672ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:18:59.932473Z","caller":"traceutil/trace.go:171","msg":"trace[911079038] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"200.612349ms","start":"2026-06-12T01:18:59.731834Z","end":"2026-06-12T01:18:59.932446Z","steps":["trace[911079038] 'process raft request' (duration: 200.006591ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:18:59.932665Z","caller":"traceutil/trace.go:171","msg":"trace[391256786] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"138.320197ms","start":"2026-06-12T01:18:59.794254Z","end":"2026-06-12T01:18:59.932574Z","steps":["trace[391256786] 'process raft request' (duration: 137.639658ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:00.0602Z","caller":"traceutil/trace.go:171","msg":"trace[1992938284] transaction","detail":"{read_only:false; response_revision:1910; number_of_response:1; }","duration":"118.662078ms","start":"2026-06-12T01:18:59.941498Z","end":"2026-06-12T01:19:00.06016Z","steps":["trace[1992938284] 'process raft request' (duration: 98.163311ms)","trace[1992938284] 'compare' (duration: 20.240574ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:19:00.562327Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232311978484734780,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T01:19:00.668349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.490176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:19:00.668672Z","caller":"traceutil/trace.go:171","msg":"trace[1791370825] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"461.205907ms","start":"2026-06-12T01:19:00.207445Z","end":"2026-06-12T01:19:00.668651Z","steps":["trace[1791370825] 'process raft request' (duration: 461.117875ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:00.668971Z","caller":"traceutil/trace.go:171","msg":"trace[2132542228] transaction","detail":"{read_only:false; response_revision:1912; number_of_response:1; }","duration":"602.978481ms","start":"2026-06-12T01:19:00.065975Z","end":"2026-06-12T01:19:00.668953Z","steps":["trace[2132542228] 'process raft request' (duration: 602.500365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:00.669042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:00.207425Z","time spent":"461.573531ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:00.669061Z","caller":"traceutil/trace.go:171","msg":"trace[7075577] linearizableReadLoop","detail":"{readStateIndex:1991; appliedIndex:1986; }","duration":"607.62923ms","start":"2026-06-12T01:19:00.061397Z","end":"2026-06-12T01:19:00.669026Z","steps":["trace[7075577] 'read index received' (duration: 503.211333ms)","trace[7075577] 'applied index is now lower than readState.Index' (duration: 104.416477ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:19:00.668682Z","caller":"traceutil/trace.go:171","msg":"trace[695588962] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"613.076368ms","start":"2026-06-12T01:19:00.055552Z","end":"2026-06-12T01:19:00.668629Z","steps":["trace[695588962] 'process raft request' (duration: 509.046166ms)","trace[695588962] 'compare' (duration: 103.098491ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:19:00.669167Z","caller":"traceutil/trace.go:171","msg":"trace[1084888424] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"253.233062ms","start":"2026-06-12T01:19:00.415917Z","end":"2026-06-12T01:19:00.66915Z","steps":["trace[1084888424] 'process raft request' (duration: 252.986329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:00.669169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:00.065951Z","time spent":"603.087023ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:00.669149Z","caller":"traceutil/trace.go:171","msg":"trace[1786627866] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"283.672103ms","start":"2026-06-12T01:19:00.385407Z","end":"2026-06-12T01:19:00.669079Z","steps":["trace[1786627866] 'process raft request' (duration: 283.197287ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:00.669293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:00.055518Z","time spent":"613.690226ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:19:00.669418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.989815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-12T01:19:00.669484Z","caller":"traceutil/trace.go:171","msg":"trace[1724289180] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1915; }","duration":"608.082636ms","start":"2026-06-12T01:19:00.061375Z","end":"2026-06-12T01:19:00.669458Z","steps":["trace[1724289180] 'agreement among raft nodes before linearized reading' (duration: 607.848723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:00.669516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.819823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T01:19:00.669523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.09008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5e5da17e-03a1-49d8-8943-7930d2f79eed\" ","response":"range_response_count:1 size:3745"} {"level":"warn","ts":"2026-06-12T01:19:00.669538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:00.061357Z","time spent":"608.168176ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-12T01:19:00.669601Z","caller":"traceutil/trace.go:171","msg":"trace[931062072] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5e5da17e-03a1-49d8-8943-7930d2f79eed; range_end:; response_count:1; response_revision:1915; }","duration":"558.185381ms","start":"2026-06-12T01:19:00.111372Z","end":"2026-06-12T01:19:00.669557Z","steps":["trace[931062072] 'agreement among raft nodes before linearized reading' (duration: 557.951478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:00.669641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:00.111358Z","time spent":"558.273272ms","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3768,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5e5da17e-03a1-49d8-8943-7930d2f79eed\" "} {"level":"info","ts":"2026-06-12T01:19:00.669674Z","caller":"traceutil/trace.go:171","msg":"trace[147987545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1915; }","duration":"516.885564ms","start":"2026-06-12T01:19:00.152664Z","end":"2026-06-12T01:19:00.669549Z","steps":["trace[147987545] 'agreement among raft nodes before linearized reading' (duration: 516.815863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:00.669723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:00.152648Z","time spent":"517.064986ms","remote":"127.0.0.1:47916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T01:19:00.669815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.569081ms","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-12T01:19:00.669858Z","caller":"traceutil/trace.go:171","msg":"trace[639020415] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1915; }","duration":"556.662312ms","start":"2026-06-12T01:19:00.113182Z","end":"2026-06-12T01:19:00.669844Z","steps":["trace[639020415] 'agreement among raft nodes before linearized reading' (duration: 556.537431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:00.669893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:00.113144Z","time spent":"556.741853ms","remote":"127.0.0.1:59496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-12T01:19:08.186688Z","caller":"traceutil/trace.go:171","msg":"trace[1420570986] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"164.327549ms","start":"2026-06-12T01:19:08.022332Z","end":"2026-06-12T01:19:08.18666Z","steps":["trace[1420570986] 'process raft request' (duration: 164.285159ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:08.186717Z","caller":"traceutil/trace.go:171","msg":"trace[1570585765] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"164.391891ms","start":"2026-06-12T01:19:08.022305Z","end":"2026-06-12T01:19:08.186697Z","steps":["trace[1570585765] 'process raft request' (duration: 103.27935ms)","trace[1570585765] 'compare' (duration: 60.927118ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:19:18.274838Z","caller":"traceutil/trace.go:171","msg":"trace[1783087331] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"427.245395ms","start":"2026-06-12T01:19:17.847565Z","end":"2026-06-12T01:19:18.27481Z","steps":["trace[1783087331] 'process raft request' (duration: 427.093024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:18.274987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:17.847547Z","time spent":"427.363487ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:19:18.42918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.386618ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:19:18.429321Z","caller":"traceutil/trace.go:171","msg":"trace[1087245882] linearizableReadLoop","detail":"{readStateIndex:2131; appliedIndex:2129; }","duration":"342.684704ms","start":"2026-06-12T01:19:18.086618Z","end":"2026-06-12T01:19:18.429302Z","steps":["trace[1087245882] 'read index received' (duration: 188.040813ms)","trace[1087245882] 'applied index is now lower than readState.Index' (duration: 154.642351ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:19:18.429433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.988351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:19:18.429459Z","caller":"traceutil/trace.go:171","msg":"trace[1966142462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2051; }","duration":"276.051362ms","start":"2026-06-12T01:19:18.153398Z","end":"2026-06-12T01:19:18.42945Z","steps":["trace[1966142462] 'agreement among raft nodes before linearized reading' (duration: 275.996322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:18.429482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.845216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T01:19:18.429514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.883092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:19:18.429587Z","caller":"traceutil/trace.go:171","msg":"trace[611404841] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2051; }","duration":"343.028379ms","start":"2026-06-12T01:19:18.086526Z","end":"2026-06-12T01:19:18.429554Z","steps":["trace[611404841] 'agreement among raft nodes before linearized reading' (duration: 342.862407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:18.429601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.115261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-12T01:19:18.429634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:18.08651Z","time spent":"343.113049ms","remote":"127.0.0.1:35826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-12T01:19:18.429657Z","caller":"traceutil/trace.go:171","msg":"trace[1944078172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2051; }","duration":"196.250542ms","start":"2026-06-12T01:19:18.233395Z","end":"2026-06-12T01:19:18.429646Z","steps":["trace[1944078172] 'agreement among raft nodes before linearized reading' (duration: 196.052589ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:18.429608Z","caller":"traceutil/trace.go:171","msg":"trace[844609967] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2051; }","duration":"159.036664ms","start":"2026-06-12T01:19:18.270552Z","end":"2026-06-12T01:19:18.429588Z","steps":["trace[844609967] 'agreement among raft nodes before linearized reading' (duration: 158.867342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:18.429931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.586042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-12T01:19:18.429936Z","caller":"traceutil/trace.go:171","msg":"trace[486821901] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"372.948058ms","start":"2026-06-12T01:19:18.05641Z","end":"2026-06-12T01:19:18.429358Z","steps":["trace[486821901] 'process raft request' (duration: 256.908832ms)","trace[486821901] 'compare' (duration: 115.261577ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:19:18.429969Z","caller":"traceutil/trace.go:171","msg":"trace[1787533782] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2051; }","duration":"204.681512ms","start":"2026-06-12T01:19:18.225277Z","end":"2026-06-12T01:19:18.429959Z","steps":["trace[1787533782] 'agreement among raft nodes before linearized reading' (duration: 204.47858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:18.430019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:18.056385Z","time spent":"373.581646ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:40.659604Z","caller":"traceutil/trace.go:171","msg":"trace[1497469753] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"112.278512ms","start":"2026-06-12T01:19:40.547297Z","end":"2026-06-12T01:19:40.659576Z","steps":["trace[1497469753] 'process raft request' (duration: 86.518153ms)","trace[1497469753] 'compare' (duration: 25.604857ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:19:40.680185Z","caller":"traceutil/trace.go:171","msg":"trace[1388548215] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"132.791061ms","start":"2026-06-12T01:19:40.547357Z","end":"2026-06-12T01:19:40.680148Z","steps":["trace[1388548215] 'process raft request' (duration: 132.596598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:41.132457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.795066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:19:41.13282Z","caller":"traceutil/trace.go:171","msg":"trace[277902602] linearizableReadLoop","detail":"{readStateIndex:2269; appliedIndex:2266; }","duration":"186.962497ms","start":"2026-06-12T01:19:40.94584Z","end":"2026-06-12T01:19:41.132802Z","steps":["trace[277902602] 'read index received' (duration: 54.745935ms)","trace[277902602] 'applied index is now lower than readState.Index' (duration: 132.215571ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:19:41.132962Z","caller":"traceutil/trace.go:171","msg":"trace[1038820898] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"269.946469ms","start":"2026-06-12T01:19:40.863001Z","end":"2026-06-12T01:19:41.132947Z","steps":["trace[1038820898] 'process raft request' (duration: 137.572576ms)","trace[1038820898] 'compare' (duration: 131.662835ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:19:41.133234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.386591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-12T01:19:41.133434Z","caller":"traceutil/trace.go:171","msg":"trace[1803128370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2184; }","duration":"187.471522ms","start":"2026-06-12T01:19:40.945822Z","end":"2026-06-12T01:19:41.133294Z","steps":["trace[1803128370] 'agreement among raft nodes before linearized reading' (duration: 187.26381ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:41.133412Z","caller":"traceutil/trace.go:171","msg":"trace[949082278] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"242.906495ms","start":"2026-06-12T01:19:40.890459Z","end":"2026-06-12T01:19:41.133365Z","steps":["trace[949082278] 'process raft request' (duration: 242.114286ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:41.133619Z","caller":"traceutil/trace.go:171","msg":"trace[1576308300] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"241.944135ms","start":"2026-06-12T01:19:40.891651Z","end":"2026-06-12T01:19:41.133595Z","steps":["trace[1576308300] 'process raft request' (duration: 240.968423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:41.133799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.713937ms","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-12T01:19:41.133879Z","caller":"traceutil/trace.go:171","msg":"trace[838325796] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2184; }","duration":"144.810548ms","start":"2026-06-12T01:19:40.98905Z","end":"2026-06-12T01:19:41.133861Z","steps":["trace[838325796] 'agreement among raft nodes before linearized reading' (duration: 144.609896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:41.133873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.591269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-12T01:19:41.134046Z","caller":"traceutil/trace.go:171","msg":"trace[2048915722] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2184; }","duration":"184.823372ms","start":"2026-06-12T01:19:40.949209Z","end":"2026-06-12T01:19:41.134033Z","steps":["trace[2048915722] 'agreement among raft nodes before linearized reading' (duration: 184.453708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:42.744246Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232311978484735396,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T01:19:43.244593Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232311978484735396,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T01:19:43.305954Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.085761342s","expected-duration":"1s"} {"level":"info","ts":"2026-06-12T01:19:43.306583Z","caller":"traceutil/trace.go:171","msg":"trace[719102093] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"1.086512401s","start":"2026-06-12T01:19:42.22004Z","end":"2026-06-12T01:19:43.306552Z","steps":["trace[719102093] 'process raft request' (duration: 1.086335758s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.306773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.220011Z","time spent":"1.086655053s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:19:43.626276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.704592ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:19:43.62665Z","caller":"traceutil/trace.go:171","msg":"trace[247136723] linearizableReadLoop","detail":"{readStateIndex:2276; appliedIndex:2271; }","duration":"1.382450548s","start":"2026-06-12T01:19:42.244178Z","end":"2026-06-12T01:19:43.626628Z","steps":["trace[247136723] 'read index received' (duration: 1.062180589s)","trace[247136723] 'applied index is now lower than readState.Index' (duration: 320.268529ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:19:43.626703Z","caller":"traceutil/trace.go:171","msg":"trace[1022661279] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"1.079218131s","start":"2026-06-12T01:19:42.547461Z","end":"2026-06-12T01:19:43.626679Z","steps":["trace[1022661279] 'process raft request' (duration: 837.009634ms)","trace[1022661279] 'compare' (duration: 241.387007ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:19:43.62677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.547449Z","time spent":"1.079275951s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:43.626797Z","caller":"traceutil/trace.go:171","msg":"trace[1328612997] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"486.761322ms","start":"2026-06-12T01:19:43.140009Z","end":"2026-06-12T01:19:43.626771Z","steps":["trace[1328612997] 'process raft request' (duration: 486.401598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.626884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.139989Z","time spent":"486.849423ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:43.627028Z","caller":"traceutil/trace.go:171","msg":"trace[1664650154] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"486.374197ms","start":"2026-06-12T01:19:43.140637Z","end":"2026-06-12T01:19:43.627011Z","steps":["trace[1664650154] 'process raft request' (duration: 485.848031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.627119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.140623Z","time spent":"486.450008ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:43.627237Z","caller":"traceutil/trace.go:171","msg":"trace[2142128645] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"486.269756ms","start":"2026-06-12T01:19:43.140951Z","end":"2026-06-12T01:19:43.627221Z","steps":["trace[2142128645] 'process raft request' (duration: 485.582688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.627321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.14094Z","time spent":"486.337357ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:19:43.627559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.383371969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b830ac04b03613\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-12T01:19:43.627623Z","caller":"traceutil/trace.go:171","msg":"trace[1878618891] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b830ac04b03613; range_end:; response_count:1; response_revision:2191; }","duration":"1.38345502s","start":"2026-06-12T01:19:42.244146Z","end":"2026-06-12T01:19:43.627601Z","steps":["trace[1878618891] 'agreement among raft nodes before linearized reading' (duration: 1.383276058s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.627607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.308039458s","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":"warn","ts":"2026-06-12T01:19:43.62768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.244134Z","time spent":"1.383533541s","remote":"127.0.0.1:47976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b830ac04b03613\" "} {"level":"info","ts":"2026-06-12T01:19:43.627731Z","caller":"traceutil/trace.go:171","msg":"trace[1277226151] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2191; }","duration":"1.308211179s","start":"2026-06-12T01:19:42.319491Z","end":"2026-06-12T01:19:43.627702Z","steps":["trace[1277226151] 'agreement among raft nodes before linearized reading' (duration: 1.308000327s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.627754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.08276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-12T01:19:43.627851Z","caller":"traceutil/trace.go:171","msg":"trace[1998792016] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2191; }","duration":"496.237591ms","start":"2026-06-12T01:19:43.131594Z","end":"2026-06-12T01:19:43.627832Z","steps":["trace[1998792016] 'agreement among raft nodes before linearized reading' (duration: 495.895757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.627901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.131575Z","time spent":"496.316252ms","remote":"127.0.0.1:48378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":274,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-06-12T01:19:43.628002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.124169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-12T01:19:43.628073Z","caller":"traceutil/trace.go:171","msg":"trace[91862694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2191; }","duration":"944.223419ms","start":"2026-06-12T01:19:42.683834Z","end":"2026-06-12T01:19:43.628057Z","steps":["trace[91862694] 'agreement among raft nodes before linearized reading' (duration: 943.988067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.628121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.683821Z","time spent":"944.289311ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T01:19:43.628302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.353636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-12T01:19:43.628332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.1629852s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:19:43.628398Z","caller":"traceutil/trace.go:171","msg":"trace[1477595964] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2191; }","duration":"1.163056271s","start":"2026-06-12T01:19:42.465327Z","end":"2026-06-12T01:19:43.628383Z","steps":["trace[1477595964] 'agreement among raft nodes before linearized reading' (duration: 1.16295283s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.628456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.465261Z","time spent":"1.163179322s","remote":"127.0.0.1:48288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-06-12T01:19:43.628348Z","caller":"traceutil/trace.go:171","msg":"trace[1692428298] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2191; }","duration":"460.419328ms","start":"2026-06-12T01:19:43.167918Z","end":"2026-06-12T01:19:43.628337Z","steps":["trace[1692428298] 'agreement among raft nodes before linearized reading' (duration: 460.189155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.628576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.167905Z","time spent":"460.66125ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-12T01:19:43.627793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.319479Z","time spent":"1.30829914s","remote":"127.0.0.1:48322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":2,"response size":30,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-12T01:19:43.628607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.089972335s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12384"} {"level":"warn","ts":"2026-06-12T01:19:43.628971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.234392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:19:43.629004Z","caller":"traceutil/trace.go:171","msg":"trace[611871824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2191; }","duration":"477.286982ms","start":"2026-06-12T01:19:43.151709Z","end":"2026-06-12T01:19:43.628996Z","steps":["trace[611871824] 'agreement among raft nodes before linearized reading' (duration: 477.232682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.629023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.1517Z","time spent":"477.319672ms","remote":"127.0.0.1:47910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T01:19:43.62905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.481706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-12T01:19:43.629118Z","caller":"traceutil/trace.go:171","msg":"trace[1340901396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2191; }","duration":"965.583596ms","start":"2026-06-12T01:19:42.66352Z","end":"2026-06-12T01:19:43.629104Z","steps":["trace[1340901396] 'agreement among raft nodes before linearized reading' (duration: 965.00507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.629168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.663507Z","time spent":"965.649167ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T01:19:43.629487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.559241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-12T01:19:43.629545Z","caller":"traceutil/trace.go:171","msg":"trace[1232777384] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2191; }","duration":"474.639491ms","start":"2026-06-12T01:19:43.154891Z","end":"2026-06-12T01:19:43.62953Z","steps":["trace[1232777384] 'agreement among raft nodes before linearized reading' (duration: 474.042044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.629624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.154881Z","time spent":"474.726522ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-12T01:19:43.629735Z","caller":"traceutil/trace.go:171","msg":"trace[1807729237] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2191; }","duration":"1.090189348s","start":"2026-06-12T01:19:42.538506Z","end":"2026-06-12T01:19:43.628695Z","steps":["trace[1807729237] 'agreement among raft nodes before linearized reading' (duration: 1.089580021s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.629819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.538486Z","time spent":"1.09131278s","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12407,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-12T01:19:43.629887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131769199s","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-12T01:19:43.629946Z","caller":"traceutil/trace.go:171","msg":"trace[1180376031] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2191; }","duration":"1.13185501s","start":"2026-06-12T01:19:42.498077Z","end":"2026-06-12T01:19:43.629932Z","steps":["trace[1180376031] 'agreement among raft nodes before linearized reading' (duration: 1.130165041s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.629999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:42.498063Z","time spent":"1.131924311s","remote":"127.0.0.1:48136","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-12T01:19:43.631558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.413323ms","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-12T01:19:43.631619Z","caller":"traceutil/trace.go:171","msg":"trace[1769817189] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2191; }","duration":"483.500804ms","start":"2026-06-12T01:19:43.148102Z","end":"2026-06-12T01:19:43.631603Z","steps":["trace[1769817189] 'agreement among raft nodes before linearized reading' (duration: 480.213906ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:43.631722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.148092Z","time spent":"483.618816ms","remote":"127.0.0.1:59496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-12T01:19:44.1441Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232311978484735403,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T01:19:44.218463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.525383ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:19:44.218583Z","caller":"traceutil/trace.go:171","msg":"trace[1448840324] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2191; }","duration":"439.657934ms","start":"2026-06-12T01:19:43.778907Z","end":"2026-06-12T01:19:44.218565Z","steps":["trace[1448840324] 'range keys from in-memory index tree' (duration: 439.507932ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:44.291425Z","caller":"traceutil/trace.go:171","msg":"trace[1333399049] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"658.047696ms","start":"2026-06-12T01:19:43.633342Z","end":"2026-06-12T01:19:44.29139Z","steps":["trace[1333399049] 'process raft request' (duration: 657.766463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:44.291675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.63332Z","time spent":"658.219658ms","remote":"127.0.0.1:47976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:44.296137Z","caller":"traceutil/trace.go:171","msg":"trace[1591343514] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"661.789048ms","start":"2026-06-12T01:19:43.634309Z","end":"2026-06-12T01:19:44.296098Z","steps":["trace[1591343514] 'process raft request' (duration: 661.528845ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:44.296267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.647363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:19:44.296324Z","caller":"traceutil/trace.go:171","msg":"trace[851538250] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2197; }","duration":"652.757825ms","start":"2026-06-12T01:19:43.643554Z","end":"2026-06-12T01:19:44.296312Z","steps":["trace[851538250] 'agreement among raft nodes before linearized reading' (duration: 652.653004ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:44.296333Z","caller":"traceutil/trace.go:171","msg":"trace[1183711629] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"661.86745ms","start":"2026-06-12T01:19:43.634445Z","end":"2026-06-12T01:19:44.296313Z","steps":["trace[1183711629] 'process raft request' (duration: 661.533526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:44.296367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.634297Z","time spent":"661.927581ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:44.296422Z","caller":"traceutil/trace.go:171","msg":"trace[2103063635] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"659.065807ms","start":"2026-06-12T01:19:43.637344Z","end":"2026-06-12T01:19:44.296409Z","steps":["trace[2103063635] 'process raft request' (duration: 658.747973ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:19:44.296346Z","caller":"traceutil/trace.go:171","msg":"trace[1598298643] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"661.06116ms","start":"2026-06-12T01:19:43.635262Z","end":"2026-06-12T01:19:44.296323Z","steps":["trace[1598298643] 'process raft request' (duration: 660.799207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:44.296492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.634413Z","time spent":"662.009401ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:19:44.296513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.637332Z","time spent":"659.121177ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:19:44.296553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.635254Z","time spent":"661.213623ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:19:44.296152Z","caller":"traceutil/trace.go:171","msg":"trace[568742702] linearizableReadLoop","detail":"{readStateIndex:2282; appliedIndex:2276; }","duration":"652.528572ms","start":"2026-06-12T01:19:43.643599Z","end":"2026-06-12T01:19:44.296128Z","steps":["trace[568742702] 'read index received' (duration: 647.459953ms)","trace[568742702] 'applied index is now lower than readState.Index' (duration: 5.067149ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:19:44.296262Z","caller":"traceutil/trace.go:171","msg":"trace[2051091414] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"661.03672ms","start":"2026-06-12T01:19:43.635198Z","end":"2026-06-12T01:19:44.296234Z","steps":["trace[2051091414] 'process raft request' (duration: 660.820967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:44.296738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.635186Z","time spent":"661.523195ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:19:44.296367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:19:43.64354Z","time spent":"652.818555ms","remote":"127.0.0.1:48316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-12T01:19:44.296878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.649827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:19:44.296992Z","caller":"traceutil/trace.go:171","msg":"trace[582169417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2197; }","duration":"143.826488ms","start":"2026-06-12T01:19:44.153141Z","end":"2026-06-12T01:19:44.296968Z","steps":["trace[582169417] 'agreement among raft nodes before linearized reading' (duration: 143.653116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:19:44.297023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.046291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:19:44.297093Z","caller":"traceutil/trace.go:171","msg":"trace[634415482] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2197; }","duration":"131.138882ms","start":"2026-06-12T01:19:44.165937Z","end":"2026-06-12T01:19:44.297076Z","steps":["trace[634415482] 'agreement among raft nodes before linearized reading' (duration: 130.94851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:20:39.280358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.444534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:20:39.280443Z","caller":"traceutil/trace.go:171","msg":"trace[1716803411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2536; }","duration":"127.580188ms","start":"2026-06-12T01:20:39.152845Z","end":"2026-06-12T01:20:39.280425Z","steps":["trace[1716803411] 'range keys from in-memory index tree' (duration: 127.375531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:20:39.280683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.678165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:20:39.280761Z","caller":"traceutil/trace.go:171","msg":"trace[11021782] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2536; }","duration":"164.80867ms","start":"2026-06-12T01:20:39.115935Z","end":"2026-06-12T01:20:39.280744Z","steps":["trace[11021782] 'range keys from in-memory index tree' (duration: 164.601123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:21:21.376227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.033985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:21:21.376361Z","caller":"traceutil/trace.go:171","msg":"trace[1324520034] transaction","detail":"{read_only:false; response_revision:2823; number_of_response:1; }","duration":"511.8856ms","start":"2026-06-12T01:21:20.864423Z","end":"2026-06-12T01:21:21.376309Z","steps":["trace[1324520034] 'process raft request' (duration: 294.68267ms)","trace[1324520034] 'compare' (duration: 216.779528ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:21:21.376417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:21:20.864401Z","time spent":"511.992913ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:21:21.379863Z","caller":"traceutil/trace.go:171","msg":"trace[1221391139] linearizableReadLoop","detail":"{readStateIndex:2933; appliedIndex:2931; }","duration":"138.726146ms","start":"2026-06-12T01:21:21.241111Z","end":"2026-06-12T01:21:21.379838Z","steps":["trace[1221391139] 'read index received' (duration: 138.52657ms)","trace[1221391139] 'applied index is now lower than readState.Index' (duration: 198.486µs)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:21:21.379952Z","caller":"traceutil/trace.go:171","msg":"trace[557303591] transaction","detail":"{read_only:false; response_revision:2824; number_of_response:1; }","duration":"510.019699ms","start":"2026-06-12T01:21:20.869875Z","end":"2026-06-12T01:21:21.379894Z","steps":["trace[557303591] 'process raft request' (duration: 509.783313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:21:21.380124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.967202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:21:21.380156Z","caller":"traceutil/trace.go:171","msg":"trace[1840651170] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2825; }","duration":"139.118756ms","start":"2026-06-12T01:21:21.241028Z","end":"2026-06-12T01:21:21.380147Z","steps":["trace[1840651170] 'agreement among raft nodes before linearized reading' (duration: 138.994113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:21:21.380142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:21:20.869866Z","time spent":"510.180543ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:21:21.380001Z","caller":"traceutil/trace.go:171","msg":"trace[1077659701] transaction","detail":"{read_only:false; response_revision:2825; number_of_response:1; }","duration":"509.929457ms","start":"2026-06-12T01:21:20.870058Z","end":"2026-06-12T01:21:21.379987Z","steps":["trace[1077659701] 'process raft request' (duration: 509.737841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:21:21.380401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:21:20.870038Z","time spent":"510.302757ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:21:21.380697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.929614ms","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-06-12T01:21:21.380919Z","caller":"traceutil/trace.go:171","msg":"trace[213279552] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:2825; }","duration":"135.194471ms","start":"2026-06-12T01:21:21.245693Z","end":"2026-06-12T01:21:21.380888Z","steps":["trace[213279552] 'agreement among raft nodes before linearized reading' (duration: 134.681767ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:21:26.744167Z","caller":"traceutil/trace.go:171","msg":"trace[7218420] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"180.850755ms","start":"2026-06-12T01:21:26.56329Z","end":"2026-06-12T01:21:26.744141Z","steps":["trace[7218420] 'process raft request' (duration: 180.687301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:23:04.385986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.033858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-12T01:23:04.386003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.106869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/auth-system/\" range_end:\"/registry/secrets/auth-system0\" ","response":"range_response_count:3 size:76684"} {"level":"info","ts":"2026-06-12T01:23:04.386082Z","caller":"traceutil/trace.go:171","msg":"trace[1979714470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3370; }","duration":"233.178041ms","start":"2026-06-12T01:23:04.15288Z","end":"2026-06-12T01:23:04.386058Z","steps":["trace[1979714470] 'range keys from in-memory index tree' (duration: 232.929756ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:04.386087Z","caller":"traceutil/trace.go:171","msg":"trace[1361487456] range","detail":"{range_begin:/registry/secrets/auth-system/; range_end:/registry/secrets/auth-system0; response_count:3; response_revision:3370; }","duration":"217.232102ms","start":"2026-06-12T01:23:04.168832Z","end":"2026-06-12T01:23:04.386065Z","steps":["trace[1361487456] 'range keys from in-memory index tree' (duration: 216.893085ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:08.108139Z","caller":"traceutil/trace.go:171","msg":"trace[1529775720] linearizableReadLoop","detail":"{readStateIndex:3586; appliedIndex:3582; }","duration":"110.828403ms","start":"2026-06-12T01:23:07.997287Z","end":"2026-06-12T01:23:08.108115Z","steps":["trace[1529775720] 'read index received' (duration: 75.71264ms)","trace[1529775720] 'applied index is now lower than readState.Index' (duration: 35.114743ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:23:08.108421Z","caller":"traceutil/trace.go:171","msg":"trace[1171046176] transaction","detail":"{read_only:false; response_revision:3452; number_of_response:1; }","duration":"114.436652ms","start":"2026-06-12T01:23:07.993971Z","end":"2026-06-12T01:23:08.108408Z","steps":["trace[1171046176] 'process raft request' (duration: 114.063965ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:08.108551Z","caller":"traceutil/trace.go:171","msg":"trace[708346655] transaction","detail":"{read_only:false; response_revision:3453; number_of_response:1; }","duration":"114.085835ms","start":"2026-06-12T01:23:07.994431Z","end":"2026-06-12T01:23:08.108517Z","steps":["trace[708346655] 'process raft request' (duration: 113.639966ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:08.108706Z","caller":"traceutil/trace.go:171","msg":"trace[1810049934] transaction","detail":"{read_only:false; response_revision:3450; number_of_response:1; }","duration":"116.625064ms","start":"2026-06-12T01:23:07.992052Z","end":"2026-06-12T01:23:08.108677Z","steps":["trace[1810049934] 'process raft request' (duration: 80.966831ms)","trace[1810049934] 'compare' (duration: 34.817357ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:23:08.108702Z","caller":"traceutil/trace.go:171","msg":"trace[546479787] transaction","detail":"{read_only:false; response_revision:3451; number_of_response:1; }","duration":"115.708186ms","start":"2026-06-12T01:23:07.992925Z","end":"2026-06-12T01:23:08.108633Z","steps":["trace[546479787] 'process raft request' (duration: 115.033903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:23:08.108759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.439895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T01:23:08.109031Z","caller":"traceutil/trace.go:171","msg":"trace[391703312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3453; }","duration":"111.746711ms","start":"2026-06-12T01:23:07.997272Z","end":"2026-06-12T01:23:08.109019Z","steps":["trace[391703312] 'agreement among raft nodes before linearized reading' (duration: 111.265881ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:23:08.109126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.524978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/secretgen-controller/secretgen-controller-5cf976ccc7-5tqkp\" ","response":"range_response_count:1 size:2097"} {"level":"info","ts":"2026-06-12T01:23:08.109194Z","caller":"traceutil/trace.go:171","msg":"trace[1324002177] range","detail":"{range_begin:/registry/pods/secretgen-controller/secretgen-controller-5cf976ccc7-5tqkp; range_end:; response_count:1; response_revision:3454; }","duration":"108.623001ms","start":"2026-06-12T01:23:08.000553Z","end":"2026-06-12T01:23:08.109176Z","steps":["trace[1324002177] 'agreement among raft nodes before linearized reading' (duration: 108.458657ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:08.109149Z","caller":"traceutil/trace.go:171","msg":"trace[1454028598] transaction","detail":"{read_only:false; response_revision:3454; number_of_response:1; }","duration":"109.210182ms","start":"2026-06-12T01:23:07.999925Z","end":"2026-06-12T01:23:08.109135Z","steps":["trace[1454028598] 'process raft request' (duration: 108.972637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:23:08.109356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.615383ms","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-12T01:23:08.109399Z","caller":"traceutil/trace.go:171","msg":"trace[275070875] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3454; }","duration":"105.685215ms","start":"2026-06-12T01:23:08.003705Z","end":"2026-06-12T01:23:08.10939Z","steps":["trace[275070875] 'agreement among raft nodes before linearized reading' (duration: 105.533012ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:16.66911Z","caller":"traceutil/trace.go:171","msg":"trace[718178194] transaction","detail":"{read_only:false; response_revision:3511; number_of_response:1; }","duration":"110.823723ms","start":"2026-06-12T01:23:16.558259Z","end":"2026-06-12T01:23:16.669082Z","steps":["trace[718178194] 'process raft request' (duration: 110.199011ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:16.669119Z","caller":"traceutil/trace.go:171","msg":"trace[1617264729] transaction","detail":"{read_only:false; response_revision:3512; number_of_response:1; }","duration":"104.25732ms","start":"2026-06-12T01:23:16.564837Z","end":"2026-06-12T01:23:16.669094Z","steps":["trace[1617264729] 'process raft request' (duration: 104.126577ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:16.669163Z","caller":"traceutil/trace.go:171","msg":"trace[1042038907] transaction","detail":"{read_only:false; response_revision:3513; number_of_response:1; }","duration":"104.28989ms","start":"2026-06-12T01:23:16.564855Z","end":"2026-06-12T01:23:16.669145Z","steps":["trace[1042038907] 'process raft request' (duration: 104.200838ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:28.947938Z","caller":"traceutil/trace.go:171","msg":"trace[773954673] transaction","detail":"{read_only:false; response_revision:3584; number_of_response:1; }","duration":"110.849028ms","start":"2026-06-12T01:23:28.837068Z","end":"2026-06-12T01:23:28.947917Z","steps":["trace[773954673] 'process raft request' (duration: 110.707636ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:29.760166Z","caller":"traceutil/trace.go:171","msg":"trace[39440495] transaction","detail":"{read_only:false; response_revision:3587; number_of_response:1; }","duration":"126.360057ms","start":"2026-06-12T01:23:29.633777Z","end":"2026-06-12T01:23:29.760137Z","steps":["trace[39440495] 'process raft request' (duration: 30.050328ms)","trace[39440495] 'compare' (duration: 96.044914ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:23:34.755926Z","caller":"traceutil/trace.go:171","msg":"trace[646534067] transaction","detail":"{read_only:false; response_revision:3616; number_of_response:1; }","duration":"106.650396ms","start":"2026-06-12T01:23:34.649251Z","end":"2026-06-12T01:23:34.755901Z","steps":["trace[646534067] 'process raft request' (duration: 106.490803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:23:40.420156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.846892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T01:23:40.420308Z","caller":"traceutil/trace.go:171","msg":"trace[1524133832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3646; }","duration":"141.032716ms","start":"2026-06-12T01:23:40.279258Z","end":"2026-06-12T01:23:40.420291Z","steps":["trace[1524133832] 'range keys from in-memory index tree' (duration: 140.72497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:23:40.420187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.128079ms","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-12T01:23:40.42043Z","caller":"traceutil/trace.go:171","msg":"trace[338036020] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3646; }","duration":"140.528276ms","start":"2026-06-12T01:23:40.27985Z","end":"2026-06-12T01:23:40.420378Z","steps":["trace[338036020] 'range keys from in-memory index tree' (duration: 139.993057ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:23:40.548768Z","caller":"traceutil/trace.go:171","msg":"trace[2015692046] transaction","detail":"{read_only:false; response_revision:3648; number_of_response:1; }","duration":"123.703607ms","start":"2026-06-12T01:23:40.425041Z","end":"2026-06-12T01:23:40.548745Z","steps":["trace[2015692046] 'process raft request' (duration: 109.395081ms)","trace[2015692046] 'compare' (duration: 14.058011ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:23:42.976976Z","caller":"traceutil/trace.go:171","msg":"trace[1746598692] transaction","detail":"{read_only:false; response_revision:3659; number_of_response:1; }","duration":"136.017217ms","start":"2026-06-12T01:23:42.840923Z","end":"2026-06-12T01:23:42.97694Z","steps":["trace[1746598692] 'process raft request' (duration: 92.595706ms)","trace[1746598692] 'compare' (duration: 43.320549ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:23:47.173165Z","caller":"traceutil/trace.go:171","msg":"trace[243744640] transaction","detail":"{read_only:false; response_revision:3682; number_of_response:1; }","duration":"103.011143ms","start":"2026-06-12T01:23:47.070082Z","end":"2026-06-12T01:23:47.173093Z","steps":["trace[243744640] 'process raft request' (duration: 81.610596ms)","trace[243744640] 'compare' (duration: 21.200033ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:23:50.754983Z","caller":"traceutil/trace.go:171","msg":"trace[295728355] transaction","detail":"{read_only:false; response_revision:3702; number_of_response:1; }","duration":"120.901235ms","start":"2026-06-12T01:23:50.634041Z","end":"2026-06-12T01:23:50.754942Z","steps":["trace[295728355] 'process raft request' (duration: 30.792969ms)","trace[295728355] 'compare' (duration: 89.966474ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:24:10.108042Z","caller":"traceutil/trace.go:171","msg":"trace[887396029] transaction","detail":"{read_only:false; response_revision:3808; number_of_response:1; }","duration":"138.253034ms","start":"2026-06-12T01:24:09.969752Z","end":"2026-06-12T01:24:10.108005Z","steps":["trace[887396029] 'process raft request' (duration: 99.584102ms)","trace[887396029] 'compare' (duration: 38.52221ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:24:22.87655Z","caller":"traceutil/trace.go:171","msg":"trace[1481291539] transaction","detail":"{read_only:false; response_revision:3939; number_of_response:1; }","duration":"102.70459ms","start":"2026-06-12T01:24:22.773821Z","end":"2026-06-12T01:24:22.876526Z","steps":["trace[1481291539] 'process raft request' (duration: 102.552967ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:24:23.116385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.152174ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:24:23.11695Z","caller":"traceutil/trace.go:171","msg":"trace[743228450] transaction","detail":"{read_only:false; response_revision:3940; number_of_response:1; }","duration":"193.598401ms","start":"2026-06-12T01:24:22.923012Z","end":"2026-06-12T01:24:23.11661Z","steps":["trace[743228450] 'process raft request' (duration: 84.148742ms)","trace[743228450] 'compare' (duration: 108.958961ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:24:48.993765Z","caller":"traceutil/trace.go:171","msg":"trace[1513176565] transaction","detail":"{read_only:false; response_revision:4082; number_of_response:1; }","duration":"213.210849ms","start":"2026-06-12T01:24:48.780516Z","end":"2026-06-12T01:24:48.993726Z","steps":["trace[1513176565] 'process raft request' (duration: 212.64168ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.208372Z","caller":"traceutil/trace.go:171","msg":"trace[457735504] transaction","detail":"{read_only:false; response_revision:4387; number_of_response:1; }","duration":"191.317949ms","start":"2026-06-12T01:24:56.017017Z","end":"2026-06-12T01:24:56.208335Z","steps":["trace[457735504] 'process raft request' (duration: 191.076435ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.208663Z","caller":"traceutil/trace.go:171","msg":"trace[435753446] transaction","detail":"{read_only:false; response_revision:4390; number_of_response:1; }","duration":"191.404459ms","start":"2026-06-12T01:24:56.01717Z","end":"2026-06-12T01:24:56.208574Z","steps":["trace[435753446] 'process raft request' (duration: 191.127625ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.208696Z","caller":"traceutil/trace.go:171","msg":"trace[515361924] transaction","detail":"{read_only:false; response_revision:4388; number_of_response:1; }","duration":"191.540461ms","start":"2026-06-12T01:24:56.0171Z","end":"2026-06-12T01:24:56.20864Z","steps":["trace[515361924] 'process raft request' (duration: 191.136495ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.208723Z","caller":"traceutil/trace.go:171","msg":"trace[1788520738] transaction","detail":"{read_only:false; response_revision:4389; number_of_response:1; }","duration":"191.536402ms","start":"2026-06-12T01:24:56.017138Z","end":"2026-06-12T01:24:56.208674Z","steps":["trace[1788520738] 'process raft request' (duration: 191.135676ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.208848Z","caller":"traceutil/trace.go:171","msg":"trace[944442472] linearizableReadLoop","detail":"{readStateIndex:4567; appliedIndex:4559; }","duration":"163.58116ms","start":"2026-06-12T01:24:56.04524Z","end":"2026-06-12T01:24:56.208821Z","steps":["trace[944442472] 'read index received' (duration: 13.663425ms)","trace[944442472] 'applied index is now lower than readState.Index' (duration: 149.916475ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:24:56.208942Z","caller":"traceutil/trace.go:171","msg":"trace[1942290544] transaction","detail":"{read_only:false; response_revision:4393; number_of_response:1; }","duration":"186.39911ms","start":"2026-06-12T01:24:56.02253Z","end":"2026-06-12T01:24:56.208929Z","steps":["trace[1942290544] 'process raft request' (duration: 186.018244ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.208946Z","caller":"traceutil/trace.go:171","msg":"trace[1968665927] transaction","detail":"{read_only:false; response_revision:4392; number_of_response:1; }","duration":"188.200019ms","start":"2026-06-12T01:24:56.020733Z","end":"2026-06-12T01:24:56.208933Z","steps":["trace[1968665927] 'process raft request' (duration: 187.62416ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.208868Z","caller":"traceutil/trace.go:171","msg":"trace[822504807] transaction","detail":"{read_only:false; response_revision:4391; number_of_response:1; }","duration":"191.565492ms","start":"2026-06-12T01:24:56.017264Z","end":"2026-06-12T01:24:56.208829Z","steps":["trace[822504807] 'process raft request' (duration: 191.062664ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:24:56.209093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.828694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-grafana\" ","response":"range_response_count:1 size:891"} {"level":"info","ts":"2026-06-12T01:24:56.20914Z","caller":"traceutil/trace.go:171","msg":"trace[1624549884] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-grafana; range_end:; response_count:1; response_revision:4393; }","duration":"163.926936ms","start":"2026-06-12T01:24:56.045199Z","end":"2026-06-12T01:24:56.209126Z","steps":["trace[1624549884] 'agreement among raft nodes before linearized reading' (duration: 163.771454ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.241749Z","caller":"traceutil/trace.go:171","msg":"trace[196793557] transaction","detail":"{read_only:false; response_revision:4394; number_of_response:1; }","duration":"127.806876ms","start":"2026-06-12T01:24:56.113921Z","end":"2026-06-12T01:24:56.241728Z","steps":["trace[196793557] 'process raft request' (duration: 127.586673ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:56.241854Z","caller":"traceutil/trace.go:171","msg":"trace[228616082] transaction","detail":"{read_only:false; response_revision:4395; number_of_response:1; }","duration":"106.919877ms","start":"2026-06-12T01:24:56.134916Z","end":"2026-06-12T01:24:56.241836Z","steps":["trace[228616082] 'process raft request' (duration: 106.749084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:24:56.241985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.164686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:24:56.244343Z","caller":"traceutil/trace.go:171","msg":"trace[1323702685] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:4395; }","duration":"141.591863ms","start":"2026-06-12T01:24:56.102728Z","end":"2026-06-12T01:24:56.24432Z","steps":["trace[1323702685] 'agreement among raft nodes before linearized reading' (duration: 139.110734ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:24:57.751051Z","caller":"traceutil/trace.go:171","msg":"trace[202477897] linearizableReadLoop","detail":"{readStateIndex:4657; appliedIndex:4656; }","duration":"165.65133ms","start":"2026-06-12T01:24:57.585375Z","end":"2026-06-12T01:24:57.751026Z","steps":["trace[202477897] 'read index received' (duration: 102.957782ms)","trace[202477897] 'applied index is now lower than readState.Index' (duration: 62.692098ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:24:57.751143Z","caller":"traceutil/trace.go:171","msg":"trace[1024171174] transaction","detail":"{read_only:false; response_revision:4482; number_of_response:1; }","duration":"171.173967ms","start":"2026-06-12T01:24:57.579935Z","end":"2026-06-12T01:24:57.751109Z","steps":["trace[1024171174] 'process raft request' (duration: 108.405918ms)","trace[1024171174] 'compare' (duration: 62.564236ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:24:57.751276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.889974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-tls\" ","response":"range_response_count:1 size:2930"} {"level":"info","ts":"2026-06-12T01:24:57.751313Z","caller":"traceutil/trace.go:171","msg":"trace[1859950571] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-tls; range_end:; response_count:1; response_revision:4482; }","duration":"165.974715ms","start":"2026-06-12T01:24:57.585327Z","end":"2026-06-12T01:24:57.751302Z","steps":["trace[1859950571] 'agreement among raft nodes before linearized reading' (duration: 165.831153ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:00.750337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.478538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:25:00.750419Z","caller":"traceutil/trace.go:171","msg":"trace[398871711] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:4566; }","duration":"153.60302ms","start":"2026-06-12T01:25:00.596797Z","end":"2026-06-12T01:25:00.7504Z","steps":["trace[398871711] 'count revisions from in-memory index tree' (duration: 153.417707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:00.7505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.756139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-06-12T01:25:00.750602Z","caller":"traceutil/trace.go:171","msg":"trace[1658431763] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4566; }","duration":"163.962953ms","start":"2026-06-12T01:25:00.586608Z","end":"2026-06-12T01:25:00.750571Z","steps":["trace[1658431763] 'range keys from in-memory index tree' (duration: 163.623567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:00.750764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.290201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-12T01:25:00.75082Z","caller":"traceutil/trace.go:171","msg":"trace[78166400] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4566; }","duration":"196.361121ms","start":"2026-06-12T01:25:00.554446Z","end":"2026-06-12T01:25:00.750807Z","steps":["trace[78166400] 'range keys from in-memory index tree' (duration: 196.178758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:00.750904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.121205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-06-12T01:25:00.75096Z","caller":"traceutil/trace.go:171","msg":"trace[1808313365] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4566; }","duration":"171.213327ms","start":"2026-06-12T01:25:00.579735Z","end":"2026-06-12T01:25:00.750949Z","steps":["trace[1808313365] 'range keys from in-memory index tree' (duration: 170.953083ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:00.961469Z","caller":"traceutil/trace.go:171","msg":"trace[628490160] linearizableReadLoop","detail":"{readStateIndex:4744; appliedIndex:4742; }","duration":"184.863002ms","start":"2026-06-12T01:25:00.776581Z","end":"2026-06-12T01:25:00.961444Z","steps":["trace[628490160] 'read index received' (duration: 62.655274ms)","trace[628490160] 'applied index is now lower than readState.Index' (duration: 122.206598ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:00.961519Z","caller":"traceutil/trace.go:171","msg":"trace[99193250] transaction","detail":"{read_only:false; response_revision:4568; number_of_response:1; }","duration":"204.921247ms","start":"2026-06-12T01:25:00.756573Z","end":"2026-06-12T01:25:00.961494Z","steps":["trace[99193250] 'process raft request' (duration: 165.061501ms)","trace[99193250] 'compare' (duration: 39.612972ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:00.961748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.143966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-06-12T01:25:00.961835Z","caller":"traceutil/trace.go:171","msg":"trace[1951384031] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4568; }","duration":"185.291519ms","start":"2026-06-12T01:25:00.776518Z","end":"2026-06-12T01:25:00.96181Z","steps":["trace[1951384031] 'agreement among raft nodes before linearized reading' (duration: 185.071665ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:01.521321Z","caller":"traceutil/trace.go:171","msg":"trace[178877928] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"373.899372ms","start":"2026-06-12T01:25:01.147404Z","end":"2026-06-12T01:25:01.521303Z","steps":["trace[178877928] 'process raft request' (duration: 373.544256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:01.521438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:01.147388Z","time spent":"373.979793ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:25:01.521443Z","caller":"traceutil/trace.go:171","msg":"trace[1303944386] linearizableReadLoop","detail":"{readStateIndex:4749; appliedIndex:4747; }","duration":"369.249848ms","start":"2026-06-12T01:25:01.152153Z","end":"2026-06-12T01:25:01.521403Z","steps":["trace[1303944386] 'read index received' (duration: 19.405174ms)","trace[1303944386] 'applied index is now lower than readState.Index' (duration: 349.843284ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:01.52153Z","caller":"traceutil/trace.go:171","msg":"trace[2144089275] transaction","detail":"{read_only:false; response_revision:4574; number_of_response:1; }","duration":"365.844575ms","start":"2026-06-12T01:25:01.155677Z","end":"2026-06-12T01:25:01.521522Z","steps":["trace[2144089275] 'process raft request' (duration: 365.52746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:01.521621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:01.155669Z","time spent":"365.930647ms","remote":"127.0.0.1:48322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15282,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:25:01.521832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.630444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:01.521902Z","caller":"traceutil/trace.go:171","msg":"trace[890128043] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4574; }","duration":"369.752577ms","start":"2026-06-12T01:25:01.152132Z","end":"2026-06-12T01:25:01.521885Z","steps":["trace[890128043] 'agreement among raft nodes before linearized reading' (duration: 369.581434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:01.521967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:01.152124Z","time spent":"369.834088ms","remote":"127.0.0.1:47916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-12T01:25:01.571658Z","caller":"traceutil/trace.go:171","msg":"trace[30323804] transaction","detail":"{read_only:false; response_revision:4576; number_of_response:1; }","duration":"280.64244ms","start":"2026-06-12T01:25:01.290971Z","end":"2026-06-12T01:25:01.571614Z","steps":["trace[30323804] 'process raft request' (duration: 280.416676ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:01.571688Z","caller":"traceutil/trace.go:171","msg":"trace[1163848587] transaction","detail":"{read_only:false; response_revision:4577; number_of_response:1; }","duration":"220.915423ms","start":"2026-06-12T01:25:01.350749Z","end":"2026-06-12T01:25:01.571664Z","steps":["trace[1163848587] 'process raft request' (duration: 220.72505ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:01.571873Z","caller":"traceutil/trace.go:171","msg":"trace[954732919] transaction","detail":"{read_only:false; response_revision:4575; number_of_response:1; }","duration":"388.908068ms","start":"2026-06-12T01:25:01.182954Z","end":"2026-06-12T01:25:01.571862Z","steps":["trace[954732919] 'process raft request' (duration: 388.274958ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:01.571984Z","caller":"traceutil/trace.go:171","msg":"trace[1700423802] transaction","detail":"{read_only:false; response_revision:4578; number_of_response:1; }","duration":"141.842594ms","start":"2026-06-12T01:25:01.430129Z","end":"2026-06-12T01:25:01.571972Z","steps":["trace[1700423802] 'process raft request' (duration: 141.397587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:01.571988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:01.182935Z","time spent":"388.969908ms","remote":"127.0.0.1:35796","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2228,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-12T01:25:01.572235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.682746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-12T01:25:01.57228Z","caller":"traceutil/trace.go:171","msg":"trace[334850548] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4579; }","duration":"392.777688ms","start":"2026-06-12T01:25:01.179489Z","end":"2026-06-12T01:25:01.572267Z","steps":["trace[334850548] 'agreement among raft nodes before linearized reading' (duration: 392.592165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:01.572313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:01.179459Z","time spent":"392.846389ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-12T01:25:01.572521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.771684ms","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-12T01:25:01.572559Z","caller":"traceutil/trace.go:171","msg":"trace[1475425441] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4579; }","duration":"187.817794ms","start":"2026-06-12T01:25:01.384732Z","end":"2026-06-12T01:25:01.57255Z","steps":["trace[1475425441] 'agreement among raft nodes before linearized reading' (duration: 187.722593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:01.572694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.11772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6c0cbe19-18e7-46f8-950b-676fd3ccd24a\" ","response":"range_response_count:1 size:3758"} {"level":"info","ts":"2026-06-12T01:25:01.572734Z","caller":"traceutil/trace.go:171","msg":"trace[1944270194] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6c0cbe19-18e7-46f8-950b-676fd3ccd24a; range_end:; response_count:1; response_revision:4579; }","duration":"241.15251ms","start":"2026-06-12T01:25:01.331569Z","end":"2026-06-12T01:25:01.572721Z","steps":["trace[1944270194] 'agreement among raft nodes before linearized reading' (duration: 241.055609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:01.572981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.695218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-m8chq\" ","response":"range_response_count:1 size:4657"} {"level":"info","ts":"2026-06-12T01:25:01.573021Z","caller":"traceutil/trace.go:171","msg":"trace[115695660] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-patch-m8chq; range_end:; response_count:1; response_revision:4579; }","duration":"380.77753ms","start":"2026-06-12T01:25:01.192234Z","end":"2026-06-12T01:25:01.573012Z","steps":["trace[115695660] 'agreement among raft nodes before linearized reading' (duration: 380.664618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:01.573054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:01.192216Z","time spent":"380.82988ms","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":4680,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-m8chq\" "} {"level":"warn","ts":"2026-06-12T01:25:07.097861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.533354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-12T01:25:07.09792Z","caller":"traceutil/trace.go:171","msg":"trace[2098685359] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4707; }","duration":"116.634146ms","start":"2026-06-12T01:25:06.981273Z","end":"2026-06-12T01:25:07.097907Z","steps":["trace[2098685359] 'range keys from in-memory index tree' (duration: 116.375042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:07.097858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.837967ms","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-12T01:25:07.097978Z","caller":"traceutil/trace.go:171","msg":"trace[1840790801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4707; }","duration":"198.992319ms","start":"2026-06-12T01:25:06.898961Z","end":"2026-06-12T01:25:07.097953Z","steps":["trace[1840790801] 'range keys from in-memory index tree' (duration: 198.692754ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:08.651582Z","caller":"traceutil/trace.go:171","msg":"trace[262043734] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"136.543033ms","start":"2026-06-12T01:25:08.514978Z","end":"2026-06-12T01:25:08.651521Z","steps":["trace[262043734] 'process raft request' (duration: 136.265729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:08.668958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.489567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-2xmwc\" ","response":"range_response_count:1 size:9761"} {"level":"info","ts":"2026-06-12T01:25:08.669059Z","caller":"traceutil/trace.go:171","msg":"trace[37377746] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-2xmwc; range_end:; response_count:1; response_revision:4719; }","duration":"108.602319ms","start":"2026-06-12T01:25:08.560435Z","end":"2026-06-12T01:25:08.669037Z","steps":["trace[37377746] 'agreement among raft nodes before linearized reading' (duration: 92.345136ms)","trace[37377746] 'range keys from in-memory index tree' (duration: 15.951518ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:08.66907Z","caller":"traceutil/trace.go:171","msg":"trace[1903850553] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"106.698509ms","start":"2026-06-12T01:25:08.562331Z","end":"2026-06-12T01:25:08.66903Z","steps":["trace[1903850553] 'process raft request' (duration: 106.483026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:13.754604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.599431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:13.754704Z","caller":"traceutil/trace.go:171","msg":"trace[685245987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4805; }","duration":"603.742833ms","start":"2026-06-12T01:25:13.150941Z","end":"2026-06-12T01:25:13.754683Z","steps":["trace[685245987] 'range keys from in-memory index tree' (duration: 603.50002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:13.754751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:13.150929Z","time spent":"603.813154ms","remote":"127.0.0.1:47910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T01:25:13.755339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.090916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T01:25:13.755475Z","caller":"traceutil/trace.go:171","msg":"trace[1356668974] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4805; }","duration":"162.208548ms","start":"2026-06-12T01:25:13.593185Z","end":"2026-06-12T01:25:13.755393Z","steps":["trace[1356668974] 'range keys from in-memory index tree' (duration: 161.872613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:13.755552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.549516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81659ada-4288-4ef2-a18c-d746808a16f8\" ","response":"range_response_count:1 size:3644"} {"level":"warn","ts":"2026-06-12T01:25:13.755565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.810029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-12T01:25:13.755606Z","caller":"traceutil/trace.go:171","msg":"trace[1941402290] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-81659ada-4288-4ef2-a18c-d746808a16f8; range_end:; response_count:1; response_revision:4805; }","duration":"148.640948ms","start":"2026-06-12T01:25:13.606951Z","end":"2026-06-12T01:25:13.755592Z","steps":["trace[1941402290] 'range keys from in-memory index tree' (duration: 148.417555ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.755609Z","caller":"traceutil/trace.go:171","msg":"trace[674534866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4805; }","duration":"615.890941ms","start":"2026-06-12T01:25:13.139706Z","end":"2026-06-12T01:25:13.755597Z","steps":["trace[674534866] 'range keys from in-memory index tree' (duration: 615.644497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:13.75564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:13.139684Z","time spent":"615.947691ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T01:25:13.755762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.117307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-12T01:25:13.755786Z","caller":"traceutil/trace.go:171","msg":"trace[163063764] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4805; }","duration":"613.172399ms","start":"2026-06-12T01:25:13.142606Z","end":"2026-06-12T01:25:13.755778Z","steps":["trace[163063764] 'range keys from in-memory index tree' (duration: 612.973936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:13.755813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:13.142587Z","time spent":"613.218249ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T01:25:13.75593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.82611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81659ada-4288-4ef2-a18c-d746808a16f8\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-12T01:25:13.755955Z","caller":"traceutil/trace.go:171","msg":"trace[1246753827] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-81659ada-4288-4ef2-a18c-d746808a16f8; range_end:; response_count:1; response_revision:4805; }","duration":"518.890341ms","start":"2026-06-12T01:25:13.237058Z","end":"2026-06-12T01:25:13.755948Z","steps":["trace[1246753827] 'range keys from in-memory index tree' (duration: 518.714368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:13.755975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:13.237035Z","time spent":"518.933582ms","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3667,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81659ada-4288-4ef2-a18c-d746808a16f8\" "} {"level":"info","ts":"2026-06-12T01:25:13.890415Z","caller":"traceutil/trace.go:171","msg":"trace[2088562418] transaction","detail":"{read_only:false; response_revision:4806; number_of_response:1; }","duration":"276.047738ms","start":"2026-06-12T01:25:13.614341Z","end":"2026-06-12T01:25:13.890388Z","steps":["trace[2088562418] 'process raft request' (duration: 275.881575ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.924273Z","caller":"traceutil/trace.go:171","msg":"trace[1015588271] transaction","detail":"{read_only:false; response_revision:4808; number_of_response:1; }","duration":"257.820996ms","start":"2026-06-12T01:25:13.666423Z","end":"2026-06-12T01:25:13.924244Z","steps":["trace[1015588271] 'process raft request' (duration: 257.632573ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.924467Z","caller":"traceutil/trace.go:171","msg":"trace[823769077] transaction","detail":"{read_only:false; response_revision:4807; number_of_response:1; }","duration":"264.835904ms","start":"2026-06-12T01:25:13.659599Z","end":"2026-06-12T01:25:13.924435Z","steps":["trace[823769077] 'process raft request' (duration: 264.279165ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.924626Z","caller":"traceutil/trace.go:171","msg":"trace[628148492] transaction","detail":"{read_only:false; response_revision:4809; number_of_response:1; }","duration":"257.484931ms","start":"2026-06-12T01:25:13.66712Z","end":"2026-06-12T01:25:13.924605Z","steps":["trace[628148492] 'process raft request' (duration: 257.083224ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.924902Z","caller":"traceutil/trace.go:171","msg":"trace[300261521] transaction","detail":"{read_only:false; response_revision:4810; number_of_response:1; }","duration":"204.335279ms","start":"2026-06-12T01:25:13.720552Z","end":"2026-06-12T01:25:13.924887Z","steps":["trace[300261521] 'process raft request' (duration: 203.984703ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.925091Z","caller":"traceutil/trace.go:171","msg":"trace[1445077769] transaction","detail":"{read_only:false; response_revision:4811; number_of_response:1; }","duration":"164.28676ms","start":"2026-06-12T01:25:13.76079Z","end":"2026-06-12T01:25:13.925077Z","steps":["trace[1445077769] 'process raft request' (duration: 164.039716ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.925415Z","caller":"traceutil/trace.go:171","msg":"trace[61252387] transaction","detail":"{read_only:false; response_revision:4812; number_of_response:1; }","duration":"164.156988ms","start":"2026-06-12T01:25:13.76125Z","end":"2026-06-12T01:25:13.925407Z","steps":["trace[61252387] 'process raft request' (duration: 163.774162ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.925617Z","caller":"traceutil/trace.go:171","msg":"trace[166029107] linearizableReadLoop","detail":"{readStateIndex:4992; appliedIndex:4988; }","duration":"209.952025ms","start":"2026-06-12T01:25:13.715658Z","end":"2026-06-12T01:25:13.92561Z","steps":["trace[166029107] 'read index received' (duration: 174.527868ms)","trace[166029107] 'applied index is now lower than readState.Index' (duration: 35.423527ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:13.925636Z","caller":"traceutil/trace.go:171","msg":"trace[1599472493] transaction","detail":"{read_only:false; response_revision:4813; number_of_response:1; }","duration":"163.444227ms","start":"2026-06-12T01:25:13.762166Z","end":"2026-06-12T01:25:13.92561Z","steps":["trace[1599472493] 'process raft request' (duration: 163.194973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:13.925741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.078848ms","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-12T01:25:13.925768Z","caller":"traceutil/trace.go:171","msg":"trace[1772865558] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4815; }","duration":"210.160688ms","start":"2026-06-12T01:25:13.715601Z","end":"2026-06-12T01:25:13.925762Z","steps":["trace[1772865558] 'agreement among raft nodes before linearized reading' (duration: 210.047507ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:13.925767Z","caller":"traceutil/trace.go:171","msg":"trace[1809103570] transaction","detail":"{read_only:false; response_revision:4814; number_of_response:1; }","duration":"160.779395ms","start":"2026-06-12T01:25:13.764966Z","end":"2026-06-12T01:25:13.925746Z","steps":["trace[1809103570] 'process raft request' (duration: 160.547422ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:14.074689Z","caller":"traceutil/trace.go:171","msg":"trace[1817661001] transaction","detail":"{read_only:false; response_revision:4816; number_of_response:1; }","duration":"142.721955ms","start":"2026-06-12T01:25:13.931942Z","end":"2026-06-12T01:25:14.074664Z","steps":["trace[1817661001] 'process raft request' (duration: 44.703961ms)","trace[1817661001] 'compare' (duration: 97.905562ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:14.090186Z","caller":"traceutil/trace.go:171","msg":"trace[1014412001] transaction","detail":"{read_only:false; response_revision:4817; number_of_response:1; }","duration":"150.361913ms","start":"2026-06-12T01:25:13.939798Z","end":"2026-06-12T01:25:14.09016Z","steps":["trace[1014412001] 'process raft request' (duration: 150.189861ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:14.625843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.982253ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:25:14.626022Z","caller":"traceutil/trace.go:171","msg":"trace[261126234] transaction","detail":"{read_only:false; response_revision:4819; number_of_response:1; }","duration":"524.750223ms","start":"2026-06-12T01:25:14.10124Z","end":"2026-06-12T01:25:14.625991Z","steps":["trace[261126234] 'process raft request' (duration: 75.538707ms)","trace[261126234] 'compare' (duration: 448.661678ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:14.626051Z","caller":"traceutil/trace.go:171","msg":"trace[1586779646] linearizableReadLoop","detail":"{readStateIndex:5002; appliedIndex:5001; }","duration":"475.598364ms","start":"2026-06-12T01:25:14.150424Z","end":"2026-06-12T01:25:14.626023Z","steps":["trace[1586779646] 'read index received' (duration: 26.337896ms)","trace[1586779646] 'applied index is now lower than readState.Index' (duration: 449.257768ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:14.626196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:14.101202Z","time spent":"524.886095ms","remote":"127.0.0.1:48056","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:25:14.691447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.008243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:14.691539Z","caller":"traceutil/trace.go:171","msg":"trace[867104105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4819; }","duration":"541.105625ms","start":"2026-06-12T01:25:14.15041Z","end":"2026-06-12T01:25:14.691516Z","steps":["trace[867104105] 'agreement among raft nodes before linearized reading' (duration: 475.750426ms)","trace[867104105] 'range keys from in-memory index tree' (duration: 65.235727ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:14.691577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:14.150353Z","time spent":"541.215717ms","remote":"127.0.0.1:47916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T01:25:14.69187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.52864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:25:14.691906Z","caller":"traceutil/trace.go:171","msg":"trace[21160558] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:4819; }","duration":"390.612012ms","start":"2026-06-12T01:25:14.301285Z","end":"2026-06-12T01:25:14.691897Z","steps":["trace[21160558] 'agreement among raft nodes before linearized reading' (duration: 390.537801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:14.691935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:14.301257Z","time spent":"390.670982ms","remote":"127.0.0.1:48016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":12,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-06-12T01:25:14.692137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.704277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-06-12T01:25:14.692208Z","caller":"traceutil/trace.go:171","msg":"trace[1925084728] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4819; }","duration":"457.810709ms","start":"2026-06-12T01:25:14.234379Z","end":"2026-06-12T01:25:14.692189Z","steps":["trace[1925084728] 'agreement among raft nodes before linearized reading' (duration: 457.565496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:14.692248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:14.234365Z","time spent":"457.87416ms","remote":"127.0.0.1:59340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-06-12T01:25:16.089315Z","caller":"traceutil/trace.go:171","msg":"trace[974871753] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5021; }","duration":"156.875678ms","start":"2026-06-12T01:25:15.932417Z","end":"2026-06-12T01:25:16.089293Z","steps":["trace[974871753] 'read index received' (duration: 79.675429ms)","trace[974871753] 'applied index is now lower than readState.Index' (duration: 77.199129ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:16.089381Z","caller":"traceutil/trace.go:171","msg":"trace[219865563] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"158.94511ms","start":"2026-06-12T01:25:15.930405Z","end":"2026-06-12T01:25:16.08935Z","steps":["trace[219865563] 'process raft request' (duration: 158.686986ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:16.089443Z","caller":"traceutil/trace.go:171","msg":"trace[568460882] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"156.98534ms","start":"2026-06-12T01:25:15.932447Z","end":"2026-06-12T01:25:16.089432Z","steps":["trace[568460882] 'process raft request' (duration: 156.768566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:16.089719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.281425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-12T01:25:16.089768Z","caller":"traceutil/trace.go:171","msg":"trace[430384493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4841; }","duration":"157.374516ms","start":"2026-06-12T01:25:15.932379Z","end":"2026-06-12T01:25:16.089754Z","steps":["trace[430384493] 'agreement among raft nodes before linearized reading' (duration: 157.212313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:16.089862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.372276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T01:25:16.089818Z","caller":"traceutil/trace.go:171","msg":"trace[27796521] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"156.867278ms","start":"2026-06-12T01:25:15.932879Z","end":"2026-06-12T01:25:16.089746Z","steps":["trace[27796521] 'process raft request' (duration: 156.372011ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:16.08993Z","caller":"traceutil/trace.go:171","msg":"trace[1644296458] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4841; }","duration":"157.487348ms","start":"2026-06-12T01:25:15.932429Z","end":"2026-06-12T01:25:16.089917Z","steps":["trace[1644296458] 'agreement among raft nodes before linearized reading' (duration: 157.286035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:16.090117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.147553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18b830fc2a02ee9c\" ","response":"range_response_count:1 size:1012"} {"level":"info","ts":"2026-06-12T01:25:16.090156Z","caller":"traceutil/trace.go:171","msg":"trace[32619821] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-keystone-server-0.18b830fc2a02ee9c; range_end:; response_count:1; response_revision:4841; }","duration":"124.208445ms","start":"2026-06-12T01:25:15.965936Z","end":"2026-06-12T01:25:16.090144Z","steps":["trace[32619821] 'agreement among raft nodes before linearized reading' (duration: 124.107893ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:16.090304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.480477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-12T01:25:16.090394Z","caller":"traceutil/trace.go:171","msg":"trace[676989573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4841; }","duration":"157.58799ms","start":"2026-06-12T01:25:15.932755Z","end":"2026-06-12T01:25:16.090343Z","steps":["trace[676989573] 'agreement among raft nodes before linearized reading' (duration: 157.444627ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:16.971284Z","caller":"traceutil/trace.go:171","msg":"trace[1060658543] linearizableReadLoop","detail":"{readStateIndex:5036; appliedIndex:5035; }","duration":"281.964544ms","start":"2026-06-12T01:25:16.689296Z","end":"2026-06-12T01:25:16.97126Z","steps":["trace[1060658543] 'read index received' (duration: 271.284069ms)","trace[1060658543] 'applied index is now lower than readState.Index' (duration: 10.679355ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:16.971313Z","caller":"traceutil/trace.go:171","msg":"trace[620309383] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"318.361085ms","start":"2026-06-12T01:25:16.65292Z","end":"2026-06-12T01:25:16.971281Z","steps":["trace[620309383] 'process raft request' (duration: 307.736721ms)","trace[620309383] 'compare' (duration: 10.439831ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:16.971482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:16.652902Z","time spent":"318.499407ms","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13272,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:25:16.971521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.215208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-12T01:25:16.971561Z","caller":"traceutil/trace.go:171","msg":"trace[513403472] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4852; }","duration":"282.266278ms","start":"2026-06-12T01:25:16.68928Z","end":"2026-06-12T01:25:16.971546Z","steps":["trace[513403472] 'agreement among raft nodes before linearized reading' (duration: 282.098836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:16.971652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.250033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-12T01:25:16.971703Z","caller":"traceutil/trace.go:171","msg":"trace[1848000317] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4852; }","duration":"244.339875ms","start":"2026-06-12T01:25:16.727355Z","end":"2026-06-12T01:25:16.971694Z","steps":["trace[1848000317] 'agreement among raft nodes before linearized reading' (duration: 244.214513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:16.971977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.906549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81659ada-4288-4ef2-a18c-d746808a16f8\" ","response":"range_response_count:1 size:3950"} {"level":"info","ts":"2026-06-12T01:25:16.972035Z","caller":"traceutil/trace.go:171","msg":"trace[759559271] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-81659ada-4288-4ef2-a18c-d746808a16f8; range_end:; response_count:1; response_revision:4852; }","duration":"198.002051ms","start":"2026-06-12T01:25:16.774018Z","end":"2026-06-12T01:25:16.97202Z","steps":["trace[759559271] 'agreement among raft nodes before linearized reading' (duration: 197.844418ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:20.320242Z","caller":"traceutil/trace.go:171","msg":"trace[510710730] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"113.804746ms","start":"2026-06-12T01:25:20.206413Z","end":"2026-06-12T01:25:20.320218Z","steps":["trace[510710730] 'process raft request' (duration: 104.33529ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:20.320484Z","caller":"traceutil/trace.go:171","msg":"trace[62104787] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"113.554522ms","start":"2026-06-12T01:25:20.206907Z","end":"2026-06-12T01:25:20.320462Z","steps":["trace[62104787] 'process raft request' (duration: 113.462551ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:20.320496Z","caller":"traceutil/trace.go:171","msg":"trace[777070555] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"113.990869ms","start":"2026-06-12T01:25:20.206483Z","end":"2026-06-12T01:25:20.320474Z","steps":["trace[777070555] 'process raft request' (duration: 113.690764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:24.776643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.807239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:24.776742Z","caller":"traceutil/trace.go:171","msg":"trace[1439916510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4949; }","duration":"623.90096ms","start":"2026-06-12T01:25:24.152804Z","end":"2026-06-12T01:25:24.776705Z","steps":["trace[1439916510] 'range keys from in-memory index tree' (duration: 623.717088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:24.776785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:24.152782Z","time spent":"623.994121ms","remote":"127.0.0.1:47916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-12T01:25:24.778047Z","caller":"traceutil/trace.go:171","msg":"trace[45139099] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"566.29314ms","start":"2026-06-12T01:25:24.211716Z","end":"2026-06-12T01:25:24.778009Z","steps":["trace[45139099] 'process raft request' (duration: 470.774751ms)","trace[45139099] 'compare' (duration: 94.679396ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:24.778283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:24.211685Z","time spent":"566.500523ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:25:24.77852Z","caller":"traceutil/trace.go:171","msg":"trace[2100353746] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"566.775658ms","start":"2026-06-12T01:25:24.211733Z","end":"2026-06-12T01:25:24.778509Z","steps":["trace[2100353746] 'process raft request' (duration: 566.25727ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:24.778705Z","caller":"traceutil/trace.go:171","msg":"trace[1633427272] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"565.204274ms","start":"2026-06-12T01:25:24.213482Z","end":"2026-06-12T01:25:24.778686Z","steps":["trace[1633427272] 'process raft request' (duration: 564.827358ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:24.778802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:24.213475Z","time spent":"565.278625ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:25:24.779078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:24.211704Z","time spent":"566.888749ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:25:24.824339Z","caller":"traceutil/trace.go:171","msg":"trace[1618369729] linearizableReadLoop","detail":"{readStateIndex:5140; appliedIndex:5137; }","duration":"594.691924ms","start":"2026-06-12T01:25:24.229615Z","end":"2026-06-12T01:25:24.824307Z","steps":["trace[1618369729] 'read index received' (duration: 453.004829ms)","trace[1618369729] 'applied index is now lower than readState.Index' (duration: 141.684565ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:24.824626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.997279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-12T01:25:24.824697Z","caller":"traceutil/trace.go:171","msg":"trace[1078712631] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4952; }","duration":"595.12678ms","start":"2026-06-12T01:25:24.229552Z","end":"2026-06-12T01:25:24.824679Z","steps":["trace[1078712631] 'agreement among raft nodes before linearized reading' (duration: 594.938187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:24.824719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.100882ms","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-12T01:25:24.824773Z","caller":"traceutil/trace.go:171","msg":"trace[505394892] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4952; }","duration":"491.181103ms","start":"2026-06-12T01:25:24.333582Z","end":"2026-06-12T01:25:24.824763Z","steps":["trace[505394892] 'agreement among raft nodes before linearized reading' (duration: 491.01011ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:24.824779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:24.229541Z","time spent":"595.225513ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T01:25:24.824798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:24.333559Z","time spent":"491.232004ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-12T01:25:24.824857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.902453ms","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-12T01:25:24.824988Z","caller":"traceutil/trace.go:171","msg":"trace[1345736511] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4952; }","duration":"492.062307ms","start":"2026-06-12T01:25:24.332896Z","end":"2026-06-12T01:25:24.824959Z","steps":["trace[1345736511] 'agreement among raft nodes before linearized reading' (duration: 491.731682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:24.825034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:24.332888Z","time spent":"492.135498ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T01:25:24.825221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.260172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:25:24.825298Z","caller":"traceutil/trace.go:171","msg":"trace[1790370587] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:4952; }","duration":"265.970623ms","start":"2026-06-12T01:25:24.559312Z","end":"2026-06-12T01:25:24.825283Z","steps":["trace[1790370587] 'agreement among raft nodes before linearized reading' (duration: 265.247842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:24.825252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.584934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-12T01:25:24.825468Z","caller":"traceutil/trace.go:171","msg":"trace[1123875531] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4952; }","duration":"492.823028ms","start":"2026-06-12T01:25:24.332628Z","end":"2026-06-12T01:25:24.825451Z","steps":["trace[1123875531] 'agreement among raft nodes before linearized reading' (duration: 491.919554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:24.825625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:24.332617Z","time spent":"492.990941ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-12T01:25:25.210696Z","caller":"traceutil/trace.go:171","msg":"trace[893021964] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"173.03652ms","start":"2026-06-12T01:25:25.037636Z","end":"2026-06-12T01:25:25.210673Z","steps":["trace[893021964] 'process raft request' (duration: 172.542562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:30.632781Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232311978484742112,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-12T01:25:30.92198Z","caller":"traceutil/trace.go:171","msg":"trace[2018293801] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"851.619229ms","start":"2026-06-12T01:25:30.070341Z","end":"2026-06-12T01:25:30.92196Z","steps":["trace[2018293801] 'process raft request' (duration: 851.521627ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:30.922008Z","caller":"traceutil/trace.go:171","msg":"trace[960208397] linearizableReadLoop","detail":"{readStateIndex:5186; appliedIndex:5185; }","duration":"789.230851ms","start":"2026-06-12T01:25:30.132747Z","end":"2026-06-12T01:25:30.921978Z","steps":["trace[960208397] 'read index received' (duration: 789.193891ms)","trace[960208397] 'applied index is now lower than readState.Index' (duration: 34.34µs)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:30.922102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.070313Z","time spent":"851.73061ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:25:30.922185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.414895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:30.922221Z","caller":"traceutil/trace.go:171","msg":"trace[508271208] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4996; }","duration":"789.482016ms","start":"2026-06-12T01:25:30.132731Z","end":"2026-06-12T01:25:30.922213Z","steps":["trace[508271208] 'agreement among raft nodes before linearized reading' (duration: 789.378444ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:30.922255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.132675Z","time spent":"789.571026ms","remote":"127.0.0.1:35786","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-12T01:25:31.422754Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232311978484742117,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T01:25:31.923916Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232311978484742117,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-12T01:25:31.988804Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.066890702s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-12T01:25:33.153497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000370097s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-12T01:25:33.153605Z","caller":"traceutil/trace.go:171","msg":"trace[267339047] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00053709s","start":"2026-06-12T01:25:31.15305Z","end":"2026-06-12T01:25:33.153587Z","steps":["trace[267339047] 'agreement among raft nodes before linearized reading' (duration: 2.000407448s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.153654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:31.15302Z","time spent":"2.000625402s","remote":"127.0.0.1:47916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/12 01:25:33 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-12T01:25:33.368719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.372860065s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:25:33.369182Z","caller":"traceutil/trace.go:171","msg":"trace[1479458103] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"1.129012199s","start":"2026-06-12T01:25:32.240147Z","end":"2026-06-12T01:25:33.369159Z","steps":["trace[1479458103] 'process raft request' (duration: 1.128954278s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.369294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:32.240121Z","time spent":"1.12912184s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:25:33.369749Z","caller":"traceutil/trace.go:171","msg":"trace[1463457899] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"2.569624368s","start":"2026-06-12T01:25:30.800105Z","end":"2026-06-12T01:25:33.36973Z","steps":["trace[1463457899] 'process raft request' (duration: 1.195649027s)","trace[1463457899] 'compare' (duration: 1.372545839s)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:33.369848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.800078Z","time spent":"2.569723059s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:25:33.370046Z","caller":"traceutil/trace.go:171","msg":"trace[1314574254] linearizableReadLoop","detail":"{readStateIndex:5190; appliedIndex:5186; }","duration":"2.44791849s","start":"2026-06-12T01:25:30.922077Z","end":"2026-06-12T01:25:33.369996Z","steps":["trace[1314574254] 'read index received' (duration: 1.073635164s)","trace[1314574254] 'applied index is now lower than readState.Index' (duration: 1.374279696s)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:33.370133Z","caller":"traceutil/trace.go:171","msg":"trace[1146147010] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"2.569283353s","start":"2026-06-12T01:25:30.80084Z","end":"2026-06-12T01:25:33.370123Z","steps":["trace[1146147010] 'process raft request' (duration: 2.568026473s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.370244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.800827Z","time spent":"2.569328443s","remote":"127.0.0.1:48136","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-12T01:25:33.370358Z","caller":"traceutil/trace.go:171","msg":"trace[1378082934] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"2.568753874s","start":"2026-06-12T01:25:30.801596Z","end":"2026-06-12T01:25:33.37035Z","steps":["trace[1378082934] 'process raft request' (duration: 2.567373303s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.370411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.801545Z","time spent":"2.568844566s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:25:33.370491Z","caller":"traceutil/trace.go:171","msg":"trace[713646234] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"2.172757345s","start":"2026-06-12T01:25:31.197727Z","end":"2026-06-12T01:25:33.370484Z","steps":["trace[713646234] 'process raft request' (duration: 2.171318033s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.370549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:31.197704Z","time spent":"2.172824927s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:25:33.37058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.883712986s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:33.370647Z","caller":"traceutil/trace.go:171","msg":"trace[439436814] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:5001; }","duration":"2.883834257s","start":"2026-06-12T01:25:30.486794Z","end":"2026-06-12T01:25:33.370628Z","steps":["trace[439436814] 'agreement among raft nodes before linearized reading' (duration: 2.883731426s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.370701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.486774Z","time spent":"2.883913229s","remote":"127.0.0.1:35976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-06-12T01:25:33.370708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.177844071s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-2xmwc.18b830fad7732cf6\" ","response":"range_response_count:1 size:906"} {"level":"warn","ts":"2026-06-12T01:25:33.370794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.452691353s","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-12T01:25:33.370837Z","caller":"traceutil/trace.go:171","msg":"trace[1416537755] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5001; }","duration":"2.452743453s","start":"2026-06-12T01:25:30.918068Z","end":"2026-06-12T01:25:33.370811Z","steps":["trace[1416537755] 'agreement among raft nodes before linearized reading' (duration: 2.452665602s)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.370826Z","caller":"traceutil/trace.go:171","msg":"trace[1729746673] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-2xmwc.18b830fad7732cf6; range_end:; response_count:1; response_revision:5001; }","duration":"3.177982913s","start":"2026-06-12T01:25:30.192828Z","end":"2026-06-12T01:25:33.370811Z","steps":["trace[1729746673] 'agreement among raft nodes before linearized reading' (duration: 3.17778029s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.370858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.918053Z","time spent":"2.452799994s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-12T01:25:33.370874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.192815Z","time spent":"3.178045464s","remote":"127.0.0.1:47976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":929,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-2xmwc.18b830fad7732cf6\" "} {"level":"warn","ts":"2026-06-12T01:25:33.638813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.771521ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:25:33.639016Z","caller":"traceutil/trace.go:171","msg":"trace[20608530] linearizableReadLoop","detail":"{readStateIndex:5192; appliedIndex:5191; }","duration":"268.90207ms","start":"2026-06-12T01:25:33.370096Z","end":"2026-06-12T01:25:33.638998Z","steps":["trace[20608530] 'read index received' (duration: 125.984137ms)","trace[20608530] 'applied index is now lower than readState.Index' (duration: 142.916983ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:33.639082Z","caller":"traceutil/trace.go:171","msg":"trace[1649552786] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"711.700403ms","start":"2026-06-12T01:25:32.927371Z","end":"2026-06-12T01:25:33.639071Z","steps":["trace[1649552786] 'process raft request' (duration: 568.600117ms)","trace[1649552786] 'compare' (duration: 142.68254ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:25:33.63914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:32.927345Z","time spent":"711.765514ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-12T01:25:33.639281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.665222616s","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-06-12T01:25:33.639286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.409890023s","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-12T01:25:33.639311Z","caller":"traceutil/trace.go:171","msg":"trace[713812577] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5003; }","duration":"2.665252957s","start":"2026-06-12T01:25:30.97405Z","end":"2026-06-12T01:25:33.639303Z","steps":["trace[713812577] 'agreement among raft nodes before linearized reading' (duration: 2.665176906s)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.63932Z","caller":"traceutil/trace.go:171","msg":"trace[1722957517] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5003; }","duration":"2.409966485s","start":"2026-06-12T01:25:31.229344Z","end":"2026-06-12T01:25:33.639311Z","steps":["trace[1722957517] 'agreement among raft nodes before linearized reading' (duration: 2.409843293s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.639337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.974003Z","time spent":"2.665326878s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-12T01:25:33.639353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:31.229321Z","time spent":"2.410026275s","remote":"127.0.0.1:48136","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-12T01:25:33.639407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.036468ms","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":"warn","ts":"2026-06-12T01:25:33.639419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.438977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:33.63944Z","caller":"traceutil/trace.go:171","msg":"trace[1794893411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5003; }","duration":"485.491939ms","start":"2026-06-12T01:25:33.153941Z","end":"2026-06-12T01:25:33.639433Z","steps":["trace[1794893411] 'agreement among raft nodes before linearized reading' (duration: 485.158644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.639468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:33.153927Z","time spent":"485.534859ms","remote":"127.0.0.1:47910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-12T01:25:33.639505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.157534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16547"} {"level":"warn","ts":"2026-06-12T01:25:33.639523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.913882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-12T01:25:33.639555Z","caller":"traceutil/trace.go:171","msg":"trace[771520560] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5003; }","duration":"631.239014ms","start":"2026-06-12T01:25:33.008302Z","end":"2026-06-12T01:25:33.639541Z","steps":["trace[771520560] 'agreement among raft nodes before linearized reading' (duration: 630.814328ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.639571Z","caller":"traceutil/trace.go:171","msg":"trace[1089388702] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5003; }","duration":"572.990833ms","start":"2026-06-12T01:25:33.066565Z","end":"2026-06-12T01:25:33.639556Z","steps":["trace[1089388702] 'agreement among raft nodes before linearized reading' (duration: 572.542036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.639603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:33.008285Z","time spent":"631.306535ms","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16570,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-06-12T01:25:33.639605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:33.066548Z","time spent":"573.048954ms","remote":"127.0.0.1:48070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-12T01:25:33.63975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.703173822s","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-12T01:25:33.639771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.044171937s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-12T01:25:33.639808Z","caller":"traceutil/trace.go:171","msg":"trace[1669542362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5003; }","duration":"2.703272524s","start":"2026-06-12T01:25:30.936522Z","end":"2026-06-12T01:25:33.639794Z","steps":["trace[1669542362] 'agreement among raft nodes before linearized reading' (duration: 2.702529333s)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.639844Z","caller":"traceutil/trace.go:171","msg":"trace[469054822] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5003; }","duration":"2.044244058s","start":"2026-06-12T01:25:31.595585Z","end":"2026-06-12T01:25:33.639829Z","steps":["trace[469054822] 'agreement among raft nodes before linearized reading' (duration: 2.043573058s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.639896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.599456453s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:25:33.63944Z","caller":"traceutil/trace.go:171","msg":"trace[1059316897] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:5003; }","duration":"885.10564ms","start":"2026-06-12T01:25:32.754324Z","end":"2026-06-12T01:25:33.639429Z","steps":["trace[1059316897] 'agreement among raft nodes before linearized reading' (duration: 884.800295ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.63994Z","caller":"traceutil/trace.go:171","msg":"trace[241213290] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:5003; }","duration":"1.599614645s","start":"2026-06-12T01:25:32.040313Z","end":"2026-06-12T01:25:33.639928Z","steps":["trace[241213290] 'agreement among raft nodes before linearized reading' (duration: 1.598772822s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.639947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:32.754303Z","time spent":"885.630657ms","remote":"127.0.0.1:36008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-12T01:25:33.639974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:32.040292Z","time spent":"1.599672796s","remote":"127.0.0.1:56650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"warn","ts":"2026-06-12T01:25:33.639899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:31.595532Z","time spent":"2.0443548s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-12T01:25:33.639858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.9365Z","time spent":"2.703346335s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-12T01:25:33.640301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.663806155s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-12T01:25:33.640284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.588272103s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-12T01:25:33.640336Z","caller":"traceutil/trace.go:171","msg":"trace[2029732430] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5003; }","duration":"2.663875436s","start":"2026-06-12T01:25:30.976452Z","end":"2026-06-12T01:25:33.640328Z","steps":["trace[2029732430] 'agreement among raft nodes before linearized reading' (duration: 2.662728639s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.640363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:30.976432Z","time spent":"2.663923547s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-12T01:25:33.640371Z","caller":"traceutil/trace.go:171","msg":"trace[1858034392] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5003; }","duration":"1.588393346s","start":"2026-06-12T01:25:32.051954Z","end":"2026-06-12T01:25:33.640348Z","steps":["trace[1858034392] 'agreement among raft nodes before linearized reading' (duration: 1.587196717s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.640376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.642433805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"warn","ts":"2026-06-12T01:25:33.640411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:32.051944Z","time spent":"1.588458726s","remote":"127.0.0.1:48048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-06-12T01:25:33.640338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.641792105s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-12T01:25:33.640442Z","caller":"traceutil/trace.go:171","msg":"trace[911859726] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5003; }","duration":"1.642623948s","start":"2026-06-12T01:25:31.997799Z","end":"2026-06-12T01:25:33.640423Z","steps":["trace[911859726] 'agreement among raft nodes before linearized reading' (duration: 1.641371929s)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.640436Z","caller":"traceutil/trace.go:171","msg":"trace[1499591236] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"266.981801ms","start":"2026-06-12T01:25:33.373433Z","end":"2026-06-12T01:25:33.640414Z","steps":["trace[1499591236] 'process raft request' (duration: 265.480568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.640489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:31.997343Z","time spent":"1.643132545s","remote":"127.0.0.1:59340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3339,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-06-12T01:25:33.640577Z","caller":"traceutil/trace.go:171","msg":"trace[400848588] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5003; }","duration":"1.641943057s","start":"2026-06-12T01:25:31.998515Z","end":"2026-06-12T01:25:33.640458Z","steps":["trace[400848588] 'agreement among raft nodes before linearized reading' (duration: 1.640650198s)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.640585Z","caller":"traceutil/trace.go:171","msg":"trace[1116371618] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"265.460528ms","start":"2026-06-12T01:25:33.375106Z","end":"2026-06-12T01:25:33.640566Z","steps":["trace[1116371618] 'process raft request' (duration: 264.163948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.64066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.392523367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:33.640723Z","caller":"traceutil/trace.go:171","msg":"trace[1649897424] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:5004; }","duration":"1.392647899s","start":"2026-06-12T01:25:32.248063Z","end":"2026-06-12T01:25:33.640711Z","steps":["trace[1649897424] 'agreement among raft nodes before linearized reading' (duration: 1.391069345s)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.640782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:32.248056Z","time spent":"1.39271391s","remote":"127.0.0.1:48274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-06-12T01:25:33.6408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:25:31.998508Z","time spent":"1.64211928s","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-06-12T01:25:33.812766Z","caller":"traceutil/trace.go:171","msg":"trace[340320358] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"166.326258ms","start":"2026-06-12T01:25:33.646407Z","end":"2026-06-12T01:25:33.812733Z","steps":["trace[340320358] 'process raft request' (duration: 105.66841ms)","trace[340320358] 'compare' (duration: 60.479875ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:33.823338Z","caller":"traceutil/trace.go:171","msg":"trace[1933836099] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"176.618194ms","start":"2026-06-12T01:25:33.64666Z","end":"2026-06-12T01:25:33.823279Z","steps":["trace[1933836099] 'process raft request' (duration: 176.298189ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.82333Z","caller":"traceutil/trace.go:171","msg":"trace[1922980109] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"176.512122ms","start":"2026-06-12T01:25:33.646744Z","end":"2026-06-12T01:25:33.823256Z","steps":["trace[1922980109] 'process raft request' (duration: 176.420331ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.823727Z","caller":"traceutil/trace.go:171","msg":"trace[1311684337] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"174.028504ms","start":"2026-06-12T01:25:33.649673Z","end":"2026-06-12T01:25:33.823702Z","steps":["trace[1311684337] 'process raft request' (duration: 173.849791ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.823753Z","caller":"traceutil/trace.go:171","msg":"trace[699544718] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"176.942958ms","start":"2026-06-12T01:25:33.64678Z","end":"2026-06-12T01:25:33.823723Z","steps":["trace[699544718] 'process raft request' (duration: 176.42671ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.823912Z","caller":"traceutil/trace.go:171","msg":"trace[166488423] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"174.170856ms","start":"2026-06-12T01:25:33.649729Z","end":"2026-06-12T01:25:33.8239Z","steps":["trace[166488423] 'process raft request' (duration: 173.927812ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.824002Z","caller":"traceutil/trace.go:171","msg":"trace[1897518749] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"172.086345ms","start":"2026-06-12T01:25:33.651864Z","end":"2026-06-12T01:25:33.82395Z","steps":["trace[1897518749] 'process raft request' (duration: 171.911922ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:25:33.824204Z","caller":"traceutil/trace.go:171","msg":"trace[875651203] linearizableReadLoop","detail":"{readStateIndex:5198; appliedIndex:5194; }","duration":"177.277563ms","start":"2026-06-12T01:25:33.646885Z","end":"2026-06-12T01:25:33.824163Z","steps":["trace[875651203] 'read index received' (duration: 105.197552ms)","trace[875651203] 'applied index is now lower than readState.Index' (duration: 72.078221ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:25:33.824273Z","caller":"traceutil/trace.go:171","msg":"trace[488690954] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"168.398719ms","start":"2026-06-12T01:25:33.655856Z","end":"2026-06-12T01:25:33.824255Z","steps":["trace[488690954] 'process raft request' (duration: 167.990593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.824764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.845432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-81659ada-4288-4ef2-a18c-d746808a16f8\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-06-12T01:25:33.824823Z","caller":"traceutil/trace.go:171","msg":"trace[165689837] range","detail":"{range_begin:/registry/persistentvolumes/pvc-81659ada-4288-4ef2-a18c-d746808a16f8; range_end:; response_count:1; response_revision:5012; }","duration":"177.944854ms","start":"2026-06-12T01:25:33.646863Z","end":"2026-06-12T01:25:33.824807Z","steps":["trace[165689837] 'agreement among raft nodes before linearized reading' (duration: 177.71213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.841284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.223645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:25:33.84139Z","caller":"traceutil/trace.go:171","msg":"trace[2074196216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5013; }","duration":"189.362817ms","start":"2026-06-12T01:25:33.65201Z","end":"2026-06-12T01:25:33.841373Z","steps":["trace[2074196216] 'agreement among raft nodes before linearized reading' (duration: 189.176384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:25:33.841397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.733187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-12T01:25:33.841648Z","caller":"traceutil/trace.go:171","msg":"trace[2004847775] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5013; }","duration":"192.828809ms","start":"2026-06-12T01:25:33.648627Z","end":"2026-06-12T01:25:33.841456Z","steps":["trace[2004847775] 'agreement among raft nodes before linearized reading' (duration: 192.526464ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:03.76512Z","caller":"traceutil/trace.go:171","msg":"trace[1928140847] linearizableReadLoop","detail":"{readStateIndex:5500; appliedIndex:5499; }","duration":"114.358035ms","start":"2026-06-12T01:26:03.650745Z","end":"2026-06-12T01:26:03.765103Z","steps":["trace[1928140847] 'read index received' (duration: 114.242024ms)","trace[1928140847] 'applied index is now lower than readState.Index' (duration: 115.401µs)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:26:03.765213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.458497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-12T01:26:03.765236Z","caller":"traceutil/trace.go:171","msg":"trace[703881929] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:5303; }","duration":"114.522828ms","start":"2026-06-12T01:26:03.650703Z","end":"2026-06-12T01:26:03.765226Z","steps":["trace[703881929] 'agreement among raft nodes before linearized reading' (duration: 114.467237ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:03.765404Z","caller":"traceutil/trace.go:171","msg":"trace[1571815217] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"137.932913ms","start":"2026-06-12T01:26:03.627219Z","end":"2026-06-12T01:26:03.765152Z","steps":["trace[1571815217] 'process raft request' (duration: 137.760401ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:07.890769Z","caller":"traceutil/trace.go:171","msg":"trace[783779485] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"112.27327ms","start":"2026-06-12T01:26:07.778472Z","end":"2026-06-12T01:26:07.890746Z","steps":["trace[783779485] 'process raft request' (duration: 100.906273ms)","trace[783779485] 'compare' (duration: 11.191994ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:26:07.890892Z","caller":"traceutil/trace.go:171","msg":"trace[305034373] transaction","detail":"{read_only:false; response_revision:5326; number_of_response:1; }","duration":"112.400002ms","start":"2026-06-12T01:26:07.77847Z","end":"2026-06-12T01:26:07.89087Z","steps":["trace[305034373] 'process raft request' (duration: 112.208149ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:08.161059Z","caller":"traceutil/trace.go:171","msg":"trace[961437569] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"126.231833ms","start":"2026-06-12T01:26:08.034799Z","end":"2026-06-12T01:26:08.161031Z","steps":["trace[961437569] 'process raft request' (duration: 106.400442ms)","trace[961437569] 'compare' (duration: 19.633868ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:26:08.161174Z","caller":"traceutil/trace.go:171","msg":"trace[859673466] linearizableReadLoop","detail":"{readStateIndex:5529; appliedIndex:5526; }","duration":"123.669936ms","start":"2026-06-12T01:26:08.037483Z","end":"2026-06-12T01:26:08.161153Z","steps":["trace[859673466] 'read index received' (duration: 10.579646ms)","trace[859673466] 'applied index is now lower than readState.Index' (duration: 113.0891ms)"],"step_count":2} {"level":"info","ts":"2026-06-12T01:26:08.161211Z","caller":"traceutil/trace.go:171","msg":"trace[114456847] transaction","detail":"{read_only:false; response_revision:5331; number_of_response:1; }","duration":"126.067291ms","start":"2026-06-12T01:26:08.035129Z","end":"2026-06-12T01:26:08.161196Z","steps":["trace[114456847] 'process raft request' (duration: 125.857457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:26:08.161358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.871099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-12T01:26:08.16136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.433548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:26:08.16139Z","caller":"traceutil/trace.go:171","msg":"trace[471318012] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5331; }","duration":"123.923379ms","start":"2026-06-12T01:26:08.037457Z","end":"2026-06-12T01:26:08.161381Z","steps":["trace[471318012] 'agreement among raft nodes before linearized reading' (duration: 123.806538ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:08.1614Z","caller":"traceutil/trace.go:171","msg":"trace[1777244487] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:5331; }","duration":"120.515149ms","start":"2026-06-12T01:26:08.040873Z","end":"2026-06-12T01:26:08.161388Z","steps":["trace[1777244487] 'agreement among raft nodes before linearized reading' (duration: 120.416798ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:36.010164Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2900} {"level":"info","ts":"2026-06-12T01:26:36.108013Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2900,"took":"96.184455ms","hash":4233684652,"current-db-size-bytes":52748288,"current-db-size":"53 MB","current-db-size-in-use-bytes":28991488,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-12T01:26:36.108075Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4233684652,"revision":2900,"compact-revision":-1} {"level":"info","ts":"2026-06-12T01:26:46.061027Z","caller":"traceutil/trace.go:171","msg":"trace[21933871] transaction","detail":"{read_only:false; response_revision:5611; number_of_response:1; }","duration":"105.037743ms","start":"2026-06-12T01:26:45.955968Z","end":"2026-06-12T01:26:46.061006Z","steps":["trace[21933871] 'process raft request' (duration: 104.894241ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:46.191387Z","caller":"traceutil/trace.go:171","msg":"trace[1994153612] transaction","detail":"{read_only:false; response_revision:5612; number_of_response:1; }","duration":"184.721483ms","start":"2026-06-12T01:26:46.006636Z","end":"2026-06-12T01:26:46.191357Z","steps":["trace[1994153612] 'process raft request' (duration: 184.560141ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:46.226269Z","caller":"traceutil/trace.go:171","msg":"trace[1932419655] transaction","detail":"{read_only:false; response_revision:5613; number_of_response:1; }","duration":"123.858532ms","start":"2026-06-12T01:26:46.102387Z","end":"2026-06-12T01:26:46.226245Z","steps":["trace[1932419655] 'process raft request' (duration: 123.70682ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:46.226604Z","caller":"traceutil/trace.go:171","msg":"trace[291307802] transaction","detail":"{read_only:false; response_revision:5614; number_of_response:1; }","duration":"119.141175ms","start":"2026-06-12T01:26:46.107451Z","end":"2026-06-12T01:26:46.226592Z","steps":["trace[291307802] 'process raft request' (duration: 118.75742ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:26:46.227136Z","caller":"traceutil/trace.go:171","msg":"trace[1075853346] transaction","detail":"{read_only:false; response_revision:5615; number_of_response:1; }","duration":"115.694316ms","start":"2026-06-12T01:26:46.111382Z","end":"2026-06-12T01:26:46.227076Z","steps":["trace[1075853346] 'process raft request' (duration: 115.089347ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:29:25.428428Z","caller":"traceutil/trace.go:171","msg":"trace[463886905] transaction","detail":"{read_only:false; response_revision:6734; number_of_response:1; }","duration":"166.43468ms","start":"2026-06-12T01:29:25.261946Z","end":"2026-06-12T01:29:25.428381Z","steps":["trace[463886905] 'process raft request' (duration: 166.008165ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:29:25.593111Z","caller":"traceutil/trace.go:171","msg":"trace[542492625] transaction","detail":"{read_only:false; response_revision:6735; number_of_response:1; }","duration":"160.510587ms","start":"2026-06-12T01:29:25.432553Z","end":"2026-06-12T01:29:25.593064Z","steps":["trace[542492625] 'process raft request' (duration: 155.664133ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:29:34.702573Z","caller":"traceutil/trace.go:171","msg":"trace[2048579134] transaction","detail":"{read_only:false; response_revision:6778; number_of_response:1; }","duration":"194.767788ms","start":"2026-06-12T01:29:34.507784Z","end":"2026-06-12T01:29:34.702552Z","steps":["trace[2048579134] 'process raft request' (duration: 194.638844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-12T01:29:34.998756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.845102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-12T01:29:34.998869Z","caller":"traceutil/trace.go:171","msg":"trace[667850986] transaction","detail":"{read_only:false; response_revision:6779; number_of_response:1; }","duration":"360.19913ms","start":"2026-06-12T01:29:34.63865Z","end":"2026-06-12T01:29:34.998849Z","steps":["trace[667850986] 'process raft request' (duration: 213.171722ms)","trace[667850986] 'compare' (duration: 146.545612ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:29:34.99893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-12T01:29:34.638599Z","time spent":"360.302593ms","remote":"127.0.0.1:48136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-12T01:29:35.100643Z","caller":"traceutil/trace.go:171","msg":"trace[230985896] transaction","detail":"{read_only:false; response_revision:6780; number_of_response:1; }","duration":"258.829435ms","start":"2026-06-12T01:29:34.841783Z","end":"2026-06-12T01:29:35.100613Z","steps":["trace[230985896] 'process raft request' (duration: 258.001288ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:29:35.100837Z","caller":"traceutil/trace.go:171","msg":"trace[424738605] transaction","detail":"{read_only:false; response_revision:6781; number_of_response:1; }","duration":"258.924089ms","start":"2026-06-12T01:29:34.841896Z","end":"2026-06-12T01:29:35.10082Z","steps":["trace[424738605] 'process raft request' (duration: 258.305819ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:29:35.100976Z","caller":"traceutil/trace.go:171","msg":"trace[722410957] linearizableReadLoop","detail":"{readStateIndex:7031; appliedIndex:7028; }","duration":"179.976039ms","start":"2026-06-12T01:29:34.92099Z","end":"2026-06-12T01:29:35.100966Z","steps":["trace[722410957] 'read index received' (duration: 96.242955ms)","trace[722410957] 'applied index is now lower than readState.Index' (duration: 83.732124ms)"],"step_count":2} {"level":"warn","ts":"2026-06-12T01:29:35.101205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.194736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-12T01:29:35.101234Z","caller":"traceutil/trace.go:171","msg":"trace[52769412] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:6782; }","duration":"180.284089ms","start":"2026-06-12T01:29:34.920944Z","end":"2026-06-12T01:29:35.101229Z","steps":["trace[52769412] 'agreement among raft nodes before linearized reading' (duration: 180.218377ms)"],"step_count":1} {"level":"info","ts":"2026-06-12T01:31:36.017605Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5532} {"level":"info","ts":"2026-06-12T01:31:36.104451Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5532,"took":"85.691444ms","hash":3197262045,"current-db-size-bytes":52748288,"current-db-size":"53 MB","current-db-size-in-use-bytes":18518016,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-12T01:31:36.104513Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3197262045,"revision":5532,"compact-revision":2900} {"level":"info","ts":"2026-06-12T01:32:41.482732Z","caller":"traceutil/trace.go:171","msg":"trace[909884310] transaction","detail":"{read_only:false; response_revision:7746; number_of_response:1; }","duration":"103.408675ms","start":"2026-06-12T01:32:41.379272Z","end":"2026-06-12T01:32:41.482681Z","steps":["trace[909884310] 'process raft request' (duration: 103.154138ms)"],"step_count":1}