{"level":"warn","ts":"2026-05-26T05:41:19.870083Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:41:19.870167Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-26T05:41:19.870231Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-26T05:41:19.870243Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-05-26T05:41:19.87026Z","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-05-26T05:41:19.870842Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-05-26T05:41:19.870914Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-26T05:41:19.874056Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.952116ms"} {"level":"info","ts":"2026-05-26T05:41:19.880721Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-05-26T05:41:19.880799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-05-26T05:41:19.880823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-05-26T05:41:19.880838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-26T05:41:19.880848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-05-26T05:41:19.880889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-05-26T05:41:19.888828Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-26T05:41:19.889932Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-26T05:41:19.89101Z","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-05-26T05:41:19.892867Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-26T05:41:19.893774Z","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-05-26T05:41:19.894904Z","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-05-26T05:41:19.894923Z","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-05-26T05:41:19.89506Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-26T05:41:19.895454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-05-26T05:41:19.895659Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-05-26T05:41:19.897088Z","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-05-26T05:41:19.897282Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-05-26T05:41:19.897371Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-05-26T05:41:19.897388Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-26T05:41:19.897417Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-26T05:41:20.381698Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-05-26T05:41:20.381772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-26T05:41:20.381814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-05-26T05:41:20.381839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-05-26T05:41:20.381856Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-05-26T05:41:20.381877Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-05-26T05:41:20.381896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-05-26T05:41:20.38279Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:41:20.382957Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-05-26T05:41:20.383139Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:41:20.383192Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-26T05:41:20.383604Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:41:20.383713Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:41:20.38374Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-26T05:41:20.384125Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-26T05:41:20.38414Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-26T05:41:20.385494Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-26T05:41:20.386202Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-05-26T05:41:22.764646Z","caller":"traceutil/trace.go:171","msg":"trace[921638561] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"146.412807ms","start":"2026-05-26T05:41:22.618204Z","end":"2026-05-26T05:41:22.764617Z","steps":["trace[921638561] 'read index received' (duration: 146.131754ms)","trace[921638561] 'applied index is now lower than readState.Index' (duration: 280.123µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:41:22.764788Z","caller":"traceutil/trace.go:171","msg":"trace[1008589066] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"148.520795ms","start":"2026-05-26T05:41:22.616218Z","end":"2026-05-26T05:41:22.764739Z","steps":["trace[1008589066] 'process raft request' (duration: 148.209742ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:22.765955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.753839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:41:22.766146Z","caller":"traceutil/trace.go:171","msg":"trace[1118874036] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:71; }","duration":"147.93034ms","start":"2026-05-26T05:41:22.618171Z","end":"2026-05-26T05:41:22.766102Z","steps":["trace[1118874036] 'agreement among raft nodes before linearized reading' (duration: 146.605758ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:22.890897Z","caller":"traceutil/trace.go:171","msg":"trace[142267377] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"115.135146ms","start":"2026-05-26T05:41:22.775746Z","end":"2026-05-26T05:41:22.890881Z","steps":["trace[142267377] 'process raft request' (duration: 114.573291ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:22.891149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.373988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-26T05:41:22.891209Z","caller":"traceutil/trace.go:171","msg":"trace[1275170141] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:72; }","duration":"115.459019ms","start":"2026-05-26T05:41:22.77573Z","end":"2026-05-26T05:41:22.891189Z","steps":["trace[1275170141] 'agreement among raft nodes before linearized reading' (duration: 115.332307ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:22.891013Z","caller":"traceutil/trace.go:171","msg":"trace[1112961809] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"115.041825ms","start":"2026-05-26T05:41:22.775761Z","end":"2026-05-26T05:41:22.890803Z","steps":["trace[1112961809] 'read index received' (duration: 114.582101ms)","trace[1112961809] 'applied index is now lower than readState.Index' (duration: 458.504µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:41:56.47139Z","caller":"traceutil/trace.go:171","msg":"trace[1543668237] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"104.277874ms","start":"2026-05-26T05:41:56.367091Z","end":"2026-05-26T05:41:56.471369Z","steps":["trace[1543668237] 'process raft request' (duration: 100.033981ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:56.570424Z","caller":"traceutil/trace.go:171","msg":"trace[861796540] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:549; }","duration":"115.964687ms","start":"2026-05-26T05:41:56.454433Z","end":"2026-05-26T05:41:56.570397Z","steps":["trace[861796540] 'read index received' (duration: 12.683169ms)","trace[861796540] 'applied index is now lower than readState.Index' (duration: 103.280548ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:41:56.570512Z","caller":"traceutil/trace.go:171","msg":"trace[2123887524] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"197.905175ms","start":"2026-05-26T05:41:56.372582Z","end":"2026-05-26T05:41:56.570487Z","steps":["trace[2123887524] 'process raft request' (duration: 197.334389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:41:56.570658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.209314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:41:56.570702Z","caller":"traceutil/trace.go:171","msg":"trace[1435645364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:528; }","duration":"116.306496ms","start":"2026-05-26T05:41:56.454382Z","end":"2026-05-26T05:41:56.570688Z","steps":["trace[1435645364] 'agreement among raft nodes before linearized reading' (duration: 116.210604ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:41:56.571522Z","caller":"traceutil/trace.go:171","msg":"trace[1248925555] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"197.483473ms","start":"2026-05-26T05:41:56.374021Z","end":"2026-05-26T05:41:56.571504Z","steps":["trace[1248925555] 'process raft request' (duration: 196.22224ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:00.299859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.204829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:42:00.299983Z","caller":"traceutil/trace.go:171","msg":"trace[893356747] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:597; }","duration":"289.217123ms","start":"2026-05-26T05:42:00.01074Z","end":"2026-05-26T05:42:00.299957Z","steps":["trace[893356747] 'read index received' (duration: 168.365497ms)","trace[893356747] 'applied index is now lower than readState.Index' (duration: 120.850456ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:42:00.30004Z","caller":"traceutil/trace.go:171","msg":"trace[1946857650] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"289.400147ms","start":"2026-05-26T05:42:00.01061Z","end":"2026-05-26T05:42:00.30001Z","steps":["trace[1946857650] 'process raft request' (duration: 168.568692ms)","trace[1946857650] 'compare' (duration: 119.924992ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:42:00.300213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.451689ms","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-05-26T05:42:00.300312Z","caller":"traceutil/trace.go:171","msg":"trace[1713000208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"289.568602ms","start":"2026-05-26T05:42:00.010711Z","end":"2026-05-26T05:42:00.300279Z","steps":["trace[1713000208] 'agreement among raft nodes before linearized reading' (duration: 289.328836ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:03.204261Z","caller":"traceutil/trace.go:171","msg":"trace[1340861847] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"514.733367ms","start":"2026-05-26T05:42:02.689499Z","end":"2026-05-26T05:42:03.204232Z","steps":["trace[1340861847] 'process raft request' (duration: 514.575893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:03.204695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:02.689477Z","time spent":"514.866289ms","remote":"127.0.0.1:44866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:42:03.254761Z","caller":"traceutil/trace.go:171","msg":"trace[940346230] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"558.605091ms","start":"2026-05-26T05:42:02.695028Z","end":"2026-05-26T05:42:03.253633Z","steps":["trace[940346230] 'process raft request' (duration: 557.964025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:03.255004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:42:02.695008Z","time spent":"559.902824ms","remote":"127.0.0.1:44774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:42:03.587101Z","caller":"traceutil/trace.go:171","msg":"trace[2045941927] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"130.621583ms","start":"2026-05-26T05:42:03.456455Z","end":"2026-05-26T05:42:03.587077Z","steps":["trace[2045941927] 'read index received' (duration: 129.715241ms)","trace[2045941927] 'applied index is now lower than readState.Index' (duration: 905.132µs)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:42:03.587239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.766467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:42:03.587269Z","caller":"traceutil/trace.go:171","msg":"trace[956951390] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"130.87288ms","start":"2026-05-26T05:42:03.456387Z","end":"2026-05-26T05:42:03.58726Z","steps":["trace[956951390] 'agreement among raft nodes before linearized reading' (duration: 130.781378ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:42:03.58721Z","caller":"traceutil/trace.go:171","msg":"trace[1346421376] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"266.400127ms","start":"2026-05-26T05:42:03.320772Z","end":"2026-05-26T05:42:03.587172Z","steps":["trace[1346421376] 'process raft request' (duration: 265.562416ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:42:28.018274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.047329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jgtsx\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-05-26T05:42:28.01836Z","caller":"traceutil/trace.go:171","msg":"trace[1665765669] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jgtsx; range_end:; response_count:1; response_revision:784; }","duration":"191.186914ms","start":"2026-05-26T05:42:27.827157Z","end":"2026-05-26T05:42:28.018344Z","steps":["trace[1665765669] 'range keys from in-memory index tree' (duration: 190.831255ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:44.778359Z","caller":"traceutil/trace.go:171","msg":"trace[1027430341] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1924; }","duration":"174.169209ms","start":"2026-05-26T05:43:44.604162Z","end":"2026-05-26T05:43:44.778331Z","steps":["trace[1027430341] 'read index received' (duration: 174.035357ms)","trace[1027430341] 'applied index is now lower than readState.Index' (duration: 132.582µs)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:43:44.778446Z","caller":"traceutil/trace.go:171","msg":"trace[525829588] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"195.586183ms","start":"2026-05-26T05:43:44.582837Z","end":"2026-05-26T05:43:44.778424Z","steps":["trace[525829588] 'process raft request' (duration: 195.324559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:43:44.778611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.425042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-251b8286-0234-4615-8f14-b38d67bba21e\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-05-26T05:43:44.778655Z","caller":"traceutil/trace.go:171","msg":"trace[1508324018] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-251b8286-0234-4615-8f14-b38d67bba21e; range_end:; response_count:1; response_revision:1847; }","duration":"174.512044ms","start":"2026-05-26T05:43:44.604129Z","end":"2026-05-26T05:43:44.778641Z","steps":["trace[1508324018] 'agreement among raft nodes before linearized reading' (duration: 174.327342ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:43:44.784845Z","caller":"traceutil/trace.go:171","msg":"trace[1859977212] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"140.440029ms","start":"2026-05-26T05:43:44.644379Z","end":"2026-05-26T05:43:44.784819Z","steps":["trace[1859977212] 'process raft request' (duration: 140.336368ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:44:19.228118Z","caller":"traceutil/trace.go:171","msg":"trace[620375616] linearizableReadLoop","detail":"{readStateIndex:2168; appliedIndex:2167; }","duration":"140.842956ms","start":"2026-05-26T05:44:19.087253Z","end":"2026-05-26T05:44:19.228096Z","steps":["trace[620375616] 'read index received' (duration: 130.019986ms)","trace[620375616] 'applied index is now lower than readState.Index' (duration: 10.82192ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:44:19.22815Z","caller":"traceutil/trace.go:171","msg":"trace[822244767] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"231.113824ms","start":"2026-05-26T05:44:18.996985Z","end":"2026-05-26T05:44:19.228098Z","steps":["trace[822244767] 'process raft request' (duration: 220.209912ms)","trace[822244767] 'compare' (duration: 10.565898ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:44:19.230472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.198515ms","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-05-26T05:44:19.230557Z","caller":"traceutil/trace.go:171","msg":"trace[9449873] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2084; }","duration":"143.321726ms","start":"2026-05-26T05:44:19.087212Z","end":"2026-05-26T05:44:19.230534Z","steps":["trace[9449873] 'agreement among raft nodes before linearized reading' (duration: 141.027208ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:45:55.843249Z","caller":"traceutil/trace.go:171","msg":"trace[2052323988] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"125.281051ms","start":"2026-05-26T05:45:55.717924Z","end":"2026-05-26T05:45:55.843205Z","steps":["trace[2052323988] 'process raft request' (duration: 124.994582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:56.107646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.128861ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:45:56.107747Z","caller":"traceutil/trace.go:171","msg":"trace[1262695206] linearizableReadLoop","detail":"{readStateIndex:2822; appliedIndex:2821; }","duration":"181.353214ms","start":"2026-05-26T05:45:55.926377Z","end":"2026-05-26T05:45:56.10773Z","steps":["trace[1262695206] 'read index received' (duration: 70.926895ms)","trace[1262695206] 'applied index is now lower than readState.Index' (duration: 110.425199ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:45:56.107959Z","caller":"traceutil/trace.go:171","msg":"trace[537282295] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"184.089276ms","start":"2026-05-26T05:45:55.923857Z","end":"2026-05-26T05:45:56.107946Z","steps":["trace[537282295] 'process raft request' (duration: 73.569484ms)","trace[537282295] 'compare' (duration: 109.890014ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:45:56.10824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.841719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-05-26T05:45:56.10828Z","caller":"traceutil/trace.go:171","msg":"trace[460865739] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2715; }","duration":"181.906331ms","start":"2026-05-26T05:45:55.926361Z","end":"2026-05-26T05:45:56.108267Z","steps":["trace[460865739] 'agreement among raft nodes before linearized reading' (duration: 181.760336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:56.108488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.87139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-26T05:45:56.108527Z","caller":"traceutil/trace.go:171","msg":"trace[618752065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2715; }","duration":"181.920801ms","start":"2026-05-26T05:45:55.926596Z","end":"2026-05-26T05:45:56.108517Z","steps":["trace[618752065] 'agreement among raft nodes before linearized reading' (duration: 181.817738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:45:56.108764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.250871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:45:56.108803Z","caller":"traceutil/trace.go:171","msg":"trace[1709319513] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2715; }","duration":"179.301792ms","start":"2026-05-26T05:45:55.929493Z","end":"2026-05-26T05:45:56.108794Z","steps":["trace[1709319513] 'agreement among raft nodes before linearized reading' (duration: 179.242661ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:46:01.457171Z","caller":"traceutil/trace.go:171","msg":"trace[2059031388] transaction","detail":"{read_only:false; response_revision:2743; number_of_response:1; }","duration":"112.599178ms","start":"2026-05-26T05:46:01.34454Z","end":"2026-05-26T05:46:01.457139Z","steps":["trace[2059031388] 'process raft request' (duration: 112.372422ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:32.111639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.505806ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:49:32.111801Z","caller":"traceutil/trace.go:171","msg":"trace[420306456] transaction","detail":"{read_only:false; response_revision:4493; number_of_response:1; }","duration":"216.983433ms","start":"2026-05-26T05:49:31.894778Z","end":"2026-05-26T05:49:32.111761Z","steps":["trace[420306456] 'compare' (duration: 209.401915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.333062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.245455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:49:39.333725Z","caller":"traceutil/trace.go:171","msg":"trace[150297869] transaction","detail":"{read_only:false; response_revision:4600; number_of_response:1; }","duration":"416.090612ms","start":"2026-05-26T05:49:38.917604Z","end":"2026-05-26T05:49:39.333695Z","steps":["trace[150297869] 'process raft request' (duration: 181.158076ms)","trace[150297869] 'compare' (duration: 222.153245ms)","trace[150297869] 'store kv pair into bolt db' {req_type:put; key:/registry/services/endpoints/monitoring/kube-prometheus-stack-grafana; req_size:989; } (duration: 12.006488ms)"],"step_count":3} {"level":"warn","ts":"2026-05-26T05:49:39.333832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:38.917595Z","time spent":"416.168993ms","remote":"127.0.0.1:44842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:49:39.333911Z","caller":"traceutil/trace.go:171","msg":"trace[2118970033] linearizableReadLoop","detail":"{readStateIndex:4782; appliedIndex:4778; }","duration":"380.069127ms","start":"2026-05-26T05:49:38.953794Z","end":"2026-05-26T05:49:39.333863Z","steps":["trace[2118970033] 'read index received' (duration: 144.907398ms)","trace[2118970033] 'applied index is now lower than readState.Index' (duration: 235.158709ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:39.333884Z","caller":"traceutil/trace.go:171","msg":"trace[1975879121] transaction","detail":"{read_only:false; response_revision:4601; number_of_response:1; }","duration":"416.257994ms","start":"2026-05-26T05:49:38.917616Z","end":"2026-05-26T05:49:39.333874Z","steps":["trace[1975879121] 'process raft request' (duration: 415.525153ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:39.333761Z","caller":"traceutil/trace.go:171","msg":"trace[549908999] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"412.86241ms","start":"2026-05-26T05:49:38.920866Z","end":"2026-05-26T05:49:39.333729Z","steps":["trace[549908999] 'process raft request' (duration: 412.455954ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.334101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:38.91761Z","time spent":"416.362516ms","remote":"127.0.0.1:44964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1563,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:49:39.334195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:38.920856Z","time spent":"413.243356ms","remote":"127.0.0.1:44954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:49:39.334425Z","caller":"traceutil/trace.go:171","msg":"trace[700916333] transaction","detail":"{read_only:false; response_revision:4603; number_of_response:1; }","duration":"411.370848ms","start":"2026-05-26T05:49:38.92279Z","end":"2026-05-26T05:49:39.33416Z","steps":["trace[700916333] 'process raft request' (duration: 410.623926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.334698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:38.92278Z","time spent":"411.874915ms","remote":"127.0.0.1:44866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:49:39.400588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.124396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:49:39.400659Z","caller":"traceutil/trace.go:171","msg":"trace[1865887468] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4603; }","duration":"387.253738ms","start":"2026-05-26T05:49:39.013389Z","end":"2026-05-26T05:49:39.400643Z","steps":["trace[1865887468] 'agreement among raft nodes before linearized reading' (duration: 387.114466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.400711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:39.013349Z","time spent":"387.351719ms","remote":"127.0.0.1:44954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:49:39.400871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.052498ms","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-05-26T05:49:39.400923Z","caller":"traceutil/trace.go:171","msg":"trace[3064402] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4603; }","duration":"150.158809ms","start":"2026-05-26T05:49:39.250749Z","end":"2026-05-26T05:49:39.400908Z","steps":["trace[3064402] 'agreement among raft nodes before linearized reading' (duration: 150.018607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.400897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.079175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:49:39.400987Z","caller":"traceutil/trace.go:171","msg":"trace[571614570] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4603; }","duration":"447.197368ms","start":"2026-05-26T05:49:38.953759Z","end":"2026-05-26T05:49:39.400956Z","steps":["trace[571614570] 'agreement among raft nodes before linearized reading' (duration: 380.271061ms)","trace[571614570] 'range keys from in-memory index tree' (duration: 66.760994ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:49:39.401034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.668668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-05-26T05:49:39.401051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:38.953743Z","time spent":"447.275549ms","remote":"127.0.0.1:46000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-05-26T05:49:39.401073Z","caller":"traceutil/trace.go:171","msg":"trace[816933923] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4603; }","duration":"182.705038ms","start":"2026-05-26T05:49:39.218355Z","end":"2026-05-26T05:49:39.40106Z","steps":["trace[816933923] 'agreement among raft nodes before linearized reading' (duration: 182.555306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.401117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.568332ms","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-05-26T05:49:39.401139Z","caller":"traceutil/trace.go:171","msg":"trace[1757579669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4603; }","duration":"146.617494ms","start":"2026-05-26T05:49:39.254515Z","end":"2026-05-26T05:49:39.401132Z","steps":["trace[1757579669] 'agreement among raft nodes before linearized reading' (duration: 146.557113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.401226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.210548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-26T05:49:39.401241Z","caller":"traceutil/trace.go:171","msg":"trace[1853383195] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:4603; }","duration":"302.265439ms","start":"2026-05-26T05:49:39.098971Z","end":"2026-05-26T05:49:39.401237Z","steps":["trace[1853383195] 'agreement among raft nodes before linearized reading' (duration: 302.218928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.401258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:39.098952Z","time spent":"302.300809ms","remote":"127.0.0.1:44842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":35,"response size":30,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-05-26T05:49:39.667906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.495492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-26T05:49:39.668261Z","caller":"traceutil/trace.go:171","msg":"trace[1706032115] transaction","detail":"{read_only:false; response_revision:4606; number_of_response:1; }","duration":"257.195843ms","start":"2026-05-26T05:49:39.411035Z","end":"2026-05-26T05:49:39.668231Z","steps":["trace[1706032115] 'process raft request' (duration: 140.279044ms)","trace[1706032115] 'compare' (duration: 116.276489ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:39.668326Z","caller":"traceutil/trace.go:171","msg":"trace[1153506153] transaction","detail":"{read_only:false; response_revision:4608; number_of_response:1; }","duration":"256.789777ms","start":"2026-05-26T05:49:39.411518Z","end":"2026-05-26T05:49:39.668308Z","steps":["trace[1153506153] 'process raft request' (duration: 256.696565ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:39.668343Z","caller":"traceutil/trace.go:171","msg":"trace[1161361401] transaction","detail":"{read_only:false; response_revision:4607; number_of_response:1; }","duration":"257.197293ms","start":"2026-05-26T05:49:39.411113Z","end":"2026-05-26T05:49:39.66831Z","steps":["trace[1161361401] 'process raft request' (duration: 257.02014ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:39.668505Z","caller":"traceutil/trace.go:171","msg":"trace[1918550276] transaction","detail":"{read_only:false; response_revision:4609; number_of_response:1; }","duration":"256.9135ms","start":"2026-05-26T05:49:39.411581Z","end":"2026-05-26T05:49:39.668495Z","steps":["trace[1918550276] 'process raft request' (duration: 256.691875ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:39.668791Z","caller":"traceutil/trace.go:171","msg":"trace[993474349] transaction","detail":"{read_only:false; response_revision:4610; number_of_response:1; }","duration":"256.728577ms","start":"2026-05-26T05:49:39.412049Z","end":"2026-05-26T05:49:39.668777Z","steps":["trace[993474349] 'process raft request' (duration: 256.264129ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:39.669092Z","caller":"traceutil/trace.go:171","msg":"trace[966365367] linearizableReadLoop","detail":"{readStateIndex:4790; appliedIndex:4784; }","duration":"256.666226ms","start":"2026-05-26T05:49:39.41241Z","end":"2026-05-26T05:49:39.669076Z","steps":["trace[966365367] 'read index received' (duration: 33.022266ms)","trace[966365367] 'applied index is now lower than readState.Index' (duration: 223.64293ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:39.669373Z","caller":"traceutil/trace.go:171","msg":"trace[1360858729] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"254.676084ms","start":"2026-05-26T05:49:39.414649Z","end":"2026-05-26T05:49:39.669325Z","steps":["trace[1360858729] 'process raft request' (duration: 253.851172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.669633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.204484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/openstack/\" range_end:\"/registry/resourcequotas/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:49:39.669674Z","caller":"traceutil/trace.go:171","msg":"trace[2146131213] range","detail":"{range_begin:/registry/resourcequotas/openstack/; range_end:/registry/resourcequotas/openstack0; response_count:0; response_revision:4611; }","duration":"257.258785ms","start":"2026-05-26T05:49:39.412405Z","end":"2026-05-26T05:49:39.669664Z","steps":["trace[2146131213] 'agreement among raft nodes before linearized reading' (duration: 257.167773ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.669683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.102762ms","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-05-26T05:49:39.669713Z","caller":"traceutil/trace.go:171","msg":"trace[60565564] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4611; }","duration":"147.179473ms","start":"2026-05-26T05:49:39.522525Z","end":"2026-05-26T05:49:39.669704Z","steps":["trace[60565564] 'agreement among raft nodes before linearized reading' (duration: 147.058371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:39.670073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.388168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:49:39.671369Z","caller":"traceutil/trace.go:171","msg":"trace[1791989629] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4611; }","duration":"215.259857ms","start":"2026-05-26T05:49:39.456089Z","end":"2026-05-26T05:49:39.671348Z","steps":["trace[1791989629] 'agreement among raft nodes before linearized reading' (duration: 213.390208ms)"],"step_count":1} {"level":"info","ts":"2026-05-26T05:49:40.050886Z","caller":"traceutil/trace.go:171","msg":"trace[1262705964] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"304.626835ms","start":"2026-05-26T05:49:39.746238Z","end":"2026-05-26T05:49:40.050865Z","steps":["trace[1262705964] 'process raft request' (duration: 304.472882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:40.051051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:39.746227Z","time spent":"304.727806ms","remote":"127.0.0.1:46000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1878,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:49:40.462376Z","caller":"traceutil/trace.go:171","msg":"trace[345166563] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"686.811033ms","start":"2026-05-26T05:49:39.775544Z","end":"2026-05-26T05:49:40.462355Z","steps":["trace[345166563] 'process raft request' (duration: 646.473083ms)","trace[345166563] 'compare' (duration: 40.229999ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:49:40.462376Z","caller":"traceutil/trace.go:171","msg":"trace[1558191219] linearizableReadLoop","detail":"{readStateIndex:4797; appliedIndex:4795; }","duration":"626.337838ms","start":"2026-05-26T05:49:39.836017Z","end":"2026-05-26T05:49:40.462355Z","steps":["trace[1558191219] 'read index received' (duration: 214.586087ms)","trace[1558191219] 'applied index is now lower than readState.Index' (duration: 411.750561ms)"],"step_count":2} {"level":"warn","ts":"2026-05-26T05:49:40.462472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:39.775519Z","time spent":"686.909734ms","remote":"127.0.0.1:44758","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":814,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-26T05:49:40.463341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.311133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16228"} {"level":"info","ts":"2026-05-26T05:49:40.463521Z","caller":"traceutil/trace.go:171","msg":"trace[690016363] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4616; }","duration":"627.515956ms","start":"2026-05-26T05:49:39.835985Z","end":"2026-05-26T05:49:40.463501Z","steps":["trace[690016363] 'agreement among raft nodes before linearized reading' (duration: 626.429749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:40.463637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:39.83597Z","time spent":"627.648589ms","remote":"127.0.0.1:44866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":16251,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-05-26T05:49:40.497273Z","caller":"traceutil/trace.go:171","msg":"trace[61060469] transaction","detail":"{read_only:false; response_revision:4617; number_of_response:1; }","duration":"337.609673ms","start":"2026-05-26T05:49:40.15964Z","end":"2026-05-26T05:49:40.49725Z","steps":["trace[61060469] 'process raft request' (duration: 337.336359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:40.497533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:40.159621Z","time spent":"337.834026ms","remote":"127.0.0.1:46000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2725,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-26T05:49:40.497708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.907087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"warn","ts":"2026-05-26T05:49:40.497728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.306314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-26T05:49:40.497743Z","caller":"traceutil/trace.go:171","msg":"trace[196300155] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4618; }","duration":"589.980328ms","start":"2026-05-26T05:49:39.907755Z","end":"2026-05-26T05:49:40.497736Z","steps":["trace[196300155] 'agreement among raft nodes before linearized reading' (duration: 589.870326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:40.497791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:39.907691Z","time spent":"590.08152ms","remote":"127.0.0.1:44866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-26T05:49:40.497784Z","caller":"traceutil/trace.go:171","msg":"trace[1023232113] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4618; }","duration":"567.406575ms","start":"2026-05-26T05:49:39.930359Z","end":"2026-05-26T05:49:40.497766Z","steps":["trace[1023232113] 'agreement among raft nodes before linearized reading' (duration: 567.246192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:40.497828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:39.930331Z","time spent":"567.486946ms","remote":"127.0.0.1:44826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-05-26T05:49:40.497559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.199187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-26T05:49:40.497947Z","caller":"traceutil/trace.go:171","msg":"trace[959918158] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:4618; }","duration":"330.612174ms","start":"2026-05-26T05:49:40.167309Z","end":"2026-05-26T05:49:40.497921Z","steps":["trace[959918158] 'agreement among raft nodes before linearized reading' (duration: 330.207177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:40.498043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:40.167293Z","time spent":"330.719545ms","remote":"127.0.0.1:46522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true "} {"level":"info","ts":"2026-05-26T05:49:40.4976Z","caller":"traceutil/trace.go:171","msg":"trace[1523043007] transaction","detail":"{read_only:false; response_revision:4618; number_of_response:1; }","duration":"299.997547ms","start":"2026-05-26T05:49:40.197592Z","end":"2026-05-26T05:49:40.49759Z","steps":["trace[1523043007] 'process raft request' (duration: 299.542239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-26T05:49:40.498153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-26T05:49:40.197573Z","time spent":"300.548475ms","remote":"127.0.0.1:44954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-26T05:49:52.865237Z","caller":"traceutil/trace.go:171","msg":"trace[785701478] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"210.36689ms","start":"2026-05-26T05:49:52.654847Z","end":"2026-05-26T05:49:52.865214Z","steps":["trace[785701478] 'process raft request' (duration: 191.870916ms)","trace[785701478] 'compare' (duration: 17.742842ms)"],"step_count":2} {"level":"info","ts":"2026-05-26T05:51:20.407286Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2844} {"level":"info","ts":"2026-05-26T05:51:20.505899Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2844,"took":"97.235291ms","hash":2733017383,"current-db-size-bytes":54169600,"current-db-size":"54 MB","current-db-size-in-use-bytes":29413376,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-26T05:51:20.506094Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2733017383,"revision":2844,"compact-revision":-1} {"level":"info","ts":"2026-05-26T05:56:20.413504Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5564} {"level":"info","ts":"2026-05-26T05:56:20.48214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5564,"took":"67.477138ms","hash":2871983518,"current-db-size-bytes":54169600,"current-db-size":"54 MB","current-db-size-in-use-bytes":18173952,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-26T05:56:20.4822Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2871983518,"revision":5564,"compact-revision":2844}