{"level":"warn","ts":"2026-04-07T01:19:49.795269Z","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-07T01:19:49.795384Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-07T01:19:49.795471Z","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-07T01:19:49.795488Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-07T01:19:49.795507Z","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-07T01:19:49.796348Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-04-07T01:19:49.796437Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-07T01:19:49.801628Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.90905ms"} {"level":"info","ts":"2026-04-07T01:19:49.811741Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-04-07T01:19:49.811823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T01:19:49.811847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-04-07T01:19:49.811858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T01:19:49.811866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-04-07T01:19:49.811905Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-04-07T01:19:49.818108Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T01:19:49.819754Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T01:19:49.821123Z","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-07T01:19:49.823291Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T01:19:49.823629Z","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-07T01:19:49.82376Z","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-07T01:19:49.823783Z","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-07T01:19:49.82422Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T01:19:49.829781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-04-07T01:19:49.829877Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-07T01:19:49.830437Z","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-07T01:19:49.83061Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-07T01:19:49.830652Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-07T01:19:49.83088Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T01:19:49.830926Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T01:19:50.012108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T01:19:50.012219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T01:19:50.012318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-04-07T01:19:50.012406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-04-07T01:19:50.012426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-07T01:19:50.012443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-04-07T01:19:50.012486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-07T01:19:50.014247Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:50.01589Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T01:19:50.016081Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:19:50.016113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T01:19:50.019449Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T01:19:50.019489Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T01:19:50.019634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-04-07T01:19:50.024634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T01:19:50.02484Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:50.02499Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T01:19:50.025028Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-07T01:20:08.862621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.953917ms","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-07T01:20:08.862697Z","caller":"traceutil/trace.go:171","msg":"trace[1360487637] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:406; }","duration":"152.086608ms","start":"2026-04-07T01:20:08.710599Z","end":"2026-04-07T01:20:08.862686Z","steps":["trace[1360487637] 'range keys from in-memory index tree' (duration: 151.796506ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.230467Z","caller":"traceutil/trace.go:171","msg":"trace[558065191] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"104.047071ms","start":"2026-04-07T01:20:19.126396Z","end":"2026-04-07T01:20:19.230443Z","steps":["trace[558065191] 'process raft request' (duration: 103.88646ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.501676Z","caller":"traceutil/trace.go:171","msg":"trace[1640663644] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"207.59344ms","start":"2026-04-07T01:20:19.294064Z","end":"2026-04-07T01:20:19.501657Z","steps":["trace[1640663644] 'process raft request' (duration: 207.50199ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.512865Z","caller":"traceutil/trace.go:171","msg":"trace[613647969] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"212.95357ms","start":"2026-04-07T01:20:19.299884Z","end":"2026-04-07T01:20:19.512838Z","steps":["trace[613647969] 'process raft request' (duration: 212.793569ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.513112Z","caller":"traceutil/trace.go:171","msg":"trace[663744458] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"200.25661ms","start":"2026-04-07T01:20:19.312809Z","end":"2026-04-07T01:20:19.513066Z","steps":["trace[663744458] 'process raft request' (duration: 199.987048ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.51312Z","caller":"traceutil/trace.go:171","msg":"trace[96776711] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"200.184509ms","start":"2026-04-07T01:20:19.312853Z","end":"2026-04-07T01:20:19.513037Z","steps":["trace[96776711] 'process raft request' (duration: 199.968717ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.513147Z","caller":"traceutil/trace.go:171","msg":"trace[1161216512] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"200.180189ms","start":"2026-04-07T01:20:19.312947Z","end":"2026-04-07T01:20:19.513128Z","steps":["trace[1161216512] 'process raft request' (duration: 199.900538ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.513172Z","caller":"traceutil/trace.go:171","msg":"trace[1013750726] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"200.110449ms","start":"2026-04-07T01:20:19.312994Z","end":"2026-04-07T01:20:19.513105Z","steps":["trace[1013750726] 'process raft request' (duration: 199.881748ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.513331Z","caller":"traceutil/trace.go:171","msg":"trace[1982412035] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"180.136029ms","start":"2026-04-07T01:20:19.333177Z","end":"2026-04-07T01:20:19.513313Z","steps":["trace[1982412035] 'process raft request' (duration: 179.791227ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.513387Z","caller":"traceutil/trace.go:171","msg":"trace[258510637] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"193.957185ms","start":"2026-04-07T01:20:19.319422Z","end":"2026-04-07T01:20:19.513379Z","steps":["trace[258510637] 'process raft request' (duration: 193.507762ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.513392Z","caller":"traceutil/trace.go:171","msg":"trace[1032211853] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"198.780752ms","start":"2026-04-07T01:20:19.314596Z","end":"2026-04-07T01:20:19.513377Z","steps":["trace[1032211853] 'process raft request' (duration: 198.303429ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.513424Z","caller":"traceutil/trace.go:171","msg":"trace[1076807487] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"173.229001ms","start":"2026-04-07T01:20:19.34018Z","end":"2026-04-07T01:20:19.513409Z","steps":["trace[1076807487] 'process raft request' (duration: 172.880199ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:19.513607Z","caller":"traceutil/trace.go:171","msg":"trace[1142429856] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"200.970054ms","start":"2026-04-07T01:20:19.312599Z","end":"2026-04-07T01:20:19.513569Z","steps":["trace[1142429856] 'process raft request' (duration: 200.168889ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:25.655713Z","caller":"traceutil/trace.go:171","msg":"trace[995330462] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"100.259972ms","start":"2026-04-07T01:20:25.55542Z","end":"2026-04-07T01:20:25.65568Z","steps":["trace[995330462] 'read index received' (duration: 100.024191ms)","trace[995330462] 'applied index is now lower than readState.Index' (duration: 235.121µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:20:25.655996Z","caller":"traceutil/trace.go:171","msg":"trace[1426263266] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"176.282058ms","start":"2026-04-07T01:20:25.479705Z","end":"2026-04-07T01:20:25.655987Z","steps":["trace[1426263266] 'process raft request' (duration: 175.800496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:25.656433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.894445ms","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-07T01:20:25.656475Z","caller":"traceutil/trace.go:171","msg":"trace[319824386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"101.089976ms","start":"2026-04-07T01:20:25.555373Z","end":"2026-04-07T01:20:25.656463Z","steps":["trace[319824386] 'agreement among raft nodes before linearized reading' (duration: 100.802324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:25.970078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.882335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T01:20:25.970349Z","caller":"traceutil/trace.go:171","msg":"trace[225466989] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"294.824586ms","start":"2026-04-07T01:20:25.675499Z","end":"2026-04-07T01:20:25.970323Z","steps":["trace[225466989] 'process raft request' (duration: 294.702905ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:20:25.970388Z","caller":"traceutil/trace.go:171","msg":"trace[316058757] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"310.722608ms","start":"2026-04-07T01:20:25.659634Z","end":"2026-04-07T01:20:25.970357Z","steps":["trace[316058757] 'process raft request' (duration: 118.798318ms)","trace[316058757] 'compare' (duration: 190.323292ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:20:25.970448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.49861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:20:25.970338Z","caller":"traceutil/trace.go:171","msg":"trace[224676235] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:596; }","duration":"301.3782ms","start":"2026-04-07T01:20:25.668931Z","end":"2026-04-07T01:20:25.970309Z","steps":["trace[224676235] 'read index received' (duration: 109.549381ms)","trace[224676235] 'applied index is now lower than readState.Index' (duration: 191.826489ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:20:25.970514Z","caller":"traceutil/trace.go:171","msg":"trace[1499433764] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:575; }","duration":"301.604441ms","start":"2026-04-07T01:20:25.668895Z","end":"2026-04-07T01:20:25.9705Z","steps":["trace[1499433764] 'agreement among raft nodes before linearized reading' (duration: 301.49706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:25.970552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:20:25.66888Z","time spent":"301.663121ms","remote":"127.0.0.1:41454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-07T01:20:25.970596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:20:25.659613Z","time spent":"310.834139ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:20:26.470202Z","caller":"traceutil/trace.go:171","msg":"trace[1323854010] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"214.063415ms","start":"2026-04-07T01:20:26.256107Z","end":"2026-04-07T01:20:26.47017Z","steps":["trace[1323854010] 'process raft request' (duration: 138.635797ms)","trace[1323854010] 'compare' (duration: 75.131737ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:20:26.656673Z","caller":"traceutil/trace.go:171","msg":"trace[1242462095] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"304.560933ms","start":"2026-04-07T01:20:26.352087Z","end":"2026-04-07T01:20:26.656648Z","steps":["trace[1242462095] 'process raft request' (duration: 303.86997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:20:26.656843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:20:26.352057Z","time spent":"304.684594ms","remote":"127.0.0.1:41330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:21:15.63802Z","caller":"traceutil/trace.go:171","msg":"trace[1992582009] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"109.498469ms","start":"2026-04-07T01:21:15.528476Z","end":"2026-04-07T01:21:15.637974Z","steps":["trace[1992582009] 'process raft request' (duration: 109.225849ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:02.827901Z","caller":"traceutil/trace.go:171","msg":"trace[1688307326] linearizableReadLoop","detail":"{readStateIndex:1882; appliedIndex:1881; }","duration":"360.506365ms","start":"2026-04-07T01:22:02.467366Z","end":"2026-04-07T01:22:02.827873Z","steps":["trace[1688307326] 'read index received' (duration: 359.975374ms)","trace[1688307326] 'applied index is now lower than readState.Index' (duration: 529.561µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:22:02.827918Z","caller":"traceutil/trace.go:171","msg":"trace[1995808693] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"363.869647ms","start":"2026-04-07T01:22:02.464022Z","end":"2026-04-07T01:22:02.827892Z","steps":["trace[1995808693] 'process raft request' (duration: 363.448798ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:22:02.828067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:22:02.464006Z","time spent":"363.983089ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:22:02.828116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.72804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T01:22:02.828152Z","caller":"traceutil/trace.go:171","msg":"trace[1912409356] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1813; }","duration":"360.796331ms","start":"2026-04-07T01:22:02.467344Z","end":"2026-04-07T01:22:02.828141Z","steps":["trace[1912409356] 'agreement among raft nodes before linearized reading' (duration: 360.628208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:22:02.828188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:22:02.467336Z","time spent":"360.843092ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T01:22:03.372962Z","caller":"traceutil/trace.go:171","msg":"trace[1455161776] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"185.740122ms","start":"2026-04-07T01:22:03.187191Z","end":"2026-04-07T01:22:03.372931Z","steps":["trace[1455161776] 'process raft request' (duration: 124.74716ms)","trace[1455161776] 'compare' (duration: 60.875929ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:22:16.661763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.295614ms","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-07T01:22:16.661842Z","caller":"traceutil/trace.go:171","msg":"trace[1355702277] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1930; }","duration":"130.434486ms","start":"2026-04-07T01:22:16.531383Z","end":"2026-04-07T01:22:16.661817Z","steps":["trace[1355702277] 'range keys from in-memory index tree' (duration: 130.136151ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:36.8721Z","caller":"traceutil/trace.go:171","msg":"trace[1070406262] transaction","detail":"{read_only:false; response_revision:2056; number_of_response:1; }","duration":"144.917097ms","start":"2026-04-07T01:22:36.727144Z","end":"2026-04-07T01:22:36.872061Z","steps":["trace[1070406262] 'process raft request' (duration: 144.683344ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:37.696407Z","caller":"traceutil/trace.go:171","msg":"trace[718729123] linearizableReadLoop","detail":"{readStateIndex:2136; appliedIndex:2135; }","duration":"178.900621ms","start":"2026-04-07T01:22:37.517485Z","end":"2026-04-07T01:22:37.696385Z","steps":["trace[718729123] 'read index received' (duration: 178.655627ms)","trace[718729123] 'applied index is now lower than readState.Index' (duration: 244.224µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:22:37.696575Z","caller":"traceutil/trace.go:171","msg":"trace[452757451] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"307.697934ms","start":"2026-04-07T01:22:37.388805Z","end":"2026-04-07T01:22:37.696503Z","steps":["trace[452757451] 'process raft request' (duration: 307.4362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:22:37.697064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:22:37.388775Z","time spent":"308.228563ms","remote":"127.0.0.1:41318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T01:22:37.696803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.298457ms","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-07T01:22:37.697247Z","caller":"traceutil/trace.go:171","msg":"trace[1842378823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2059; }","duration":"179.734975ms","start":"2026-04-07T01:22:37.517448Z","end":"2026-04-07T01:22:37.697183Z","steps":["trace[1842378823] 'agreement among raft nodes before linearized reading' (duration: 179.129835ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:37.831695Z","caller":"traceutil/trace.go:171","msg":"trace[510118100] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"129.945792ms","start":"2026-04-07T01:22:37.70172Z","end":"2026-04-07T01:22:37.831666Z","steps":["trace[510118100] 'process raft request' (duration: 121.881883ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:37.835271Z","caller":"traceutil/trace.go:171","msg":"trace[280957752] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"107.259259ms","start":"2026-04-07T01:22:37.727993Z","end":"2026-04-07T01:22:37.835252Z","steps":["trace[280957752] 'process raft request' (duration: 106.995335ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:38.216973Z","caller":"traceutil/trace.go:171","msg":"trace[750387947] linearizableReadLoop","detail":"{readStateIndex:2140; appliedIndex:2139; }","duration":"226.607607ms","start":"2026-04-07T01:22:37.990337Z","end":"2026-04-07T01:22:38.216944Z","steps":["trace[750387947] 'read index received' (duration: 169.291651ms)","trace[750387947] 'applied index is now lower than readState.Index' (duration: 57.314716ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:22:38.217524Z","caller":"traceutil/trace.go:171","msg":"trace[1441886986] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"268.397323ms","start":"2026-04-07T01:22:37.949083Z","end":"2026-04-07T01:22:38.21748Z","steps":["trace[1441886986] 'process raft request' (duration: 210.636339ms)","trace[1441886986] 'compare' (duration: 57.080323ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:22:38.21771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.353969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T01:22:38.217734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.851998ms","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-04-07T01:22:38.217933Z","caller":"traceutil/trace.go:171","msg":"trace[806888157] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2063; }","duration":"213.084662ms","start":"2026-04-07T01:22:38.004829Z","end":"2026-04-07T01:22:38.217914Z","steps":["trace[806888157] 'agreement among raft nodes before linearized reading' (duration: 212.504753ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:22:38.21803Z","caller":"traceutil/trace.go:171","msg":"trace[1420472116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2063; }","duration":"227.707894ms","start":"2026-04-07T01:22:37.990303Z","end":"2026-04-07T01:22:38.218011Z","steps":["trace[1420472116] 'agreement among raft nodes before linearized reading' (duration: 227.175556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:23:42.381689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.360329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T01:23:42.381773Z","caller":"traceutil/trace.go:171","msg":"trace[365733603] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2507; }","duration":"254.501172ms","start":"2026-04-07T01:23:42.127254Z","end":"2026-04-07T01:23:42.381755Z","steps":["trace[365733603] 'range keys from in-memory index tree' (duration: 254.194168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:23:42.381779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.616085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T01:23:42.381898Z","caller":"traceutil/trace.go:171","msg":"trace[761465640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2507; }","duration":"231.750897ms","start":"2026-04-07T01:23:42.150103Z","end":"2026-04-07T01:23:42.381854Z","steps":["trace[761465640] 'range keys from in-memory index tree' (duration: 231.404072ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:15.532313Z","caller":"traceutil/trace.go:171","msg":"trace[328695055] transaction","detail":"{read_only:false; response_revision:2692; number_of_response:1; }","duration":"233.882938ms","start":"2026-04-07T01:24:15.298405Z","end":"2026-04-07T01:24:15.532288Z","steps":["trace[328695055] 'process raft request' (duration: 233.727976ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:15.666442Z","caller":"traceutil/trace.go:171","msg":"trace[730215428] transaction","detail":"{read_only:false; response_revision:2693; number_of_response:1; }","duration":"129.008536ms","start":"2026-04-07T01:24:15.53741Z","end":"2026-04-07T01:24:15.666418Z","steps":["trace[730215428] 'process raft request' (duration: 128.797154ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:15.666795Z","caller":"traceutil/trace.go:171","msg":"trace[883549895] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"129.060357ms","start":"2026-04-07T01:24:15.53766Z","end":"2026-04-07T01:24:15.666721Z","steps":["trace[883549895] 'process raft request' (duration: 129.006967ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:24:20.870315Z","caller":"traceutil/trace.go:171","msg":"trace[1646810284] linearizableReadLoop","detail":"{readStateIndex:2824; appliedIndex:2823; }","duration":"109.96123ms","start":"2026-04-07T01:24:20.76033Z","end":"2026-04-07T01:24:20.870291Z","steps":["trace[1646810284] 'read index received' (duration: 13.312463ms)","trace[1646810284] 'applied index is now lower than readState.Index' (duration: 96.648127ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:24:20.870349Z","caller":"traceutil/trace.go:171","msg":"trace[1269947985] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"117.951601ms","start":"2026-04-07T01:24:20.752359Z","end":"2026-04-07T01:24:20.870311Z","steps":["trace[1269947985] 'process raft request' (duration: 21.359374ms)","trace[1269947985] 'compare' (duration: 96.433045ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:24:20.870494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.142642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:24:20.870534Z","caller":"traceutil/trace.go:171","msg":"trace[1954079601] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2724; }","duration":"110.224534ms","start":"2026-04-07T01:24:20.760297Z","end":"2026-04-07T01:24:20.870522Z","steps":["trace[1954079601] 'agreement among raft nodes before linearized reading' (duration: 110.081002ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:26:02.596151Z","caller":"traceutil/trace.go:171","msg":"trace[1114183342] transaction","detail":"{read_only:false; response_revision:3328; number_of_response:1; }","duration":"156.896264ms","start":"2026-04-07T01:26:02.439103Z","end":"2026-04-07T01:26:02.595999Z","steps":["trace[1114183342] 'process raft request' (duration: 69.04491ms)","trace[1114183342] 'compare' (duration: 87.372479ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:26:02.766673Z","caller":"traceutil/trace.go:171","msg":"trace[1284131375] transaction","detail":"{read_only:false; response_revision:3330; number_of_response:1; }","duration":"126.423324ms","start":"2026-04-07T01:26:02.640224Z","end":"2026-04-07T01:26:02.766647Z","steps":["trace[1284131375] 'process raft request' (duration: 99.307462ms)","trace[1284131375] 'compare' (duration: 27.004749ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:26:19.193531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.203772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:26:19.193634Z","caller":"traceutil/trace.go:171","msg":"trace[1995317694] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret; range_end:; response_count:0; response_revision:3427; }","duration":"102.345666ms","start":"2026-04-07T01:26:19.091265Z","end":"2026-04-07T01:26:19.193611Z","steps":["trace[1995317694] 'range keys from in-memory index tree' (duration: 102.087898ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:27:07.172446Z","caller":"traceutil/trace.go:171","msg":"trace[111928957] transaction","detail":"{read_only:false; response_revision:3745; number_of_response:1; }","duration":"100.514613ms","start":"2026-04-07T01:27:07.071911Z","end":"2026-04-07T01:27:07.172425Z","steps":["trace[111928957] 'process raft request' (duration: 100.40291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:27:57.310226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.262055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-04-07T01:27:57.310314Z","caller":"traceutil/trace.go:171","msg":"trace[1924569489] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4485; }","duration":"149.395607ms","start":"2026-04-07T01:27:57.160898Z","end":"2026-04-07T01:27:57.310294Z","steps":["trace[1924569489] 'range keys from in-memory index tree' (duration: 149.106622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:04.611137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.705002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T01:28:04.611209Z","caller":"traceutil/trace.go:171","msg":"trace[873841386] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:4639; }","duration":"113.821234ms","start":"2026-04-07T01:28:04.497371Z","end":"2026-04-07T01:28:04.611192Z","steps":["trace[873841386] 'count revisions from in-memory index tree' (duration: 113.63581ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.040662Z","caller":"traceutil/trace.go:171","msg":"trace[2022615573] linearizableReadLoop","detail":"{readStateIndex:4815; appliedIndex:4814; }","duration":"250.905341ms","start":"2026-04-07T01:28:04.789729Z","end":"2026-04-07T01:28:05.040634Z","steps":["trace[2022615573] 'read index received' (duration: 225.734781ms)","trace[2022615573] 'applied index is now lower than readState.Index' (duration: 25.168959ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:05.040684Z","caller":"traceutil/trace.go:171","msg":"trace[966688614] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"252.395261ms","start":"2026-04-07T01:28:04.788254Z","end":"2026-04-07T01:28:05.04065Z","steps":["trace[966688614] 'process raft request' (duration: 227.111199ms)","trace[966688614] 'compare' (duration: 25.118479ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:05.041048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.298759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-07T01:28:05.041133Z","caller":"traceutil/trace.go:171","msg":"trace[1820645217] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4643; }","duration":"251.403991ms","start":"2026-04-07T01:28:04.789695Z","end":"2026-04-07T01:28:05.041099Z","steps":["trace[1820645217] 'agreement among raft nodes before linearized reading' (duration: 251.183936ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.096288Z","caller":"traceutil/trace.go:171","msg":"trace[1944942562] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"300.440533ms","start":"2026-04-07T01:28:04.795819Z","end":"2026-04-07T01:28:05.09626Z","steps":["trace[1944942562] 'process raft request' (duration: 300.219709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:05.096714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.580246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:28:05.096817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.674762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-07T01:28:05.096906Z","caller":"traceutil/trace.go:171","msg":"trace[292150251] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4644; }","duration":"157.812856ms","start":"2026-04-07T01:28:04.939076Z","end":"2026-04-07T01:28:05.096889Z","steps":["trace[292150251] 'agreement among raft nodes before linearized reading' (duration: 157.54402ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.096873Z","caller":"traceutil/trace.go:171","msg":"trace[1698825669] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4644; }","duration":"200.76036ms","start":"2026-04-07T01:28:04.896089Z","end":"2026-04-07T01:28:05.096849Z","steps":["trace[1698825669] 'agreement among raft nodes before linearized reading' (duration: 200.567166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:05.097139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.059151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:28:05.097516Z","caller":"traceutil/trace.go:171","msg":"trace[367905065] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4644; }","duration":"149.446599ms","start":"2026-04-07T01:28:04.948049Z","end":"2026-04-07T01:28:05.097496Z","steps":["trace[367905065] 'agreement among raft nodes before linearized reading' (duration: 149.01575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:05.097175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.650593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"warn","ts":"2026-04-07T01:28:05.096716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:04.795802Z","time spent":"300.588837ms","remote":"127.0.0.1:41390","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9701,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:28:05.097271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.993854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-ctcg4-tls\" ","response":"range_response_count:1 size:2130"} {"level":"info","ts":"2026-04-07T01:28:05.098357Z","caller":"traceutil/trace.go:171","msg":"trace[618697670] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-ctcg4-tls; range_end:; response_count:1; response_revision:4644; }","duration":"307.088725ms","start":"2026-04-07T01:28:04.79125Z","end":"2026-04-07T01:28:05.098338Z","steps":["trace[618697670] 'agreement among raft nodes before linearized reading' (duration: 305.422302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:05.098416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:04.791242Z","time spent":"307.158246ms","remote":"127.0.0.1:39662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":2152,"request content":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-ctcg4-tls\" "} {"level":"warn","ts":"2026-04-07T01:28:05.098946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.219539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-07T01:28:05.099124Z","caller":"traceutil/trace.go:171","msg":"trace[698379779] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4644; }","duration":"101.383802ms","start":"2026-04-07T01:28:04.997665Z","end":"2026-04-07T01:28:05.099049Z","steps":["trace[698379779] 'agreement among raft nodes before linearized reading' (duration: 99.143098ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.097972Z","caller":"traceutil/trace.go:171","msg":"trace[904657754] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4644; }","duration":"251.491399ms","start":"2026-04-07T01:28:04.846463Z","end":"2026-04-07T01:28:05.097955Z","steps":["trace[904657754] 'agreement among raft nodes before linearized reading' (duration: 250.5248ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.228222Z","caller":"traceutil/trace.go:171","msg":"trace[1683728000] linearizableReadLoop","detail":"{readStateIndex:4819; appliedIndex:4818; }","duration":"121.654824ms","start":"2026-04-07T01:28:05.106547Z","end":"2026-04-07T01:28:05.228201Z","steps":["trace[1683728000] 'read index received' (duration: 8.56842ms)","trace[1683728000] 'applied index is now lower than readState.Index' (duration: 113.085234ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:05.228443Z","caller":"traceutil/trace.go:171","msg":"trace[1777807646] transaction","detail":"{read_only:false; response_revision:4647; number_of_response:1; }","duration":"124.794556ms","start":"2026-04-07T01:28:05.103636Z","end":"2026-04-07T01:28:05.22843Z","steps":["trace[1777807646] 'process raft request' (duration: 37.037575ms)","trace[1777807646] 'compare' (duration: 87.358103ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:05.228657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.085152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-04-07T01:28:05.22877Z","caller":"traceutil/trace.go:171","msg":"trace[1948712916] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4648; }","duration":"122.213934ms","start":"2026-04-07T01:28:05.106531Z","end":"2026-04-07T01:28:05.228745Z","steps":["trace[1948712916] 'agreement among raft nodes before linearized reading' (duration: 121.898588ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.228828Z","caller":"traceutil/trace.go:171","msg":"trace[1834442520] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"117.915049ms","start":"2026-04-07T01:28:05.11088Z","end":"2026-04-07T01:28:05.228795Z","steps":["trace[1834442520] 'process raft request' (duration: 117.271937ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.424223Z","caller":"traceutil/trace.go:171","msg":"trace[196492686] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"137.210273ms","start":"2026-04-07T01:28:05.286968Z","end":"2026-04-07T01:28:05.424178Z","steps":["trace[196492686] 'process raft request' (duration: 56.826248ms)","trace[196492686] 'compare' (duration: 80.12456ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:05.424275Z","caller":"traceutil/trace.go:171","msg":"trace[1701043931] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"135.955037ms","start":"2026-04-07T01:28:05.288298Z","end":"2026-04-07T01:28:05.424253Z","steps":["trace[1701043931] 'process raft request' (duration: 135.825165ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.42426Z","caller":"traceutil/trace.go:171","msg":"trace[2143324104] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"135.961108ms","start":"2026-04-07T01:28:05.288259Z","end":"2026-04-07T01:28:05.42422Z","steps":["trace[2143324104] 'process raft request' (duration: 135.830025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:05.42467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.356816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-07T01:28:05.424773Z","caller":"traceutil/trace.go:171","msg":"trace[856330095] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4658; }","duration":"135.479228ms","start":"2026-04-07T01:28:05.289259Z","end":"2026-04-07T01:28:05.424738Z","steps":["trace[856330095] 'agreement among raft nodes before linearized reading' (duration: 135.151981ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.424341Z","caller":"traceutil/trace.go:171","msg":"trace[45727823] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"126.719475ms","start":"2026-04-07T01:28:05.297604Z","end":"2026-04-07T01:28:05.424323Z","steps":["trace[45727823] 'process raft request' (duration: 126.606402ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.424343Z","caller":"traceutil/trace.go:171","msg":"trace[878600360] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"135.982238ms","start":"2026-04-07T01:28:05.288337Z","end":"2026-04-07T01:28:05.424319Z","steps":["trace[878600360] 'process raft request' (duration: 135.813644ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.424335Z","caller":"traceutil/trace.go:171","msg":"trace[30771194] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"135.637971ms","start":"2026-04-07T01:28:05.28867Z","end":"2026-04-07T01:28:05.424308Z","steps":["trace[30771194] 'process raft request' (duration: 135.510309ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.424382Z","caller":"traceutil/trace.go:171","msg":"trace[1285842810] linearizableReadLoop","detail":"{readStateIndex:4827; appliedIndex:4822; }","duration":"135.082961ms","start":"2026-04-07T01:28:05.289286Z","end":"2026-04-07T01:28:05.424369Z","steps":["trace[1285842810] 'read index received' (duration: 9.325955ms)","trace[1285842810] 'applied index is now lower than readState.Index' (duration: 125.755475ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:05.433837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.013144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T01:28:05.433911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.074518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-07T01:28:05.433959Z","caller":"traceutil/trace.go:171","msg":"trace[816470832] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4659; }","duration":"143.14832ms","start":"2026-04-07T01:28:05.290801Z","end":"2026-04-07T01:28:05.43395Z","steps":["trace[816470832] 'agreement among raft nodes before linearized reading' (duration: 142.962587ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.433933Z","caller":"traceutil/trace.go:171","msg":"trace[1356304618] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:4659; }","duration":"101.149577ms","start":"2026-04-07T01:28:05.332769Z","end":"2026-04-07T01:28:05.433918Z","steps":["trace[1356304618] 'agreement among raft nodes before linearized reading' (duration: 100.982213ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.550656Z","caller":"traceutil/trace.go:171","msg":"trace[1622789669] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"109.439451ms","start":"2026-04-07T01:28:05.441193Z","end":"2026-04-07T01:28:05.550632Z","steps":["trace[1622789669] 'process raft request' (duration: 109.37976ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.550662Z","caller":"traceutil/trace.go:171","msg":"trace[798592528] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"120.778226ms","start":"2026-04-07T01:28:05.429844Z","end":"2026-04-07T01:28:05.550622Z","steps":["trace[798592528] 'process raft request' (duration: 105.548054ms)","trace[798592528] 'compare' (duration: 14.913896ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:05.550711Z","caller":"traceutil/trace.go:171","msg":"trace[444429174] transaction","detail":"{read_only:false; response_revision:4661; number_of_response:1; }","duration":"118.019491ms","start":"2026-04-07T01:28:05.432661Z","end":"2026-04-07T01:28:05.55068Z","steps":["trace[444429174] 'process raft request' (duration: 117.859118ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:05.550672Z","caller":"traceutil/trace.go:171","msg":"trace[1290125511] linearizableReadLoop","detail":"{readStateIndex:4833; appliedIndex:4831; }","duration":"116.894899ms","start":"2026-04-07T01:28:05.433747Z","end":"2026-04-07T01:28:05.550641Z","steps":["trace[1290125511] 'read index received' (duration: 101.657207ms)","trace[1290125511] 'applied index is now lower than readState.Index' (duration: 15.234782ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:05.55087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.422948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-07T01:28:05.550916Z","caller":"traceutil/trace.go:171","msg":"trace[1135256801] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4662; }","duration":"121.513371ms","start":"2026-04-07T01:28:05.429388Z","end":"2026-04-07T01:28:05.550902Z","steps":["trace[1135256801] 'agreement among raft nodes before linearized reading' (duration: 121.335187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:05.551203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.37327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60846"} {"level":"info","ts":"2026-04-07T01:28:05.551274Z","caller":"traceutil/trace.go:171","msg":"trace[2001166713] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4662; }","duration":"113.506212ms","start":"2026-04-07T01:28:05.437752Z","end":"2026-04-07T01:28:05.551258Z","steps":["trace[2001166713] 'agreement among raft nodes before linearized reading' (duration: 113.197546ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:18.111538Z","caller":"traceutil/trace.go:171","msg":"trace[1211999626] linearizableReadLoop","detail":"{readStateIndex:5017; appliedIndex:5016; }","duration":"252.000653ms","start":"2026-04-07T01:28:17.859515Z","end":"2026-04-07T01:28:18.111516Z","steps":["trace[1211999626] 'read index received' (duration: 202.945286ms)","trace[1211999626] 'applied index is now lower than readState.Index' (duration: 49.054197ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:18.111833Z","caller":"traceutil/trace.go:171","msg":"trace[1046255017] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"352.62706ms","start":"2026-04-07T01:28:17.75918Z","end":"2026-04-07T01:28:18.111807Z","steps":["trace[1046255017] 'process raft request' (duration: 303.366929ms)","trace[1046255017] 'compare' (duration: 48.814123ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:28:18.111934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:28:17.759157Z","time spent":"352.712181ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T01:28:18.112097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.567593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-07T01:28:18.112157Z","caller":"traceutil/trace.go:171","msg":"trace[931593735] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4838; }","duration":"252.668785ms","start":"2026-04-07T01:28:17.859476Z","end":"2026-04-07T01:28:18.112145Z","steps":["trace[931593735] 'agreement among raft nodes before linearized reading' (duration: 252.493541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:18.112466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.021555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T01:28:18.112497Z","caller":"traceutil/trace.go:171","msg":"trace[561391318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4838; }","duration":"214.079546ms","start":"2026-04-07T01:28:17.898409Z","end":"2026-04-07T01:28:18.112489Z","steps":["trace[561391318] 'agreement among raft nodes before linearized reading' (duration: 214.031965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:18.112683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.04298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T01:28:18.112758Z","caller":"traceutil/trace.go:171","msg":"trace[1601816567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4838; }","duration":"149.204993ms","start":"2026-04-07T01:28:17.963534Z","end":"2026-04-07T01:28:18.112739Z","steps":["trace[1601816567] 'agreement among raft nodes before linearized reading' (duration: 149.010859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:18.112708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.684349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T01:28:18.112852Z","caller":"traceutil/trace.go:171","msg":"trace[1247497654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4838; }","duration":"164.876983ms","start":"2026-04-07T01:28:17.947957Z","end":"2026-04-07T01:28:18.112834Z","steps":["trace[1247497654] 'agreement among raft nodes before linearized reading' (duration: 164.698819ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:18.248516Z","caller":"traceutil/trace.go:171","msg":"trace[1887083774] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"131.469032ms","start":"2026-04-07T01:28:18.117029Z","end":"2026-04-07T01:28:18.248498Z","steps":["trace[1887083774] 'process raft request' (duration: 131.279768ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:18.248707Z","caller":"traceutil/trace.go:171","msg":"trace[1463150128] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"131.064764ms","start":"2026-04-07T01:28:18.117628Z","end":"2026-04-07T01:28:18.248693Z","steps":["trace[1463150128] 'process raft request' (duration: 130.84055ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:18.248922Z","caller":"traceutil/trace.go:171","msg":"trace[1640194795] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"130.945422ms","start":"2026-04-07T01:28:18.117968Z","end":"2026-04-07T01:28:18.248914Z","steps":["trace[1640194795] 'process raft request' (duration: 130.659186ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:18.255223Z","caller":"traceutil/trace.go:171","msg":"trace[2009571646] linearizableReadLoop","detail":"{readStateIndex:5022; appliedIndex:5018; }","duration":"121.046872ms","start":"2026-04-07T01:28:18.134162Z","end":"2026-04-07T01:28:18.255209Z","steps":["trace[2009571646] 'read index received' (duration: 114.242692ms)","trace[2009571646] 'applied index is now lower than readState.Index' (duration: 6.80347ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:18.255278Z","caller":"traceutil/trace.go:171","msg":"trace[748034344] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"128.355343ms","start":"2026-04-07T01:28:18.126892Z","end":"2026-04-07T01:28:18.255248Z","steps":["trace[748034344] 'process raft request' (duration: 128.21316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:18.2556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.335208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-04-07T01:28:18.255675Z","caller":"traceutil/trace.go:171","msg":"trace[222614106] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4843; }","duration":"121.535092ms","start":"2026-04-07T01:28:18.134123Z","end":"2026-04-07T01:28:18.255658Z","steps":["trace[222614106] 'agreement among raft nodes before linearized reading' (duration: 121.184415ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:28:19.31411Z","caller":"traceutil/trace.go:171","msg":"trace[141143628] linearizableReadLoop","detail":"{readStateIndex:5032; appliedIndex:5031; }","duration":"143.125346ms","start":"2026-04-07T01:28:19.170957Z","end":"2026-04-07T01:28:19.314083Z","steps":["trace[141143628] 'read index received' (duration: 142.829301ms)","trace[141143628] 'applied index is now lower than readState.Index' (duration: 295.125µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:28:19.314515Z","caller":"traceutil/trace.go:171","msg":"trace[1590445919] transaction","detail":"{read_only:false; response_revision:4852; number_of_response:1; }","duration":"163.450604ms","start":"2026-04-07T01:28:19.151028Z","end":"2026-04-07T01:28:19.314479Z","steps":["trace[1590445919] 'process raft request' (duration: 162.861053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:19.314744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.617745ms","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-07T01:28:19.314829Z","caller":"traceutil/trace.go:171","msg":"trace[468547845] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4852; }","duration":"133.738508ms","start":"2026-04-07T01:28:19.181068Z","end":"2026-04-07T01:28:19.314807Z","steps":["trace[468547845] 'agreement among raft nodes before linearized reading' (duration: 133.500744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:19.315016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.020908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T01:28:19.315176Z","caller":"traceutil/trace.go:171","msg":"trace[1062771357] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4852; }","duration":"140.233832ms","start":"2026-04-07T01:28:19.174926Z","end":"2026-04-07T01:28:19.31516Z","steps":["trace[1062771357] 'agreement among raft nodes before linearized reading' (duration: 139.62784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:28:19.31604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.073534ms","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-07T01:28:19.31613Z","caller":"traceutil/trace.go:171","msg":"trace[1047338872] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4852; }","duration":"145.184646ms","start":"2026-04-07T01:28:19.170901Z","end":"2026-04-07T01:28:19.316085Z","steps":["trace[1047338872] 'agreement among raft nodes before linearized reading' (duration: 143.499533ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:29:50.71862Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2878} {"level":"info","ts":"2026-04-07T01:29:50.787272Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2878,"took":"67.321699ms","hash":1278455128,"current-db-size-bytes":53772288,"current-db-size":"54 MB","current-db-size-in-use-bytes":28987392,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-07T01:29:50.787342Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1278455128,"revision":2878,"compact-revision":-1} {"level":"info","ts":"2026-04-07T01:31:12.3422Z","caller":"traceutil/trace.go:171","msg":"trace[328882976] transaction","detail":"{read_only:false; response_revision:6023; number_of_response:1; }","duration":"122.292103ms","start":"2026-04-07T01:31:12.219882Z","end":"2026-04-07T01:31:12.342174Z","steps":["trace[328882976] 'process raft request' (duration: 122.127601ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:31:12.59184Z","caller":"traceutil/trace.go:171","msg":"trace[2101211568] linearizableReadLoop","detail":"{readStateIndex:6243; appliedIndex:6242; }","duration":"210.630061ms","start":"2026-04-07T01:31:12.381159Z","end":"2026-04-07T01:31:12.591789Z","steps":["trace[2101211568] 'read index received' (duration: 192.577528ms)","trace[2101211568] 'applied index is now lower than readState.Index' (duration: 18.051483ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T01:31:12.591863Z","caller":"traceutil/trace.go:171","msg":"trace[1128879557] transaction","detail":"{read_only:false; response_revision:6024; number_of_response:1; }","duration":"371.089588ms","start":"2026-04-07T01:31:12.220746Z","end":"2026-04-07T01:31:12.591836Z","steps":["trace[1128879557] 'process raft request' (duration: 353.064606ms)","trace[1128879557] 'compare' (duration: 17.82913ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:31:12.59203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.855624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-07T01:31:12.592057Z","caller":"traceutil/trace.go:171","msg":"trace[1703974216] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6024; }","duration":"210.929594ms","start":"2026-04-07T01:31:12.381121Z","end":"2026-04-07T01:31:12.592051Z","steps":["trace[1703974216] 'agreement among raft nodes before linearized reading' (duration: 210.804323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:31:12.592083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.704031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:31:12.592174Z","caller":"traceutil/trace.go:171","msg":"trace[1188344546] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6024; }","duration":"165.823143ms","start":"2026-04-07T01:31:12.42633Z","end":"2026-04-07T01:31:12.592153Z","steps":["trace[1188344546] 'agreement among raft nodes before linearized reading' (duration: 165.61892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:31:12.592165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T01:31:12.220738Z","time spent":"371.18335ms","remote":"127.0.0.1:41474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T01:31:12.920226Z","caller":"traceutil/trace.go:171","msg":"trace[344853152] transaction","detail":"{read_only:false; response_revision:6027; number_of_response:1; }","duration":"193.826225ms","start":"2026-04-07T01:31:12.726373Z","end":"2026-04-07T01:31:12.920199Z","steps":["trace[344853152] 'process raft request' (duration: 193.133005ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:32:04.683748Z","caller":"traceutil/trace.go:171","msg":"trace[824256795] transaction","detail":"{read_only:false; response_revision:6480; number_of_response:1; }","duration":"102.840701ms","start":"2026-04-07T01:32:04.580879Z","end":"2026-04-07T01:32:04.683719Z","steps":["trace[824256795] 'process raft request' (duration: 69.935509ms)","trace[824256795] 'compare' (duration: 32.76734ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T01:32:19.327659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.633657ms","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-07T01:32:19.32773Z","caller":"traceutil/trace.go:171","msg":"trace[2144718279] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6608; }","duration":"124.749498ms","start":"2026-04-07T01:32:19.202966Z","end":"2026-04-07T01:32:19.327716Z","steps":["trace[2144718279] 'range keys from in-memory index tree' (duration: 124.499245ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:32:25.096161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.939756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-07T01:32:25.096239Z","caller":"traceutil/trace.go:171","msg":"trace[1055314195] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6636; }","duration":"116.045967ms","start":"2026-04-07T01:32:24.980176Z","end":"2026-04-07T01:32:25.096222Z","steps":["trace[1055314195] 'range keys from in-memory index tree' (duration: 115.808815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T01:32:25.096655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.036374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T01:32:25.096695Z","caller":"traceutil/trace.go:171","msg":"trace[241348763] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6636; }","duration":"118.107875ms","start":"2026-04-07T01:32:24.978577Z","end":"2026-04-07T01:32:25.096685Z","steps":["trace[241348763] 'range keys from in-memory index tree' (duration: 117.935132ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T01:34:50.725561Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5578} {"level":"info","ts":"2026-04-07T01:34:50.801345Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5578,"took":"73.750104ms","hash":3785719361,"current-db-size-bytes":53772288,"current-db-size":"54 MB","current-db-size-in-use-bytes":18194432,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-07T01:34:50.801399Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3785719361,"revision":5578,"compact-revision":2878}