{"level":"warn","ts":"2026-04-17T02:27:01.382245Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T02:27:01.38239Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.169: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.19.213.169:2380","--initial-cluster=instance=https://199.19.213.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.169:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-17T02:27:01.382483Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-17T02:27:01.382501Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.169:2380"]} {"level":"info","ts":"2026-04-17T02:27:01.38263Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-17T02:27:01.383476Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.169:2379"]} {"level":"info","ts":"2026-04-17T02:27:01.383565Z","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.19.213.169:2380"],"listen-peer-urls":["https://199.19.213.169:2380"],"advertise-client-urls":["https://199.19.213.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.169:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-17T02:27:01.394445Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.577623ms"} {"level":"info","ts":"2026-04-17T02:27:01.403606Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a742f9f5aa7326e5","cluster-id":"a6b466adbadbbcd5"} {"level":"info","ts":"2026-04-17T02:27:01.4037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 switched to configuration voters=()"} {"level":"info","ts":"2026-04-17T02:27:01.403732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became follower at term 0"} {"level":"info","ts":"2026-04-17T02:27:01.403791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a742f9f5aa7326e5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-17T02:27:01.403801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became follower at term 1"} {"level":"info","ts":"2026-04-17T02:27:01.403923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 switched to configuration voters=(12052470386318845669)"} {"level":"warn","ts":"2026-04-17T02:27:01.416065Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-17T02:27:01.417605Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-17T02:27:01.418817Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-17T02:27:01.420933Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a742f9f5aa7326e5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-17T02:27:01.421129Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-17T02:27:01.421198Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-17T02:27:01.421208Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-17T02:27:01.421411Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a742f9f5aa7326e5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-17T02:27:01.424258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 switched to configuration voters=(12052470386318845669)"} {"level":"info","ts":"2026-04-17T02:27:01.424406Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a6b466adbadbbcd5","local-member-id":"a742f9f5aa7326e5","added-peer-id":"a742f9f5aa7326e5","added-peer-peer-urls":["https://199.19.213.169:2380"]} {"level":"info","ts":"2026-04-17T02:27:01.426698Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-17T02:27:01.426805Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.169:2380"} {"level":"info","ts":"2026-04-17T02:27:01.426828Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.169:2380"} {"level":"info","ts":"2026-04-17T02:27:01.42749Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a742f9f5aa7326e5","initial-advertise-peer-urls":["https://199.19.213.169:2380"],"listen-peer-urls":["https://199.19.213.169:2380"],"advertise-client-urls":["https://199.19.213.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-17T02:27:01.427536Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-17T02:27:01.804141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 is starting a new election at term 1"} {"level":"info","ts":"2026-04-17T02:27:01.804205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-17T02:27:01.804223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 received MsgPreVoteResp from a742f9f5aa7326e5 at term 1"} {"level":"info","ts":"2026-04-17T02:27:01.804239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became candidate at term 2"} {"level":"info","ts":"2026-04-17T02:27:01.804246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 received MsgVoteResp from a742f9f5aa7326e5 at term 2"} {"level":"info","ts":"2026-04-17T02:27:01.804256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a742f9f5aa7326e5 became leader at term 2"} {"level":"info","ts":"2026-04-17T02:27:01.804329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a742f9f5aa7326e5 elected leader a742f9f5aa7326e5 at term 2"} {"level":"info","ts":"2026-04-17T02:27:01.805772Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T02:27:01.806734Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T02:27:01.806727Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a742f9f5aa7326e5","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.169:2379]}","request-path":"/0/members/a742f9f5aa7326e5/attributes","cluster-id":"a6b466adbadbbcd5","publish-timeout":"7s"} {"level":"info","ts":"2026-04-17T02:27:01.80679Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-17T02:27:01.807309Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-17T02:27:01.807432Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-17T02:27:01.807378Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a6b466adbadbbcd5","local-member-id":"a742f9f5aa7326e5","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T02:27:01.807668Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T02:27:01.807713Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-17T02:27:01.810095Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.169:2379"} {"level":"info","ts":"2026-04-17T02:27:01.813467Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-17T02:27:03.745794Z","caller":"traceutil/trace.go:171","msg":"trace[938697701] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"161.876664ms","start":"2026-04-17T02:27:03.583867Z","end":"2026-04-17T02:27:03.745743Z","steps":["trace[938697701] 'process raft request' (duration: 149.251633ms)","trace[938697701] 'compare' (duration: 12.212488ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:27:03.745796Z","caller":"traceutil/trace.go:171","msg":"trace[1739354932] transaction","detail":"{read_only:false; response_revision:41; number_of_response:1; }","duration":"161.850742ms","start":"2026-04-17T02:27:03.583912Z","end":"2026-04-17T02:27:03.745763Z","steps":["trace[1739354932] 'process raft request' (duration: 161.674306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:27:25.877946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.872292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T02:27:25.878043Z","caller":"traceutil/trace.go:171","msg":"trace[406283132] linearizableReadLoop","detail":"{readStateIndex:517; appliedIndex:516; }","duration":"138.622668ms","start":"2026-04-17T02:27:25.739408Z","end":"2026-04-17T02:27:25.87803Z","steps":["trace[406283132] 'read index received' (duration: 8.114146ms)","trace[406283132] 'applied index is now lower than readState.Index' (duration: 130.507292ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:27:25.878123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.72438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T02:27:25.878153Z","caller":"traceutil/trace.go:171","msg":"trace[557745934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:500; }","duration":"138.793481ms","start":"2026-04-17T02:27:25.739349Z","end":"2026-04-17T02:27:25.878143Z","steps":["trace[557745934] 'agreement among raft nodes before linearized reading' (duration: 138.75013ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:25.878103Z","caller":"traceutil/trace.go:171","msg":"trace[2028091415] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"211.305701ms","start":"2026-04-17T02:27:25.66675Z","end":"2026-04-17T02:27:25.878056Z","steps":["trace[2028091415] 'process raft request' (duration: 80.891212ms)","trace[2028091415] 'compare' (duration: 129.755009ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:27:25.878267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.192896ms","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-04-17T02:27:25.878346Z","caller":"traceutil/trace.go:171","msg":"trace[789125948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:500; }","duration":"101.30969ms","start":"2026-04-17T02:27:25.777019Z","end":"2026-04-17T02:27:25.878328Z","steps":["trace[789125948] 'agreement among raft nodes before linearized reading' (duration: 101.187706ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:27.188047Z","caller":"traceutil/trace.go:171","msg":"trace[1712858912] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"177.519122ms","start":"2026-04-17T02:27:27.010493Z","end":"2026-04-17T02:27:27.188012Z","steps":["trace[1712858912] 'process raft request' (duration: 177.339747ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:27.188029Z","caller":"traceutil/trace.go:171","msg":"trace[1923765167] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"199.423465ms","start":"2026-04-17T02:27:26.988542Z","end":"2026-04-17T02:27:27.187965Z","steps":["trace[1923765167] 'process raft request' (duration: 107.676799ms)","trace[1923765167] 'compare' (duration: 91.344004ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:27:27.200593Z","caller":"traceutil/trace.go:171","msg":"trace[2138845145] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"153.274588ms","start":"2026-04-17T02:27:27.047302Z","end":"2026-04-17T02:27:27.200576Z","steps":["trace[2138845145] 'process raft request' (duration: 153.164545ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:27.201204Z","caller":"traceutil/trace.go:171","msg":"trace[2028801994] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"165.87944ms","start":"2026-04-17T02:27:27.035316Z","end":"2026-04-17T02:27:27.201196Z","steps":["trace[2028801994] 'process raft request' (duration: 164.758057ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:27.421858Z","caller":"traceutil/trace.go:171","msg":"trace[2125536487] transaction","detail":"{read_only:false; number_of_response:1; response_revision:553; }","duration":"149.601548ms","start":"2026-04-17T02:27:27.272224Z","end":"2026-04-17T02:27:27.421825Z","steps":["trace[2125536487] 'process raft request' (duration: 93.685936ms)","trace[2125536487] 'compare' (duration: 55.705665ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:27:27.427015Z","caller":"traceutil/trace.go:171","msg":"trace[80021321] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"122.000881ms","start":"2026-04-17T02:27:27.304988Z","end":"2026-04-17T02:27:27.426989Z","steps":["trace[80021321] 'process raft request' (duration: 121.734994ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:27.602648Z","caller":"traceutil/trace.go:171","msg":"trace[813533502] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"114.134564ms","start":"2026-04-17T02:27:27.48848Z","end":"2026-04-17T02:27:27.602614Z","steps":["trace[813533502] 'process raft request' (duration: 49.143237ms)","trace[813533502] 'compare' (duration: 64.737439ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:27:27.608674Z","caller":"traceutil/trace.go:171","msg":"trace[1477832895] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"115.057162ms","start":"2026-04-17T02:27:27.49358Z","end":"2026-04-17T02:27:27.608637Z","steps":["trace[1477832895] 'process raft request' (duration: 114.122404ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:33.015601Z","caller":"traceutil/trace.go:171","msg":"trace[302082620] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"115.851374ms","start":"2026-04-17T02:27:32.899712Z","end":"2026-04-17T02:27:33.015564Z","steps":["trace[302082620] 'process raft request' (duration: 115.501422ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:33.266157Z","caller":"traceutil/trace.go:171","msg":"trace[218098474] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"227.319381ms","start":"2026-04-17T02:27:33.038802Z","end":"2026-04-17T02:27:33.266122Z","steps":["trace[218098474] 'process raft request' (duration: 226.538137ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:27:33.79482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.707393ms","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-04-17T02:27:33.795007Z","caller":"traceutil/trace.go:171","msg":"trace[2000576216] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:609; }","duration":"367.925499ms","start":"2026-04-17T02:27:33.427055Z","end":"2026-04-17T02:27:33.79498Z","steps":["trace[2000576216] 'range keys from in-memory index tree' (duration: 367.681373ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:27:33.801985Z","caller":"traceutil/trace.go:171","msg":"trace[2097613151] linearizableReadLoop","detail":"{readStateIndex:631; appliedIndex:630; }","duration":"132.05947ms","start":"2026-04-17T02:27:33.669908Z","end":"2026-04-17T02:27:33.801967Z","steps":["trace[2097613151] 'read index received' (duration: 131.888855ms)","trace[2097613151] 'applied index is now lower than readState.Index' (duration: 169.545µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:27:33.802114Z","caller":"traceutil/trace.go:171","msg":"trace[986458969] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"475.925918ms","start":"2026-04-17T02:27:33.326145Z","end":"2026-04-17T02:27:33.802071Z","steps":["trace[986458969] 'process raft request' (duration: 475.678771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:27:33.802233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.299527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-17T02:27:33.802275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:27:33.326114Z","time spent":"476.078252ms","remote":"127.0.0.1:34410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T02:27:33.802352Z","caller":"traceutil/trace.go:171","msg":"trace[1029711555] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:610; }","duration":"132.485292ms","start":"2026-04-17T02:27:33.669844Z","end":"2026-04-17T02:27:33.802329Z","steps":["trace[1029711555] 'agreement among raft nodes before linearized reading' (duration: 132.235585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:27:50.819486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.19326ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-17T02:30:21.898424Z","caller":"traceutil/trace.go:171","msg":"trace[799626365] linearizableReadLoop","detail":"{readStateIndex:2320; appliedIndex:2319; }","duration":"159.714593ms","start":"2026-04-17T02:30:21.738673Z","end":"2026-04-17T02:30:21.898387Z","steps":["trace[799626365] 'read index received' (duration: 159.673483ms)","trace[799626365] 'applied index is now lower than readState.Index' (duration: 38.83µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:30:21.898753Z","caller":"traceutil/trace.go:171","msg":"trace[348781046] transaction","detail":"{read_only:false; response_revision:2227; number_of_response:1; }","duration":"290.731133ms","start":"2026-04-17T02:30:21.60774Z","end":"2026-04-17T02:30:21.898471Z","steps":["trace[348781046] 'process raft request' (duration: 290.453588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:21.898695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.954789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T02:30:21.898864Z","caller":"traceutil/trace.go:171","msg":"trace[633047764] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2227; }","duration":"160.226254ms","start":"2026-04-17T02:30:21.738625Z","end":"2026-04-17T02:30:21.898851Z","steps":["trace[633047764] 'agreement among raft nodes before linearized reading' (duration: 159.917929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:22.129216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.434443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T02:30:22.129387Z","caller":"traceutil/trace.go:171","msg":"trace[105825744] linearizableReadLoop","detail":"{readStateIndex:2321; appliedIndex:2320; }","duration":"230.824687ms","start":"2026-04-17T02:30:21.89854Z","end":"2026-04-17T02:30:22.129364Z","steps":["trace[105825744] 'read index received' (duration: 124.050836ms)","trace[105825744] 'applied index is now lower than readState.Index' (duration: 106.771801ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:30:22.12951Z","caller":"traceutil/trace.go:171","msg":"trace[62705540] transaction","detail":"{read_only:false; response_revision:2228; number_of_response:1; }","duration":"321.643171ms","start":"2026-04-17T02:30:21.807853Z","end":"2026-04-17T02:30:22.129496Z","steps":["trace[62705540] 'process raft request' (duration: 214.730048ms)","trace[62705540] 'compare' (duration: 106.072307ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:30:22.129599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:30:21.807822Z","time spent":"321.716792ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T02:30:22.130082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.077953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T02:30:22.130137Z","caller":"traceutil/trace.go:171","msg":"trace[968277854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2228; }","duration":"229.122783ms","start":"2026-04-17T02:30:21.90099Z","end":"2026-04-17T02:30:22.130113Z","steps":["trace[968277854] 'agreement among raft nodes before linearized reading' (duration: 228.93164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:22.130165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.657333ms","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":"warn","ts":"2026-04-17T02:30:22.130196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.593915ms","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-04-17T02:30:22.130262Z","caller":"traceutil/trace.go:171","msg":"trace[1375001527] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2228; }","duration":"303.802826ms","start":"2026-04-17T02:30:21.826434Z","end":"2026-04-17T02:30:22.130236Z","steps":["trace[1375001527] 'agreement among raft nodes before linearized reading' (duration: 303.310157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:22.130316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:30:21.826412Z","time spent":"303.889758ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-04-17T02:30:22.130346Z","caller":"traceutil/trace.go:171","msg":"trace[404883143] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2228; }","duration":"255.788409ms","start":"2026-04-17T02:30:21.874515Z","end":"2026-04-17T02:30:22.130304Z","steps":["trace[404883143] 'agreement among raft nodes before linearized reading' (duration: 255.33817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:22.130639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.304917ms","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-04-17T02:30:22.130945Z","caller":"traceutil/trace.go:171","msg":"trace[1713495430] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2228; }","duration":"159.690903ms","start":"2026-04-17T02:30:21.971224Z","end":"2026-04-17T02:30:22.130915Z","steps":["trace[1713495430] 'agreement among raft nodes before linearized reading' (duration: 159.271585ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:30:35.217885Z","caller":"traceutil/trace.go:171","msg":"trace[163803747] transaction","detail":"{read_only:false; response_revision:2372; number_of_response:1; }","duration":"162.837521ms","start":"2026-04-17T02:30:35.054997Z","end":"2026-04-17T02:30:35.217834Z","steps":["trace[163803747] 'process raft request' (duration: 162.531085ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:30:35.218008Z","caller":"traceutil/trace.go:171","msg":"trace[1581006973] transaction","detail":"{read_only:false; response_revision:2374; number_of_response:1; }","duration":"162.7672ms","start":"2026-04-17T02:30:35.055222Z","end":"2026-04-17T02:30:35.217989Z","steps":["trace[1581006973] 'process raft request' (duration: 162.532066ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:30:35.217863Z","caller":"traceutil/trace.go:171","msg":"trace[554203703] transaction","detail":"{read_only:false; response_revision:2373; number_of_response:1; }","duration":"162.667418ms","start":"2026-04-17T02:30:35.055165Z","end":"2026-04-17T02:30:35.217803Z","steps":["trace[554203703] 'process raft request' (duration: 162.532545ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:30:35.232892Z","caller":"traceutil/trace.go:171","msg":"trace[332834175] transaction","detail":"{read_only:false; response_revision:2375; number_of_response:1; }","duration":"154.42401ms","start":"2026-04-17T02:30:35.078452Z","end":"2026-04-17T02:30:35.232876Z","steps":["trace[332834175] 'process raft request' (duration: 154.362079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:42.680144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.235895ms","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-04-17T02:30:42.680228Z","caller":"traceutil/trace.go:171","msg":"trace[123787427] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2423; }","duration":"301.357657ms","start":"2026-04-17T02:30:42.37885Z","end":"2026-04-17T02:30:42.680208Z","steps":["trace[123787427] 'range keys from in-memory index tree' (duration: 300.936398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:42.680275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:30:42.378835Z","time spent":"301.429248ms","remote":"127.0.0.1:34208","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-04-17T02:30:57.267717Z","caller":"traceutil/trace.go:171","msg":"trace[824260934] transaction","detail":"{read_only:false; response_revision:2514; number_of_response:1; }","duration":"249.485269ms","start":"2026-04-17T02:30:57.018175Z","end":"2026-04-17T02:30:57.267661Z","steps":["trace[824260934] 'process raft request' (duration: 164.454159ms)","trace[824260934] 'compare' (duration: 84.247722ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:30:57.267751Z","caller":"traceutil/trace.go:171","msg":"trace[578671725] transaction","detail":"{read_only:false; response_revision:2515; number_of_response:1; }","duration":"187.268047ms","start":"2026-04-17T02:30:57.080456Z","end":"2026-04-17T02:30:57.267724Z","steps":["trace[578671725] 'process raft request' (duration: 186.739646ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:30:57.268228Z","caller":"traceutil/trace.go:171","msg":"trace[959462081] transaction","detail":"{read_only:false; response_revision:2516; number_of_response:1; }","duration":"168.233641ms","start":"2026-04-17T02:30:57.099961Z","end":"2026-04-17T02:30:57.268194Z","steps":["trace[959462081] 'process raft request' (duration: 167.710319ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:30:57.520661Z","caller":"traceutil/trace.go:171","msg":"trace[1673914850] linearizableReadLoop","detail":"{readStateIndex:2622; appliedIndex:2620; }","duration":"128.567984ms","start":"2026-04-17T02:30:57.392057Z","end":"2026-04-17T02:30:57.520625Z","steps":["trace[1673914850] 'read index received' (duration: 80.43876ms)","trace[1673914850] 'applied index is now lower than readState.Index' (duration: 48.127784ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:30:57.520797Z","caller":"traceutil/trace.go:171","msg":"trace[1697849383] transaction","detail":"{read_only:false; response_revision:2518; number_of_response:1; }","duration":"149.874919ms","start":"2026-04-17T02:30:57.370871Z","end":"2026-04-17T02:30:57.520746Z","steps":["trace[1697849383] 'process raft request' (duration: 101.43707ms)","trace[1697849383] 'compare' (duration: 48.0442ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:30:57.520994Z","caller":"traceutil/trace.go:171","msg":"trace[1260480141] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"149.611983ms","start":"2026-04-17T02:30:57.371344Z","end":"2026-04-17T02:30:57.520956Z","steps":["trace[1260480141] 'process raft request' (duration: 149.205635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:57.521073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.951011ms","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-04-17T02:30:57.521146Z","caller":"traceutil/trace.go:171","msg":"trace[199973961] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2519; }","duration":"129.142975ms","start":"2026-04-17T02:30:57.391984Z","end":"2026-04-17T02:30:57.521127Z","steps":["trace[199973961] 'agreement among raft nodes before linearized reading' (duration: 128.796978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:58.689514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.073664ms","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-04-17T02:30:58.689601Z","caller":"traceutil/trace.go:171","msg":"trace[1533209443] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2521; }","duration":"161.212007ms","start":"2026-04-17T02:30:58.528369Z","end":"2026-04-17T02:30:58.689581Z","steps":["trace[1533209443] 'range keys from in-memory index tree' (duration: 160.91732ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:30:58.998969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.011401ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T02:30:58.99911Z","caller":"traceutil/trace.go:171","msg":"trace[691201222] transaction","detail":"{read_only:false; response_revision:2523; number_of_response:1; }","duration":"214.529338ms","start":"2026-04-17T02:30:58.784555Z","end":"2026-04-17T02:30:58.999084Z","steps":["trace[691201222] 'process raft request' (duration: 90.25809ms)","trace[691201222] 'compare' (duration: 123.893449ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:33:08.344156Z","caller":"traceutil/trace.go:171","msg":"trace[1180936873] linearizableReadLoop","detail":"{readStateIndex:3426; appliedIndex:3424; }","duration":"114.083553ms","start":"2026-04-17T02:33:08.23003Z","end":"2026-04-17T02:33:08.344113Z","steps":["trace[1180936873] 'read index received' (duration: 64.353514ms)","trace[1180936873] 'applied index is now lower than readState.Index' (duration: 49.728489ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:33:08.344406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.319509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T02:33:08.344461Z","caller":"traceutil/trace.go:171","msg":"trace[1062668497] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:3295; }","duration":"114.437304ms","start":"2026-04-17T02:33:08.23001Z","end":"2026-04-17T02:33:08.344447Z","steps":["trace[1062668497] 'agreement among raft nodes before linearized reading' (duration: 114.258698ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:33:08.344285Z","caller":"traceutil/trace.go:171","msg":"trace[603454079] transaction","detail":"{read_only:false; response_revision:3295; number_of_response:1; }","duration":"125.427559ms","start":"2026-04-17T02:33:08.218828Z","end":"2026-04-17T02:33:08.344255Z","steps":["trace[603454079] 'process raft request' (duration: 125.0842ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:34:14.312547Z","caller":"traceutil/trace.go:171","msg":"trace[44820103] transaction","detail":"{read_only:false; response_revision:3659; number_of_response:1; }","duration":"116.374438ms","start":"2026-04-17T02:34:14.196132Z","end":"2026-04-17T02:34:14.312507Z","steps":["trace[44820103] 'process raft request' (duration: 116.287395ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:34:14.312787Z","caller":"traceutil/trace.go:171","msg":"trace[434983018] transaction","detail":"{read_only:false; response_revision:3658; number_of_response:1; }","duration":"132.251884ms","start":"2026-04-17T02:34:14.180493Z","end":"2026-04-17T02:34:14.312745Z","steps":["trace[434983018] 'process raft request' (duration: 131.676948ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:36:20.544449Z","caller":"traceutil/trace.go:171","msg":"trace[2098759914] transaction","detail":"{read_only:false; response_revision:4702; number_of_response:1; }","duration":"106.654966ms","start":"2026-04-17T02:36:20.437753Z","end":"2026-04-17T02:36:20.544408Z","steps":["trace[2098759914] 'process raft request' (duration: 105.277277ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:36:25.061356Z","caller":"traceutil/trace.go:171","msg":"trace[431641053] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"101.320505ms","start":"2026-04-17T02:36:24.960015Z","end":"2026-04-17T02:36:25.061335Z","steps":["trace[431641053] 'process raft request' (duration: 100.987875ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:01.988682Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2891} {"level":"info","ts":"2026-04-17T02:37:02.170464Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2891,"took":"179.852013ms","hash":3659166884,"current-db-size-bytes":51875840,"current-db-size":"52 MB","current-db-size-in-use-bytes":29097984,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-17T02:37:02.170515Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3659166884,"revision":2891,"compact-revision":-1} {"level":"warn","ts":"2026-04-17T02:37:04.360031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.161246ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T02:37:04.360188Z","caller":"traceutil/trace.go:171","msg":"trace[1399141788] linearizableReadLoop","detail":"{readStateIndex:5691; appliedIndex:5690; }","duration":"141.982392ms","start":"2026-04-17T02:37:04.218181Z","end":"2026-04-17T02:37:04.360164Z","steps":["trace[1399141788] 'read index received' (duration: 25.526368ms)","trace[1399141788] 'applied index is now lower than readState.Index' (duration: 116.454714ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:04.360303Z","caller":"traceutil/trace.go:171","msg":"trace[404811353] transaction","detail":"{read_only:false; response_revision:5486; number_of_response:1; }","duration":"146.499355ms","start":"2026-04-17T02:37:04.213791Z","end":"2026-04-17T02:37:04.36029Z","steps":["trace[404811353] 'process raft request' (duration: 29.947748ms)","trace[404811353] 'compare' (duration: 116.035162ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:37:04.360625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.473268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"} {"level":"warn","ts":"2026-04-17T02:37:04.360655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.439956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T02:37:04.360725Z","caller":"traceutil/trace.go:171","msg":"trace[1249424874] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5486; }","duration":"141.603262ms","start":"2026-04-17T02:37:04.219095Z","end":"2026-04-17T02:37:04.360698Z","steps":["trace[1249424874] 'agreement among raft nodes before linearized reading' (duration: 141.327104ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:04.360758Z","caller":"traceutil/trace.go:171","msg":"trace[669197585] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:5486; }","duration":"142.567741ms","start":"2026-04-17T02:37:04.218161Z","end":"2026-04-17T02:37:04.360728Z","steps":["trace[669197585] 'agreement among raft nodes before linearized reading' (duration: 142.384535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:09.708457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.021895ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T02:37:09.708763Z","caller":"traceutil/trace.go:171","msg":"trace[430457440] transaction","detail":"{read_only:false; response_revision:5630; number_of_response:1; }","duration":"469.767772ms","start":"2026-04-17T02:37:09.238961Z","end":"2026-04-17T02:37:09.708729Z","steps":["trace[430457440] 'process raft request' (duration: 265.309083ms)","trace[430457440] 'compare' (duration: 203.332325ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:37:09.708862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:09.238878Z","time spent":"469.941377ms","remote":"127.0.0.1:34124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:09.7899Z","caller":"traceutil/trace.go:171","msg":"trace[1753556005] linearizableReadLoop","detail":"{readStateIndex:5843; appliedIndex:5841; }","duration":"397.891582ms","start":"2026-04-17T02:37:09.391946Z","end":"2026-04-17T02:37:09.789838Z","steps":["trace[1753556005] 'read index received' (duration: 112.342976ms)","trace[1753556005] 'applied index is now lower than readState.Index' (duration: 285.546866ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:09.789965Z","caller":"traceutil/trace.go:171","msg":"trace[1458204682] transaction","detail":"{read_only:false; response_revision:5632; number_of_response:1; }","duration":"291.866472ms","start":"2026-04-17T02:37:09.498051Z","end":"2026-04-17T02:37:09.789917Z","steps":["trace[1458204682] 'process raft request' (duration: 291.708438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:09.790225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.252524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-17T02:37:09.790237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.276685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-17T02:37:09.79024Z","caller":"traceutil/trace.go:171","msg":"trace[228429961] transaction","detail":"{read_only:false; response_revision:5631; number_of_response:1; }","duration":"475.919752ms","start":"2026-04-17T02:37:09.314276Z","end":"2026-04-17T02:37:09.790196Z","steps":["trace[228429961] 'process raft request' (duration: 475.360566ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.79032Z","caller":"traceutil/trace.go:171","msg":"trace[861497831] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5632; }","duration":"398.420238ms","start":"2026-04-17T02:37:09.391878Z","end":"2026-04-17T02:37:09.790298Z","steps":["trace[861497831] 'agreement among raft nodes before linearized reading' (duration: 398.127529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:09.790363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:09.39185Z","time spent":"398.504701ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-17T02:37:09.79042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:09.314262Z","time spent":"476.061346ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T02:37:09.790547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.435746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-17T02:37:09.79027Z","caller":"traceutil/trace.go:171","msg":"trace[1565585837] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5632; }","duration":"398.348646ms","start":"2026-04-17T02:37:09.391905Z","end":"2026-04-17T02:37:09.790254Z","steps":["trace[1565585837] 'agreement among raft nodes before linearized reading' (duration: 398.13991ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.790582Z","caller":"traceutil/trace.go:171","msg":"trace[1312545954] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5632; }","duration":"206.493599ms","start":"2026-04-17T02:37:09.584078Z","end":"2026-04-17T02:37:09.790572Z","steps":["trace[1312545954] 'agreement among raft nodes before linearized reading' (duration: 206.394765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:09.790595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:09.391881Z","time spent":"398.704167ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-17T02:37:09.79059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.921768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/valkey-data-valkey-node-1.18a7043fb4426268\" ","response":"range_response_count:1 size:764"} {"level":"info","ts":"2026-04-17T02:37:09.790666Z","caller":"traceutil/trace.go:171","msg":"trace[260183588] range","detail":"{range_begin:/registry/events/openstack/valkey-data-valkey-node-1.18a7043fb4426268; range_end:; response_count:1; response_revision:5632; }","duration":"106.058411ms","start":"2026-04-17T02:37:09.684587Z","end":"2026-04-17T02:37:09.790646Z","steps":["trace[260183588] 'agreement among raft nodes before linearized reading' (duration: 105.857216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:09.790754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.788716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-17T02:37:09.790787Z","caller":"traceutil/trace.go:171","msg":"trace[1188218432] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5632; }","duration":"299.861627ms","start":"2026-04-17T02:37:09.490911Z","end":"2026-04-17T02:37:09.790773Z","steps":["trace[1188218432] 'agreement among raft nodes before linearized reading' (duration: 299.762234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:09.790997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.088896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-17T02:37:09.791036Z","caller":"traceutil/trace.go:171","msg":"trace[512049376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5632; }","duration":"100.153407ms","start":"2026-04-17T02:37:09.690875Z","end":"2026-04-17T02:37:09.791028Z","steps":["trace[512049376] 'agreement among raft nodes before linearized reading' (duration: 100.004503ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.902794Z","caller":"traceutil/trace.go:171","msg":"trace[1641681858] linearizableReadLoop","detail":"{readStateIndex:5845; appliedIndex:5844; }","duration":"108.958636ms","start":"2026-04-17T02:37:09.793799Z","end":"2026-04-17T02:37:09.902757Z","steps":["trace[1641681858] 'read index received' (duration: 124.734µs)","trace[1641681858] 'applied index is now lower than readState.Index' (duration: 108.831782ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:37:09.903082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.249225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T02:37:09.90317Z","caller":"traceutil/trace.go:171","msg":"trace[397151340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5632; }","duration":"109.394579ms","start":"2026-04-17T02:37:09.793752Z","end":"2026-04-17T02:37:09.903147Z","steps":["trace[397151340] 'agreement among raft nodes before linearized reading' (duration: 109.221384ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.903355Z","caller":"traceutil/trace.go:171","msg":"trace[775183236] transaction","detail":"{read_only:false; response_revision:5633; number_of_response:1; }","duration":"105.254698ms","start":"2026-04-17T02:37:09.798079Z","end":"2026-04-17T02:37:09.903334Z","steps":["trace[775183236] 'process raft request' (duration: 105.02298ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.903747Z","caller":"traceutil/trace.go:171","msg":"trace[1548131352] transaction","detail":"{read_only:false; response_revision:5634; number_of_response:1; }","duration":"105.478854ms","start":"2026-04-17T02:37:09.798251Z","end":"2026-04-17T02:37:09.90373Z","steps":["trace[1548131352] 'process raft request' (duration: 105.035981ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.90394Z","caller":"traceutil/trace.go:171","msg":"trace[608203630] transaction","detail":"{read_only:false; response_revision:5636; number_of_response:1; }","duration":"104.157265ms","start":"2026-04-17T02:37:09.799755Z","end":"2026-04-17T02:37:09.903913Z","steps":["trace[608203630] 'process raft request' (duration: 104.049042ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.904224Z","caller":"traceutil/trace.go:171","msg":"trace[723456425] transaction","detail":"{read_only:false; response_revision:5635; number_of_response:1; }","duration":"104.526287ms","start":"2026-04-17T02:37:09.799682Z","end":"2026-04-17T02:37:09.904209Z","steps":["trace[723456425] 'process raft request' (duration: 103.96929ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:09.904518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.024968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-17T02:37:09.904815Z","caller":"traceutil/trace.go:171","msg":"trace[1275593756] transaction","detail":"{read_only:false; response_revision:5637; number_of_response:1; }","duration":"105.02209ms","start":"2026-04-17T02:37:09.799777Z","end":"2026-04-17T02:37:09.904799Z","steps":["trace[1275593756] 'process raft request' (duration: 104.079153ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.904875Z","caller":"traceutil/trace.go:171","msg":"trace[1811913065] transaction","detail":"{read_only:false; response_revision:5638; number_of_response:1; }","duration":"102.786136ms","start":"2026-04-17T02:37:09.802071Z","end":"2026-04-17T02:37:09.904857Z","steps":["trace[1811913065] 'process raft request' (duration: 101.978922ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:09.904813Z","caller":"traceutil/trace.go:171","msg":"trace[1881982624] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5638; }","duration":"109.164794ms","start":"2026-04-17T02:37:09.795436Z","end":"2026-04-17T02:37:09.904601Z","steps":["trace[1881982624] 'agreement among raft nodes before linearized reading' (duration: 108.775322ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:14.152268Z","caller":"traceutil/trace.go:171","msg":"trace[130896964] transaction","detail":"{read_only:false; response_revision:5676; number_of_response:1; }","duration":"225.016135ms","start":"2026-04-17T02:37:13.927224Z","end":"2026-04-17T02:37:14.15224Z","steps":["trace[130896964] 'process raft request' (duration: 224.921192ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:14.152296Z","caller":"traceutil/trace.go:171","msg":"trace[1865892217] transaction","detail":"{read_only:false; response_revision:5675; number_of_response:1; }","duration":"225.046586ms","start":"2026-04-17T02:37:13.927198Z","end":"2026-04-17T02:37:14.152245Z","steps":["trace[1865892217] 'process raft request' (duration: 224.709556ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:14.152525Z","caller":"traceutil/trace.go:171","msg":"trace[187776948] transaction","detail":"{read_only:false; response_revision:5677; number_of_response:1; }","duration":"225.267892ms","start":"2026-04-17T02:37:13.927222Z","end":"2026-04-17T02:37:14.15249Z","steps":["trace[187776948] 'process raft request' (duration: 224.970333ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:14.288499Z","caller":"traceutil/trace.go:171","msg":"trace[1795235367] transaction","detail":"{read_only:false; response_revision:5679; number_of_response:1; }","duration":"359.334998ms","start":"2026-04-17T02:37:13.929144Z","end":"2026-04-17T02:37:14.288479Z","steps":["trace[1795235367] 'process raft request' (duration: 359.274986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.288641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:13.929134Z","time spent":"359.43704ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:14.288779Z","caller":"traceutil/trace.go:171","msg":"trace[428987986] linearizableReadLoop","detail":"{readStateIndex:5895; appliedIndex:5891; }","duration":"108.169465ms","start":"2026-04-17T02:37:14.180592Z","end":"2026-04-17T02:37:14.288762Z","steps":["trace[428987986] 'read index received' (duration: 107.679501ms)","trace[428987986] 'applied index is now lower than readState.Index' (duration: 489.284µs)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:14.288503Z","caller":"traceutil/trace.go:171","msg":"trace[929751928] transaction","detail":"{read_only:false; response_revision:5678; number_of_response:1; }","duration":"361.227563ms","start":"2026-04-17T02:37:13.92725Z","end":"2026-04-17T02:37:14.288477Z","steps":["trace[929751928] 'process raft request' (duration: 361.044168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.289052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:13.927227Z","time spent":"361.746749ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:14.288921Z","caller":"traceutil/trace.go:171","msg":"trace[2077598985] transaction","detail":"{read_only:false; response_revision:5680; number_of_response:1; }","duration":"356.034721ms","start":"2026-04-17T02:37:13.932846Z","end":"2026-04-17T02:37:14.288881Z","steps":["trace[2077598985] 'process raft request' (duration: 355.600798ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:14.288904Z","caller":"traceutil/trace.go:171","msg":"trace[1363348686] transaction","detail":"{read_only:false; response_revision:5681; number_of_response:1; }","duration":"330.77209ms","start":"2026-04-17T02:37:13.95812Z","end":"2026-04-17T02:37:14.288892Z","steps":["trace[1363348686] 'process raft request' (duration: 330.541153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.289207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.608098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-04-17T02:37:14.28925Z","caller":"traceutil/trace.go:171","msg":"trace[784967690] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5681; }","duration":"108.69498ms","start":"2026-04-17T02:37:14.180545Z","end":"2026-04-17T02:37:14.28924Z","steps":["trace[784967690] 'agreement among raft nodes before linearized reading' (duration: 108.380921ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.289418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:13.958105Z","time spent":"331.13244ms","remote":"127.0.0.1:34028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-17T02:37:14.289896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:13.932837Z","time spent":"356.98969ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:14.428527Z","caller":"traceutil/trace.go:171","msg":"trace[914045050] transaction","detail":"{read_only:false; response_revision:5683; number_of_response:1; }","duration":"125.839024ms","start":"2026-04-17T02:37:14.30266Z","end":"2026-04-17T02:37:14.428499Z","steps":["trace[914045050] 'process raft request' (duration: 100.019736ms)","trace[914045050] 'compare' (duration: 25.649313ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:14.668821Z","caller":"traceutil/trace.go:171","msg":"trace[1643291653] transaction","detail":"{read_only:false; response_revision:5684; number_of_response:1; }","duration":"231.149225ms","start":"2026-04-17T02:37:14.437632Z","end":"2026-04-17T02:37:14.668781Z","steps":["trace[1643291653] 'process raft request' (duration: 230.883327ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:14.92553Z","caller":"traceutil/trace.go:171","msg":"trace[1995714238] transaction","detail":"{read_only:false; response_revision:5685; number_of_response:1; }","duration":"487.438717ms","start":"2026-04-17T02:37:14.438069Z","end":"2026-04-17T02:37:14.925507Z","steps":["trace[1995714238] 'process raft request' (duration: 487.222371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.925763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:14.43806Z","time spent":"487.624863ms","remote":"127.0.0.1:34112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1283,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:14.926241Z","caller":"traceutil/trace.go:171","msg":"trace[677833072] transaction","detail":"{read_only:false; response_revision:5686; number_of_response:1; }","duration":"487.952422ms","start":"2026-04-17T02:37:14.438272Z","end":"2026-04-17T02:37:14.926225Z","steps":["trace[677833072] 'process raft request' (duration: 487.18924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.926384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:14.438228Z","time spent":"488.102337ms","remote":"127.0.0.1:34112","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:14.926771Z","caller":"traceutil/trace.go:171","msg":"trace[162400001] linearizableReadLoop","detail":"{readStateIndex:5901; appliedIndex:5897; }","duration":"386.29325ms","start":"2026-04-17T02:37:14.54046Z","end":"2026-04-17T02:37:14.926753Z","steps":["trace[162400001] 'read index received' (duration: 127.998488ms)","trace[162400001] 'applied index is now lower than readState.Index' (duration: 258.293732ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:14.926875Z","caller":"traceutil/trace.go:171","msg":"trace[649667475] transaction","detail":"{read_only:false; response_revision:5687; number_of_response:1; }","duration":"487.944192ms","start":"2026-04-17T02:37:14.438919Z","end":"2026-04-17T02:37:14.926863Z","steps":["trace[649667475] 'process raft request' (duration: 486.81666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.926979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:14.438892Z","time spent":"488.005544ms","remote":"127.0.0.1:34220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1869,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T02:37:14.927287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.791423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T02:37:14.927435Z","caller":"traceutil/trace.go:171","msg":"trace[488727951] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:5687; }","duration":"386.982939ms","start":"2026-04-17T02:37:14.5404Z","end":"2026-04-17T02:37:14.927383Z","steps":["trace[488727951] 'agreement among raft nodes before linearized reading' (duration: 386.620348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.927641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:14.540382Z","time spent":"387.208836ms","remote":"127.0.0.1:34048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":83,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-04-17T02:37:14.929452Z","caller":"traceutil/trace.go:171","msg":"trace[1121280452] transaction","detail":"{read_only:false; response_revision:5688; number_of_response:1; }","duration":"131.096318ms","start":"2026-04-17T02:37:14.798335Z","end":"2026-04-17T02:37:14.929432Z","steps":["trace[1121280452] 'process raft request' (duration: 130.84037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.929739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.256467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T02:37:14.929771Z","caller":"traceutil/trace.go:171","msg":"trace[1898189998] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5688; }","duration":"141.336649ms","start":"2026-04-17T02:37:14.788425Z","end":"2026-04-17T02:37:14.929761Z","steps":["trace[1898189998] 'agreement among raft nodes before linearized reading' (duration: 141.267386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.929663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.924435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T02:37:14.930092Z","caller":"traceutil/trace.go:171","msg":"trace[214051386] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5688; }","duration":"375.404479ms","start":"2026-04-17T02:37:14.554677Z","end":"2026-04-17T02:37:14.930081Z","steps":["trace[214051386] 'agreement among raft nodes before linearized reading' (duration: 374.952566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:14.930147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:14.554631Z","time spent":"375.506212ms","remote":"127.0.0.1:33966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-17T02:37:14.930159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.524021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-17T02:37:14.930312Z","caller":"traceutil/trace.go:171","msg":"trace[1402233016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5688; }","duration":"192.811609ms","start":"2026-04-17T02:37:14.737485Z","end":"2026-04-17T02:37:14.930296Z","steps":["trace[1402233016] 'agreement among raft nodes before linearized reading' (duration: 192.542731ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:16.578559Z","caller":"traceutil/trace.go:171","msg":"trace[26154610] transaction","detail":"{read_only:false; response_revision:5706; number_of_response:1; }","duration":"415.970163ms","start":"2026-04-17T02:37:16.162564Z","end":"2026-04-17T02:37:16.578534Z","steps":["trace[26154610] 'process raft request' (duration: 415.914281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:16.578729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:16.162555Z","time spent":"416.089646ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:16.578865Z","caller":"traceutil/trace.go:171","msg":"trace[1526729844] transaction","detail":"{read_only:false; response_revision:5705; number_of_response:1; }","duration":"416.568061ms","start":"2026-04-17T02:37:16.162279Z","end":"2026-04-17T02:37:16.578847Z","steps":["trace[1526729844] 'process raft request' (duration: 416.020935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:16.578958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:16.162248Z","time spent":"416.664483ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:16.581299Z","caller":"traceutil/trace.go:171","msg":"trace[1716979962] linearizableReadLoop","detail":"{readStateIndex:5922; appliedIndex:5921; }","duration":"288.156461ms","start":"2026-04-17T02:37:16.293118Z","end":"2026-04-17T02:37:16.581275Z","steps":["trace[1716979962] 'read index received' (duration: 286.055158ms)","trace[1716979962] 'applied index is now lower than readState.Index' (duration: 2.100343ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:16.581435Z","caller":"traceutil/trace.go:171","msg":"trace[877855373] transaction","detail":"{read_only:false; response_revision:5708; number_of_response:1; }","duration":"286.366078ms","start":"2026-04-17T02:37:16.294985Z","end":"2026-04-17T02:37:16.581351Z","steps":["trace[877855373] 'process raft request' (duration: 286.232134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:16.581644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.48803ms","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-04-17T02:37:16.581628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.49796ms","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-04-17T02:37:16.581691Z","caller":"traceutil/trace.go:171","msg":"trace[1610725737] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5708; }","duration":"287.551602ms","start":"2026-04-17T02:37:16.294128Z","end":"2026-04-17T02:37:16.58168Z","steps":["trace[1610725737] 'agreement among raft nodes before linearized reading' (duration: 287.316175ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:16.581718Z","caller":"traceutil/trace.go:171","msg":"trace[1463787006] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5708; }","duration":"288.611923ms","start":"2026-04-17T02:37:16.293086Z","end":"2026-04-17T02:37:16.581698Z","steps":["trace[1463787006] 'agreement among raft nodes before linearized reading' (duration: 288.306513ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:16.581922Z","caller":"traceutil/trace.go:171","msg":"trace[1201699044] transaction","detail":"{read_only:false; response_revision:5707; number_of_response:1; }","duration":"303.439338ms","start":"2026-04-17T02:37:16.27846Z","end":"2026-04-17T02:37:16.5819Z","steps":["trace[1201699044] 'process raft request' (duration: 302.632764ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:16.582094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:16.278445Z","time spent":"303.569512ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T02:37:16.582119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.608095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-04-17T02:37:16.582258Z","caller":"traceutil/trace.go:171","msg":"trace[387256190] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5708; }","duration":"285.753969ms","start":"2026-04-17T02:37:16.296485Z","end":"2026-04-17T02:37:16.582239Z","steps":["trace[387256190] 'agreement among raft nodes before linearized reading' (duration: 285.379549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:19.412834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.875339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-17T02:37:19.412972Z","caller":"traceutil/trace.go:171","msg":"trace[344619053] transaction","detail":"{read_only:false; response_revision:5726; number_of_response:1; }","duration":"464.139941ms","start":"2026-04-17T02:37:18.948809Z","end":"2026-04-17T02:37:19.412949Z","steps":["trace[344619053] 'process raft request' (duration: 245.18073ms)","trace[344619053] 'compare' (duration: 217.436786ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:37:19.413121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:18.948771Z","time spent":"464.235373ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-17T02:37:19.429189Z","caller":"traceutil/trace.go:171","msg":"trace[1501720547] transaction","detail":"{read_only:false; response_revision:5727; number_of_response:1; }","duration":"474.713581ms","start":"2026-04-17T02:37:18.954449Z","end":"2026-04-17T02:37:19.429163Z","steps":["trace[1501720547] 'process raft request' (duration: 474.546636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:19.429387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:18.954423Z","time spent":"474.839446ms","remote":"127.0.0.1:34028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":800,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-17T02:37:19.718671Z","caller":"traceutil/trace.go:171","msg":"trace[1414021003] linearizableReadLoop","detail":"{readStateIndex:5943; appliedIndex:5941; }","duration":"478.558835ms","start":"2026-04-17T02:37:19.240061Z","end":"2026-04-17T02:37:19.71862Z","steps":["trace[1414021003] 'read index received' (duration: 188.893808ms)","trace[1414021003] 'applied index is now lower than readState.Index' (duration: 289.663977ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:19.718827Z","caller":"traceutil/trace.go:171","msg":"trace[1741437190] transaction","detail":"{read_only:false; response_revision:5728; number_of_response:1; }","duration":"486.838108ms","start":"2026-04-17T02:37:19.231974Z","end":"2026-04-17T02:37:19.718812Z","steps":["trace[1741437190] 'process raft request' (duration: 456.770455ms)","trace[1741437190] 'compare' (duration: 29.717672ms)"],"step_count":2} {"level":"warn","ts":"2026-04-17T02:37:19.719073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:19.231945Z","time spent":"486.91401ms","remote":"127.0.0.1:34208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-17T02:37:19.71917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.07624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-17T02:37:19.719244Z","caller":"traceutil/trace.go:171","msg":"trace[1771455584] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:5728; }","duration":"479.199094ms","start":"2026-04-17T02:37:19.240027Z","end":"2026-04-17T02:37:19.719226Z","steps":["trace[1771455584] 'agreement among raft nodes before linearized reading' (duration: 479.04923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:19.719474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-17T02:37:19.239999Z","time spent":"479.459351ms","remote":"127.0.0.1:34118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":31,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-04-17T02:37:20.144969Z","caller":"traceutil/trace.go:171","msg":"trace[48493778] transaction","detail":"{read_only:false; response_revision:5744; number_of_response:1; }","duration":"103.770998ms","start":"2026-04-17T02:37:20.041175Z","end":"2026-04-17T02:37:20.144946Z","steps":["trace[48493778] 'process raft request' (duration: 92.307011ms)","trace[48493778] 'compare' (duration: 11.339203ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:20.148307Z","caller":"traceutil/trace.go:171","msg":"trace[1371482981] linearizableReadLoop","detail":"{readStateIndex:5965; appliedIndex:5959; }","duration":"104.614113ms","start":"2026-04-17T02:37:20.043664Z","end":"2026-04-17T02:37:20.148278Z","steps":["trace[1371482981] 'read index received' (duration: 89.831308ms)","trace[1371482981] 'applied index is now lower than readState.Index' (duration: 14.782025ms)"],"step_count":2} {"level":"info","ts":"2026-04-17T02:37:20.148473Z","caller":"traceutil/trace.go:171","msg":"trace[1303596244] transaction","detail":"{read_only:false; response_revision:5745; number_of_response:1; }","duration":"107.151718ms","start":"2026-04-17T02:37:20.041308Z","end":"2026-04-17T02:37:20.14846Z","steps":["trace[1303596244] 'process raft request' (duration: 106.499759ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:20.148789Z","caller":"traceutil/trace.go:171","msg":"trace[437877665] transaction","detail":"{read_only:false; response_revision:5746; number_of_response:1; }","duration":"107.403234ms","start":"2026-04-17T02:37:20.04137Z","end":"2026-04-17T02:37:20.148773Z","steps":["trace[437877665] 'process raft request' (duration: 106.669363ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:20.149198Z","caller":"traceutil/trace.go:171","msg":"trace[1489139451] transaction","detail":"{read_only:false; response_revision:5747; number_of_response:1; }","duration":"107.812196ms","start":"2026-04-17T02:37:20.041373Z","end":"2026-04-17T02:37:20.149185Z","steps":["trace[1489139451] 'process raft request' (duration: 106.718074ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:20.149573Z","caller":"traceutil/trace.go:171","msg":"trace[217532418] transaction","detail":"{read_only:false; response_revision:5748; number_of_response:1; }","duration":"107.373883ms","start":"2026-04-17T02:37:20.042184Z","end":"2026-04-17T02:37:20.149558Z","steps":["trace[217532418] 'process raft request' (duration: 105.940401ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:37:20.149893Z","caller":"traceutil/trace.go:171","msg":"trace[146036784] transaction","detail":"{read_only:false; response_revision:5749; number_of_response:1; }","duration":"107.627591ms","start":"2026-04-17T02:37:20.042251Z","end":"2026-04-17T02:37:20.149879Z","steps":["trace[146036784] 'process raft request' (duration: 105.916561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-17T02:37:20.150664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.977882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-17T02:37:20.150721Z","caller":"traceutil/trace.go:171","msg":"trace[403109748] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5750; }","duration":"107.056125ms","start":"2026-04-17T02:37:20.043651Z","end":"2026-04-17T02:37:20.150708Z","steps":["trace[403109748] 'agreement among raft nodes before linearized reading' (duration: 106.89606ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:39:20.105113Z","caller":"traceutil/trace.go:171","msg":"trace[1071185380] transaction","detail":"{read_only:false; response_revision:6624; number_of_response:1; }","duration":"130.989562ms","start":"2026-04-17T02:39:19.974104Z","end":"2026-04-17T02:39:20.105094Z","steps":["trace[1071185380] 'process raft request' (duration: 130.842628ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:39:41.084348Z","caller":"traceutil/trace.go:171","msg":"trace[1185558208] transaction","detail":"{read_only:false; response_revision:6789; number_of_response:1; }","duration":"111.464968ms","start":"2026-04-17T02:39:40.972842Z","end":"2026-04-17T02:39:41.084306Z","steps":["trace[1185558208] 'process raft request' (duration: 111.224102ms)"],"step_count":1} {"level":"info","ts":"2026-04-17T02:39:51.343866Z","caller":"traceutil/trace.go:171","msg":"trace[1328615076] transaction","detail":"{read_only:false; response_revision:6841; number_of_response:1; }","duration":"126.456211ms","start":"2026-04-17T02:39:51.217383Z","end":"2026-04-17T02:39:51.34384Z","steps":["trace[1328615076] 'process raft request' (duration: 66.28281ms)","trace[1328615076] 'compare' (duration: 60.065268ms)"],"step_count":2}