{"level":"warn","ts":"2026-04-27T19:36:57.7559Z","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-27T19:36:57.755991Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.231: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.231:2380","--initial-cluster=instance=https://199.19.213.231:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.231:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.231: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-27T19:36:57.756055Z","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-27T19:36:57.756067Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.231:2380"]} {"level":"info","ts":"2026-04-27T19:36:57.756092Z","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-27T19:36:57.756874Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"]} {"level":"info","ts":"2026-04-27T19:36:57.756946Z","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.231:2380"],"listen-peer-urls":["https://199.19.213.231:2380"],"advertise-client-urls":["https://199.19.213.231:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.231: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-27T19:36:57.76545Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.312557ms"} {"level":"info","ts":"2026-04-27T19:36:57.778377Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8bb149ac537fafcb","cluster-id":"6a60f8f1d4e49112"} {"level":"info","ts":"2026-04-27T19:36:57.778842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T19:36:57.778908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became follower at term 0"} {"level":"info","ts":"2026-04-27T19:36:57.778917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8bb149ac537fafcb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T19:36:57.778927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became follower at term 1"} {"level":"info","ts":"2026-04-27T19:36:57.77896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=(10065907646633848779)"} {"level":"warn","ts":"2026-04-27T19:36:57.791592Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T19:36:57.793434Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T19:36:57.79538Z","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-27T19:36:57.801008Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8bb149ac537fafcb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T19:36:57.804753Z","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-27T19:36:57.804746Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8bb149ac537fafcb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T19:36:57.804868Z","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-27T19:36:57.805068Z","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-27T19:36:57.805986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb switched to configuration voters=(10065907646633848779)"} {"level":"info","ts":"2026-04-27T19:36:57.806114Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6a60f8f1d4e49112","local-member-id":"8bb149ac537fafcb","added-peer-id":"8bb149ac537fafcb","added-peer-peer-urls":["https://199.19.213.231:2380"]} {"level":"info","ts":"2026-04-27T19:36:57.806382Z","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-27T19:36:57.806477Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.231:2380"} {"level":"info","ts":"2026-04-27T19:36:57.806513Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.231:2380"} {"level":"info","ts":"2026-04-27T19:36:57.806646Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8bb149ac537fafcb","initial-advertise-peer-urls":["https://199.19.213.231:2380"],"listen-peer-urls":["https://199.19.213.231:2380"],"advertise-client-urls":["https://199.19.213.231:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.231:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T19:36:57.80672Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T19:36:57.880371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T19:36:57.88045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T19:36:57.880475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb received MsgPreVoteResp from 8bb149ac537fafcb at term 1"} {"level":"info","ts":"2026-04-27T19:36:57.880494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became candidate at term 2"} {"level":"info","ts":"2026-04-27T19:36:57.880506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb received MsgVoteResp from 8bb149ac537fafcb at term 2"} {"level":"info","ts":"2026-04-27T19:36:57.880522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8bb149ac537fafcb became leader at term 2"} {"level":"info","ts":"2026-04-27T19:36:57.880535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8bb149ac537fafcb elected leader 8bb149ac537fafcb at term 2"} {"level":"info","ts":"2026-04-27T19:36:57.882264Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:36:57.883349Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8bb149ac537fafcb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.231:2379]}","request-path":"/0/members/8bb149ac537fafcb/attributes","cluster-id":"6a60f8f1d4e49112","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T19:36:57.883513Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T19:36:57.8836Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T19:36:57.8841Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6a60f8f1d4e49112","local-member-id":"8bb149ac537fafcb","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:36:57.884245Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:36:57.88429Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T19:36:57.886687Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T19:36:57.886883Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.231:2379"} {"level":"info","ts":"2026-04-27T19:36:57.887016Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T19:36:57.88704Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T19:37:26.130207Z","caller":"traceutil/trace.go:171","msg":"trace[667981224] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"143.80095ms","start":"2026-04-27T19:37:25.986383Z","end":"2026-04-27T19:37:26.130184Z","steps":["trace[667981224] 'process raft request' (duration: 139.266487ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:37:32.340891Z","caller":"traceutil/trace.go:171","msg":"trace[805249111] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"151.974517ms","start":"2026-04-27T19:37:32.18887Z","end":"2026-04-27T19:37:32.340845Z","steps":["trace[805249111] 'read index received' (duration: 150.162707ms)","trace[805249111] 'applied index is now lower than readState.Index' (duration: 1.80873ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:37:32.341218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.31476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T19:37:32.341269Z","caller":"traceutil/trace.go:171","msg":"trace[2113694034] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:576; }","duration":"152.428321ms","start":"2026-04-27T19:37:32.188831Z","end":"2026-04-27T19:37:32.341259Z","steps":["trace[2113694034] 'agreement among raft nodes before linearized reading' (duration: 152.159158ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:37:32.341655Z","caller":"traceutil/trace.go:171","msg":"trace[1231271846] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"164.666024ms","start":"2026-04-27T19:37:32.176979Z","end":"2026-04-27T19:37:32.341645Z","steps":["trace[1231271846] 'process raft request' (duration: 161.836974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:37:32.779419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.095176ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:37:32.779681Z","caller":"traceutil/trace.go:171","msg":"trace[1387303081] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"433.045202ms","start":"2026-04-27T19:37:32.346612Z","end":"2026-04-27T19:37:32.779657Z","steps":["trace[1387303081] 'process raft request' (duration: 432.92934ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:37:32.779817Z","caller":"traceutil/trace.go:171","msg":"trace[779625165] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"556.162235ms","start":"2026-04-27T19:37:32.223584Z","end":"2026-04-27T19:37:32.779746Z","steps":["trace[779625165] 'process raft request' (duration: 428.254249ms)","trace[779625165] 'compare' (duration: 125.896704ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:37:32.780097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:37:32.223553Z","time spent":"556.498969ms","remote":"127.0.0.1:57992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-27T19:37:32.780217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:37:32.346587Z","time spent":"433.152033ms","remote":"127.0.0.1:57764","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-04-27T19:37:33.309434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.538664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T19:37:33.3096Z","caller":"traceutil/trace.go:171","msg":"trace[1087249717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"180.755476ms","start":"2026-04-27T19:37:33.128803Z","end":"2026-04-27T19:37:33.309558Z","steps":["trace[1087249717] 'range keys from in-memory index tree' (duration: 180.446093ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:37:33.372024Z","caller":"traceutil/trace.go:171","msg":"trace[1070486057] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"179.557913ms","start":"2026-04-27T19:37:33.192425Z","end":"2026-04-27T19:37:33.371983Z","steps":["trace[1070486057] 'process raft request' (duration: 178.614793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:38:16.66863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.723478ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-27T19:38:16.66884Z","caller":"traceutil/trace.go:171","msg":"trace[1500720039] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1174; }","duration":"222.32629ms","start":"2026-04-27T19:38:16.446502Z","end":"2026-04-27T19:38:16.668829Z","steps":["trace[1500720039] 'read index received' (duration: 16.362949ms)","trace[1500720039] 'applied index is now lower than readState.Index' (duration: 205.962101ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:38:16.669074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.556572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T19:38:16.669163Z","caller":"traceutil/trace.go:171","msg":"trace[1645248064] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1135; }","duration":"222.698043ms","start":"2026-04-27T19:38:16.446445Z","end":"2026-04-27T19:38:16.669143Z","steps":["trace[1645248064] 'agreement among raft nodes before linearized reading' (duration: 222.445241ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:38:30.861974Z","caller":"traceutil/trace.go:171","msg":"trace[2100966436] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"103.993956ms","start":"2026-04-27T19:38:30.757954Z","end":"2026-04-27T19:38:30.861948Z","steps":["trace[2100966436] 'process raft request' (duration: 103.847031ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:38:36.03688Z","caller":"traceutil/trace.go:171","msg":"trace[1965837312] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"126.103123ms","start":"2026-04-27T19:38:35.910747Z","end":"2026-04-27T19:38:36.03685Z","steps":["trace[1965837312] 'process raft request' (duration: 36.663222ms)","trace[1965837312] 'compare' (duration: 89.305907ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:38:36.040376Z","caller":"traceutil/trace.go:171","msg":"trace[1651392108] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"128.675931ms","start":"2026-04-27T19:38:35.911681Z","end":"2026-04-27T19:38:36.040357Z","steps":["trace[1651392108] 'process raft request' (duration: 128.477255ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:38:36.040427Z","caller":"traceutil/trace.go:171","msg":"trace[2013647104] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"128.610119ms","start":"2026-04-27T19:38:35.911771Z","end":"2026-04-27T19:38:36.040381Z","steps":["trace[2013647104] 'process raft request' (duration: 128.475055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:38:36.41715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.723931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-6dnt8\" ","response":"range_response_count:1 size:6053"} {"level":"info","ts":"2026-04-27T19:38:36.417231Z","caller":"traceutil/trace.go:171","msg":"trace[1102200717] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-controller-6dnt8; range_end:; response_count:1; response_revision:1347; }","duration":"180.859955ms","start":"2026-04-27T19:38:36.236345Z","end":"2026-04-27T19:38:36.417205Z","steps":["trace[1102200717] 'agreement among raft nodes before linearized reading' (duration: 90.511225ms)","trace[1102200717] 'range keys from in-memory index tree' (duration: 90.093202ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:38:36.417828Z","caller":"traceutil/trace.go:171","msg":"trace[1098206983] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"148.899538ms","start":"2026-04-27T19:38:36.268911Z","end":"2026-04-27T19:38:36.417811Z","steps":["trace[1098206983] 'process raft request' (duration: 79.810128ms)","trace[1098206983] 'compare' (duration: 68.590275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:38:36.41817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.75352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/ingress-nginx/ingress-nginx-defaultbackend\" ","response":"range_response_count:1 size:4121"} {"level":"info","ts":"2026-04-27T19:38:36.419259Z","caller":"traceutil/trace.go:171","msg":"trace[799127878] range","detail":"{range_begin:/registry/deployments/ingress-nginx/ingress-nginx-defaultbackend; range_end:; response_count:1; response_revision:1349; }","duration":"179.868395ms","start":"2026-04-27T19:38:36.239363Z","end":"2026-04-27T19:38:36.419231Z","steps":["trace[799127878] 'agreement among raft nodes before linearized reading' (duration: 178.597266ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:38:37.410963Z","caller":"traceutil/trace.go:171","msg":"trace[1985255181] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"109.014135ms","start":"2026-04-27T19:38:37.301915Z","end":"2026-04-27T19:38:37.41093Z","steps":["trace[1985255181] 'process raft request' (duration: 107.246862ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:39:04.689034Z","caller":"traceutil/trace.go:171","msg":"trace[958756277] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"206.121188ms","start":"2026-04-27T19:39:04.482883Z","end":"2026-04-27T19:39:04.689004Z","steps":["trace[958756277] 'process raft request' (duration: 192.084001ms)","trace[958756277] 'compare' (duration: 13.330451ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:39:04.689544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.372272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8fda889f-f267-4b6a-95d4-dd3bac46f95f\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-27T19:39:04.68964Z","caller":"traceutil/trace.go:171","msg":"trace[19908335] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8fda889f-f267-4b6a-95d4-dd3bac46f95f; range_end:; response_count:1; response_revision:1820; }","duration":"100.526705ms","start":"2026-04-27T19:39:04.589087Z","end":"2026-04-27T19:39:04.689614Z","steps":["trace[19908335] 'agreement among raft nodes before linearized reading' (duration: 99.856599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:04.931421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.745737ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:39:04.931844Z","caller":"traceutil/trace.go:171","msg":"trace[688684307] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"137.162709ms","start":"2026-04-27T19:39:04.794649Z","end":"2026-04-27T19:39:04.931812Z","steps":["trace[688684307] 'process raft request' (duration: 136.899133ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:39:04.932052Z","caller":"traceutil/trace.go:171","msg":"trace[1032077763] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"111.47956ms","start":"2026-04-27T19:39:04.820553Z","end":"2026-04-27T19:39:04.932032Z","steps":["trace[1032077763] 'process raft request' (duration: 111.102232ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:39:04.932059Z","caller":"traceutil/trace.go:171","msg":"trace[1492179955] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"235.219496ms","start":"2026-04-27T19:39:04.696811Z","end":"2026-04-27T19:39:04.932031Z","steps":["trace[1492179955] 'process raft request' (duration: 110.756203ms)","trace[1492179955] 'compare' (duration: 123.491481ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:39:17.134614Z","caller":"traceutil/trace.go:171","msg":"trace[183707774] linearizableReadLoop","detail":"{readStateIndex:2017; appliedIndex:2016; }","duration":"115.644019ms","start":"2026-04-27T19:39:17.018934Z","end":"2026-04-27T19:39:17.134578Z","steps":["trace[183707774] 'read index received' (duration: 115.373143ms)","trace[183707774] 'applied index is now lower than readState.Index' (duration: 269.746µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:39:17.134678Z","caller":"traceutil/trace.go:171","msg":"trace[166715259] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"145.756171ms","start":"2026-04-27T19:39:16.988898Z","end":"2026-04-27T19:39:17.134654Z","steps":["trace[166715259] 'process raft request' (duration: 145.519956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:17.134864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.910414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-27T19:39:17.134909Z","caller":"traceutil/trace.go:171","msg":"trace[140897816] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1932; }","duration":"115.995546ms","start":"2026-04-27T19:39:17.018902Z","end":"2026-04-27T19:39:17.134898Z","steps":["trace[140897816] 'agreement among raft nodes before linearized reading' (duration: 115.834413ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:39:38.011954Z","caller":"traceutil/trace.go:171","msg":"trace[327451680] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"166.28561ms","start":"2026-04-27T19:39:37.845644Z","end":"2026-04-27T19:39:38.011929Z","steps":["trace[327451680] 'process raft request' (duration: 166.141127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:39:38.956172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.145907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-27T19:39:38.956241Z","caller":"traceutil/trace.go:171","msg":"trace[1090707640] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2064; }","duration":"205.27173ms","start":"2026-04-27T19:39:38.750952Z","end":"2026-04-27T19:39:38.956224Z","steps":["trace[1090707640] 'count revisions from in-memory index tree' (duration: 205.060556ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:39:39.227039Z","caller":"traceutil/trace.go:171","msg":"trace[530925351] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"223.641473ms","start":"2026-04-27T19:39:39.003368Z","end":"2026-04-27T19:39:39.22701Z","steps":["trace[530925351] 'process raft request' (duration: 223.47916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:40:42.79012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.91793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-27T19:40:42.790189Z","caller":"traceutil/trace.go:171","msg":"trace[397101718] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2514; }","duration":"111.034732ms","start":"2026-04-27T19:40:42.679142Z","end":"2026-04-27T19:40:42.790177Z","steps":["trace[397101718] 'range keys from in-memory index tree' (duration: 110.749858ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:17.800237Z","caller":"traceutil/trace.go:171","msg":"trace[1902475057] linearizableReadLoop","detail":"{readStateIndex:2816; appliedIndex:2815; }","duration":"115.573016ms","start":"2026-04-27T19:41:17.684632Z","end":"2026-04-27T19:41:17.800205Z","steps":["trace[1902475057] 'read index received' (duration: 115.445044ms)","trace[1902475057] 'applied index is now lower than readState.Index' (duration: 126.531µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:41:17.800385Z","caller":"traceutil/trace.go:171","msg":"trace[1301219196] transaction","detail":"{read_only:false; response_revision:2704; number_of_response:1; }","duration":"183.635337ms","start":"2026-04-27T19:41:17.616739Z","end":"2026-04-27T19:41:17.800374Z","steps":["trace[1301219196] 'process raft request' (duration: 183.287712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:41:17.8007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.039161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T19:41:17.800842Z","caller":"traceutil/trace.go:171","msg":"trace[1388173197] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2704; }","duration":"116.263234ms","start":"2026-04-27T19:41:17.684554Z","end":"2026-04-27T19:41:17.800818Z","steps":["trace[1388173197] 'agreement among raft nodes before linearized reading' (duration: 115.94361ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:17.988007Z","caller":"traceutil/trace.go:171","msg":"trace[1409736992] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"182.824096ms","start":"2026-04-27T19:41:17.805157Z","end":"2026-04-27T19:41:17.987981Z","steps":["trace[1409736992] 'process raft request' (duration: 174.533748ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:41:17.988748Z","caller":"traceutil/trace.go:171","msg":"trace[282650116] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"183.141489ms","start":"2026-04-27T19:41:17.805364Z","end":"2026-04-27T19:41:17.988505Z","steps":["trace[282650116] 'process raft request' (duration: 182.565623ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:44:55.434913Z","caller":"traceutil/trace.go:171","msg":"trace[658781460] transaction","detail":"{read_only:false; response_revision:4392; number_of_response:1; }","duration":"150.062763ms","start":"2026-04-27T19:44:55.284825Z","end":"2026-04-27T19:44:55.434888Z","steps":["trace[658781460] 'process raft request' (duration: 108.618476ms)","trace[658781460] 'compare' (duration: 40.858352ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:44:55.438006Z","caller":"traceutil/trace.go:171","msg":"trace[1747109485] linearizableReadLoop","detail":"{readStateIndex:4574; appliedIndex:4570; }","duration":"110.882516ms","start":"2026-04-27T19:44:55.327099Z","end":"2026-04-27T19:44:55.437981Z","steps":["trace[1747109485] 'read index received' (duration: 66.314326ms)","trace[1747109485] 'applied index is now lower than readState.Index' (duration: 44.56666ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:44:55.438315Z","caller":"traceutil/trace.go:171","msg":"trace[843947020] transaction","detail":"{read_only:false; response_revision:4393; number_of_response:1; }","duration":"142.448631ms","start":"2026-04-27T19:44:55.295846Z","end":"2026-04-27T19:44:55.438295Z","steps":["trace[843947020] 'process raft request' (duration: 141.769603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:44:55.438482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.349638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"warn","ts":"2026-04-27T19:44:55.438489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.325005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-27T19:44:55.438525Z","caller":"traceutil/trace.go:171","msg":"trace[1756534117] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4397; }","duration":"111.42373ms","start":"2026-04-27T19:44:55.327091Z","end":"2026-04-27T19:44:55.438515Z","steps":["trace[1756534117] 'agreement among raft nodes before linearized reading' (duration: 111.132722ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:44:55.438634Z","caller":"traceutil/trace.go:171","msg":"trace[1638531814] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4397; }","duration":"106.50371ms","start":"2026-04-27T19:44:55.332102Z","end":"2026-04-27T19:44:55.438606Z","steps":["trace[1638531814] 'agreement among raft nodes before linearized reading' (duration: 106.216153ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:44:55.439066Z","caller":"traceutil/trace.go:171","msg":"trace[2013428208] transaction","detail":"{read_only:false; response_revision:4394; number_of_response:1; }","duration":"133.570127ms","start":"2026-04-27T19:44:55.305482Z","end":"2026-04-27T19:44:55.439052Z","steps":["trace[2013428208] 'process raft request' (duration: 132.247282ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:44:55.43939Z","caller":"traceutil/trace.go:171","msg":"trace[1963872800] transaction","detail":"{read_only:false; response_revision:4395; number_of_response:1; }","duration":"133.891986ms","start":"2026-04-27T19:44:55.305481Z","end":"2026-04-27T19:44:55.439373Z","steps":["trace[1963872800] 'process raft request' (duration: 132.292553ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:45:01.025708Z","caller":"traceutil/trace.go:171","msg":"trace[1684639044] linearizableReadLoop","detail":"{readStateIndex:4745; appliedIndex:4744; }","duration":"114.548629ms","start":"2026-04-27T19:45:00.911134Z","end":"2026-04-27T19:45:01.025682Z","steps":["trace[1684639044] 'read index received' (duration: 114.251271ms)","trace[1684639044] 'applied index is now lower than readState.Index' (duration: 296.008µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:45:01.025845Z","caller":"traceutil/trace.go:171","msg":"trace[706419287] transaction","detail":"{read_only:false; response_revision:4561; number_of_response:1; }","duration":"117.861195ms","start":"2026-04-27T19:45:00.907863Z","end":"2026-04-27T19:45:01.025725Z","steps":["trace[706419287] 'process raft request' (duration: 117.608739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:01.025906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.747714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:1229"} {"level":"info","ts":"2026-04-27T19:45:01.02625Z","caller":"traceutil/trace.go:171","msg":"trace[107422460] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4561; }","duration":"115.113534ms","start":"2026-04-27T19:45:00.911085Z","end":"2026-04-27T19:45:01.026199Z","steps":["trace[107422460] 'agreement among raft nodes before linearized reading' (duration: 114.693143ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:45:06.866356Z","caller":"traceutil/trace.go:171","msg":"trace[605201278] transaction","detail":"{read_only:false; response_revision:4669; number_of_response:1; }","duration":"466.076629ms","start":"2026-04-27T19:45:06.400247Z","end":"2026-04-27T19:45:06.866324Z","steps":["trace[605201278] 'process raft request' (duration: 465.868213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:06.866727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:45:06.400201Z","time spent":"466.254073ms","remote":"127.0.0.1:57698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11833,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T19:45:06.975862Z","caller":"traceutil/trace.go:171","msg":"trace[804433343] transaction","detail":"{read_only:false; response_revision:4670; number_of_response:1; }","duration":"284.171748ms","start":"2026-04-27T19:45:06.691663Z","end":"2026-04-27T19:45:06.975835Z","steps":["trace[804433343] 'process raft request' (duration: 283.924612ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:45:06.975897Z","caller":"traceutil/trace.go:171","msg":"trace[192385591] linearizableReadLoop","detail":"{readStateIndex:4855; appliedIndex:4853; }","duration":"455.625592ms","start":"2026-04-27T19:45:06.520243Z","end":"2026-04-27T19:45:06.975868Z","steps":["trace[192385591] 'read index received' (duration: 345.871012ms)","trace[192385591] 'applied index is now lower than readState.Index' (duration: 109.75266ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:45:06.97684Z","caller":"traceutil/trace.go:171","msg":"trace[1688170765] transaction","detail":"{read_only:false; response_revision:4671; number_of_response:1; }","duration":"105.157542ms","start":"2026-04-27T19:45:06.871669Z","end":"2026-04-27T19:45:06.976827Z","steps":["trace[1688170765] 'process raft request' (duration: 104.054014ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:06.977053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.801232ms","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-27T19:45:06.977104Z","caller":"traceutil/trace.go:171","msg":"trace[2133954241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4672; }","duration":"456.907835ms","start":"2026-04-27T19:45:06.520183Z","end":"2026-04-27T19:45:06.977091Z","steps":["trace[2133954241] 'agreement among raft nodes before linearized reading' (duration: 455.807837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:06.977094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.944715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8884bb8b-2316-4ef4-97c5-cb16724577d7\" ","response":"range_response_count:1 size:3646"} {"level":"warn","ts":"2026-04-27T19:45:06.97714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:45:06.520163Z","time spent":"456.967066ms","remote":"127.0.0.1:57764","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-04-27T19:45:06.977117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.738127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8884bb8b-2316-4ef4-97c5-cb16724577d7\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-27T19:45:06.977153Z","caller":"traceutil/trace.go:171","msg":"trace[588107457] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8884bb8b-2316-4ef4-97c5-cb16724577d7; range_end:; response_count:1; response_revision:4672; }","duration":"397.071168ms","start":"2026-04-27T19:45:06.580067Z","end":"2026-04-27T19:45:06.977138Z","steps":["trace[588107457] 'agreement among raft nodes before linearized reading' (duration: 396.873593ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:45:06.977178Z","caller":"traceutil/trace.go:171","msg":"trace[452128699] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8884bb8b-2316-4ef4-97c5-cb16724577d7; range_end:; response_count:1; response_revision:4672; }","duration":"105.8557ms","start":"2026-04-27T19:45:06.871311Z","end":"2026-04-27T19:45:06.977167Z","steps":["trace[452128699] 'agreement among raft nodes before linearized reading' (duration: 105.746097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:06.97719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T19:45:06.580045Z","time spent":"397.13692ms","remote":"127.0.0.1:57698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8884bb8b-2316-4ef4-97c5-cb16724577d7\" "} {"level":"info","ts":"2026-04-27T19:45:06.977306Z","caller":"traceutil/trace.go:171","msg":"trace[767280594] transaction","detail":"{read_only:false; response_revision:4672; number_of_response:1; }","duration":"103.069069ms","start":"2026-04-27T19:45:06.874229Z","end":"2026-04-27T19:45:06.977298Z","steps":["trace[767280594] 'process raft request' (duration: 102.416603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:06.977332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.714241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T19:45:06.97736Z","caller":"traceutil/trace.go:171","msg":"trace[382331425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4672; }","duration":"291.783043ms","start":"2026-04-27T19:45:06.685568Z","end":"2026-04-27T19:45:06.977351Z","steps":["trace[382331425] 'agreement among raft nodes before linearized reading' (duration: 291.69986ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:45:07.087229Z","caller":"traceutil/trace.go:171","msg":"trace[1226900520] transaction","detail":"{read_only:false; response_revision:4674; number_of_response:1; }","duration":"102.308983ms","start":"2026-04-27T19:45:06.984888Z","end":"2026-04-27T19:45:07.087197Z","steps":["trace[1226900520] 'process raft request' (duration: 83.532356ms)","trace[1226900520] 'compare' (duration: 18.564582ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:45:07.087421Z","caller":"traceutil/trace.go:171","msg":"trace[1135157680] transaction","detail":"{read_only:false; response_revision:4675; number_of_response:1; }","duration":"101.958034ms","start":"2026-04-27T19:45:06.985429Z","end":"2026-04-27T19:45:07.087387Z","steps":["trace[1135157680] 'process raft request' (duration: 101.658676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:07.371014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.488853ms","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-04-27T19:45:07.371074Z","caller":"traceutil/trace.go:171","msg":"trace[1985867222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4676; }","duration":"120.590626ms","start":"2026-04-27T19:45:07.250469Z","end":"2026-04-27T19:45:07.371059Z","steps":["trace[1985867222] 'range keys from in-memory index tree' (duration: 120.36034ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:45:10.539654Z","caller":"traceutil/trace.go:171","msg":"trace[534769645] transaction","detail":"{read_only:false; response_revision:4722; number_of_response:1; }","duration":"126.71681ms","start":"2026-04-27T19:45:10.412898Z","end":"2026-04-27T19:45:10.539615Z","steps":["trace[534769645] 'process raft request' (duration: 126.518995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:11.814374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.854971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T19:45:11.814635Z","caller":"traceutil/trace.go:171","msg":"trace[689578285] linearizableReadLoop","detail":"{readStateIndex:4930; appliedIndex:4928; }","duration":"179.141326ms","start":"2026-04-27T19:45:11.635468Z","end":"2026-04-27T19:45:11.814609Z","steps":["trace[689578285] 'read index received' (duration: 73.822423ms)","trace[689578285] 'applied index is now lower than readState.Index' (duration: 105.317483ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:45:11.814676Z","caller":"traceutil/trace.go:171","msg":"trace[971718168] transaction","detail":"{read_only:false; response_revision:4742; number_of_response:1; }","duration":"180.771397ms","start":"2026-04-27T19:45:11.633889Z","end":"2026-04-27T19:45:11.81466Z","steps":["trace[971718168] 'process raft request' (duration: 180.620633ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:45:11.814674Z","caller":"traceutil/trace.go:171","msg":"trace[400279211] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"188.45549ms","start":"2026-04-27T19:45:11.626189Z","end":"2026-04-27T19:45:11.814645Z","steps":["trace[400279211] 'process raft request' (duration: 83.205228ms)","trace[400279211] 'compare' (duration: 104.553484ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:45:11.81488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.041732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-27T19:45:11.814909Z","caller":"traceutil/trace.go:171","msg":"trace[685227786] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4742; }","duration":"163.124314ms","start":"2026-04-27T19:45:11.651777Z","end":"2026-04-27T19:45:11.814901Z","steps":["trace[685227786] 'agreement among raft nodes before linearized reading' (duration: 163.016721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:11.815366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.890714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:9224"} {"level":"info","ts":"2026-04-27T19:45:11.815415Z","caller":"traceutil/trace.go:171","msg":"trace[146994276] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4742; }","duration":"179.942056ms","start":"2026-04-27T19:45:11.635462Z","end":"2026-04-27T19:45:11.815404Z","steps":["trace[146994276] 'agreement among raft nodes before linearized reading' (duration: 179.290909ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:45:20.750625Z","caller":"traceutil/trace.go:171","msg":"trace[1402586971] linearizableReadLoop","detail":"{readStateIndex:5048; appliedIndex:5047; }","duration":"195.345485ms","start":"2026-04-27T19:45:20.555247Z","end":"2026-04-27T19:45:20.750593Z","steps":["trace[1402586971] 'read index received' (duration: 129.178411ms)","trace[1402586971] 'applied index is now lower than readState.Index' (duration: 66.165874ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:45:20.750802Z","caller":"traceutil/trace.go:171","msg":"trace[591743362] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"196.626015ms","start":"2026-04-27T19:45:20.554156Z","end":"2026-04-27T19:45:20.750782Z","steps":["trace[591743362] 'process raft request' (duration: 130.209276ms)","trace[591743362] 'compare' (duration: 66.02103ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T19:45:20.751119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.839027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-27T19:45:20.75123Z","caller":"traceutil/trace.go:171","msg":"trace[281678859] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4857; }","duration":"195.98444ms","start":"2026-04-27T19:45:20.55522Z","end":"2026-04-27T19:45:20.751204Z","steps":["trace[281678859] 'agreement among raft nodes before linearized reading' (duration: 195.683272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T19:45:20.751429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.954451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-04-27T19:45:20.751607Z","caller":"traceutil/trace.go:171","msg":"trace[696784172] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4857; }","duration":"194.304069ms","start":"2026-04-27T19:45:20.55728Z","end":"2026-04-27T19:45:20.751584Z","steps":["trace[696784172] 'agreement among raft nodes before linearized reading' (duration: 193.54805ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:46:12.103988Z","caller":"traceutil/trace.go:171","msg":"trace[757595870] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"116.809863ms","start":"2026-04-27T19:46:11.987154Z","end":"2026-04-27T19:46:12.103963Z","steps":["trace[757595870] 'process raft request' (duration: 116.546487ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:46:12.104156Z","caller":"traceutil/trace.go:171","msg":"trace[732815807] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"114.150477ms","start":"2026-04-27T19:46:11.989887Z","end":"2026-04-27T19:46:12.104038Z","steps":["trace[732815807] 'process raft request' (duration: 113.858241ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T19:46:12.104139Z","caller":"traceutil/trace.go:171","msg":"trace[304558561] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"162.997363ms","start":"2026-04-27T19:46:11.941111Z","end":"2026-04-27T19:46:12.104109Z","steps":["trace[304558561] 'process raft request' (duration: 95.096975ms)","trace[304558561] 'compare' (duration: 67.354906ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:46:40.781795Z","caller":"traceutil/trace.go:171","msg":"trace[1666091991] transaction","detail":"{read_only:false; response_revision:5514; number_of_response:1; }","duration":"102.923659ms","start":"2026-04-27T19:46:40.678844Z","end":"2026-04-27T19:46:40.781767Z","steps":["trace[1666091991] 'process raft request' (duration: 86.625874ms)","trace[1666091991] 'compare' (duration: 16.181373ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T19:46:58.312694Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2920} {"level":"info","ts":"2026-04-27T19:46:58.435369Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2920,"took":"121.302263ms","hash":1841400797,"current-db-size-bytes":54386688,"current-db-size":"54 MB","current-db-size-in-use-bytes":29417472,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-27T19:46:58.435511Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1841400797,"revision":2920,"compact-revision":-1} {"level":"info","ts":"2026-04-27T19:51:58.320088Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5637} {"level":"info","ts":"2026-04-27T19:51:58.392745Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5637,"took":"71.449858ms","hash":3298808962,"current-db-size-bytes":54386688,"current-db-size":"54 MB","current-db-size-in-use-bytes":18190336,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-27T19:51:58.392798Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3298808962,"revision":5637,"compact-revision":2920}