{"level":"warn","ts":"2026-07-01T13:05:56.736075Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T13:05:56.736207Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-07-01T13:05:56.736442Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T13:05:56.736517Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-07-01T13:05:56.736546Z","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-07-01T13:05:56.738326Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-07-01T13:05:56.738858Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-07-01T13:05:56.743843Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.578406ms"} {"level":"info","ts":"2026-07-01T13:05:56.751949Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-07-01T13:05:56.752028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T13:05:56.752054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-07-01T13:05:56.752068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T13:05:56.752081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-07-01T13:05:56.752131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-07-01T13:05:56.757451Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T13:05:56.75872Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T13:05:56.759674Z","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-07-01T13:05:56.76171Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T13:05:56.762279Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T13:05:56.762567Z","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-07-01T13:05:56.762678Z","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-07-01T13:05:56.762694Z","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-07-01T13:05:56.763287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-07-01T13:05:56.763481Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-07-01T13:05:56.765235Z","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-07-01T13:05:56.765362Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-07-01T13:05:56.76543Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-07-01T13:05:56.766137Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T13:05:56.766167Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T13:05:57.252563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T13:05:57.252632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T13:05:57.252669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-07-01T13:05:57.252691Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-07-01T13:05:57.252708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-07-01T13:05:57.252731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-07-01T13:05:57.252751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-07-01T13:05:57.254735Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T13:05:57.254798Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T13:05:57.255332Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T13:05:57.255485Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T13:05:57.255854Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T13:05:57.255955Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T13:05:57.255968Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T13:05:57.256105Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T13:05:57.256137Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T13:05:57.2584Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T13:05:57.270836Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-07-01T13:06:06.264712Z","caller":"traceutil/trace.go:171","msg":"trace[411472610] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"108.699932ms","start":"2026-07-01T13:06:06.155982Z","end":"2026-07-01T13:06:06.264682Z","steps":["trace[411472610] 'process raft request' (duration: 108.56314ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:06.265129Z","caller":"traceutil/trace.go:171","msg":"trace[1984533243] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:330; }","duration":"100.118772ms","start":"2026-07-01T13:06:06.164982Z","end":"2026-07-01T13:06:06.265101Z","steps":["trace[1984533243] 'agreement among raft nodes before linearized reading' (duration: 99.87297ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:34.172112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.176994ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T13:06:34.172263Z","caller":"traceutil/trace.go:171","msg":"trace[2040106766] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"223.835834ms","start":"2026-07-01T13:06:33.948409Z","end":"2026-07-01T13:06:34.172245Z","steps":["trace[2040106766] 'process raft request' (duration: 95.944805ms)","trace[2040106766] 'compare' (duration: 127.051133ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:06:34.181646Z","caller":"traceutil/trace.go:171","msg":"trace[1554074026] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"139.189486ms","start":"2026-07-01T13:06:34.042434Z","end":"2026-07-01T13:06:34.181623Z","steps":["trace[1554074026] 'process raft request' (duration: 139.117686ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:34.18162Z","caller":"traceutil/trace.go:171","msg":"trace[1497940435] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"224.722801ms","start":"2026-07-01T13:06:33.956865Z","end":"2026-07-01T13:06:34.181588Z","steps":["trace[1497940435] 'process raft request' (duration: 224.451319ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:34.400289Z","caller":"traceutil/trace.go:171","msg":"trace[615751772] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"200.608611ms","start":"2026-07-01T13:06:34.199648Z","end":"2026-07-01T13:06:34.400257Z","steps":["trace[615751772] 'process raft request' (duration: 200.40996ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:34.400465Z","caller":"traceutil/trace.go:171","msg":"trace[1508538824] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"165.732052ms","start":"2026-07-01T13:06:34.234671Z","end":"2026-07-01T13:06:34.400403Z","steps":["trace[1508538824] 'process raft request' (duration: 165.52878ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:34.400918Z","caller":"traceutil/trace.go:171","msg":"trace[1980695526] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"165.469569ms","start":"2026-07-01T13:06:34.235416Z","end":"2026-07-01T13:06:34.400885Z","steps":["trace[1980695526] 'process raft request' (duration: 164.944555ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:34.469947Z","caller":"traceutil/trace.go:171","msg":"trace[1889676881] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"200.991054ms","start":"2026-07-01T13:06:34.268937Z","end":"2026-07-01T13:06:34.469928Z","steps":["trace[1889676881] 'process raft request' (duration: 200.822343ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:40.822998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.659657ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-07-01T13:06:40.823238Z","caller":"traceutil/trace.go:171","msg":"trace[1539107194] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"628.829571ms","start":"2026-07-01T13:06:40.19439Z","end":"2026-07-01T13:06:40.823219Z","steps":["trace[1539107194] 'process raft request' (duration: 628.71489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:40.823318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.194359Z","time spent":"628.911672ms","remote":"127.0.0.1:45222","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T13:06:40.823462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.159517Z","time spent":"663.939691ms","remote":"127.0.0.1:45048","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-01T13:06:40.82351Z","caller":"traceutil/trace.go:171","msg":"trace[1168848726] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"656.587917ms","start":"2026-07-01T13:06:40.166911Z","end":"2026-07-01T13:06:40.823499Z","steps":["trace[1168848726] 'read index received' (duration: 410.425706ms)","trace[1168848726] 'applied index is now lower than readState.Index' (duration: 246.160891ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T13:06:40.823746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.789738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rtdnj\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-01T13:06:40.823776Z","caller":"traceutil/trace.go:171","msg":"trace[1383918631] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rtdnj; range_end:; response_count:1; response_revision:581; }","duration":"656.910139ms","start":"2026-07-01T13:06:40.166856Z","end":"2026-07-01T13:06:40.823766Z","steps":["trace[1383918631] 'agreement among raft nodes before linearized reading' (duration: 656.720327ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:40.823805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.166832Z","time spent":"656.965669ms","remote":"127.0.0.1:45214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-rtdnj\" "} {"level":"warn","ts":"2026-07-01T13:06:40.823848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.043796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T13:06:40.823926Z","caller":"traceutil/trace.go:171","msg":"trace[1404701577] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"447.166278ms","start":"2026-07-01T13:06:40.376736Z","end":"2026-07-01T13:06:40.823902Z","steps":["trace[1404701577] 'agreement among raft nodes before linearized reading' (duration: 447.027247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:40.823965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.376715Z","time spent":"447.242328ms","remote":"127.0.0.1:45016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T13:06:40.824006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.764411ms","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-07-01T13:06:40.824059Z","caller":"traceutil/trace.go:171","msg":"trace[97863861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"313.932102ms","start":"2026-07-01T13:06:40.510111Z","end":"2026-07-01T13:06:40.824043Z","steps":["trace[97863861] 'agreement among raft nodes before linearized reading' (duration: 313.70115ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:40.824091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.510095Z","time spent":"313.988113ms","remote":"127.0.0.1:45262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-01T13:06:41.121996Z","caller":"traceutil/trace.go:171","msg":"trace[1636520115] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"297.510574ms","start":"2026-07-01T13:06:40.824461Z","end":"2026-07-01T13:06:41.121972Z","steps":["trace[1636520115] 'process raft request' (duration: 252.891886ms)","trace[1636520115] 'compare' (duration: 44.281855ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T13:06:41.122115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.661518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T13:06:41.121996Z","caller":"traceutil/trace.go:171","msg":"trace[180898912] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"296.526757ms","start":"2026-07-01T13:06:40.825432Z","end":"2026-07-01T13:06:41.121959Z","steps":["trace[180898912] 'read index received' (duration: 251.937949ms)","trace[180898912] 'applied index is now lower than readState.Index' (duration: 44.587178ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:06:41.12215Z","caller":"traceutil/trace.go:171","msg":"trace[1152894881] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:582; }","duration":"296.733388ms","start":"2026-07-01T13:06:40.825406Z","end":"2026-07-01T13:06:41.12214Z","steps":["trace[1152894881] 'agreement among raft nodes before linearized reading' (duration: 296.634637ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:41.154558Z","caller":"traceutil/trace.go:171","msg":"trace[123239399] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"325.954503ms","start":"2026-07-01T13:06:40.828578Z","end":"2026-07-01T13:06:41.154532Z","steps":["trace[123239399] 'process raft request' (duration: 325.733461ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:41.154709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.828555Z","time spent":"326.074134ms","remote":"127.0.0.1:45262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T13:06:41.154856Z","caller":"traceutil/trace.go:171","msg":"trace[973145494] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"322.498237ms","start":"2026-07-01T13:06:40.832335Z","end":"2026-07-01T13:06:41.154833Z","steps":["trace[973145494] 'process raft request' (duration: 322.108494ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:41.155002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.832328Z","time spent":"322.599178ms","remote":"127.0.0.1:45262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T13:06:41.155201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.155881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T13:06:41.155251Z","caller":"traceutil/trace.go:171","msg":"trace[107264259] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:585; }","duration":"320.283851ms","start":"2026-07-01T13:06:40.83495Z","end":"2026-07-01T13:06:41.155234Z","steps":["trace[107264259] 'agreement among raft nodes before linearized reading' (duration: 320.15264ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:41.155286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.834944Z","time spent":"320.334412ms","remote":"127.0.0.1:45324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":0,"response size":28,"request content":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-07-01T13:06:41.155308Z","caller":"traceutil/trace.go:171","msg":"trace[1326184834] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"315.971559ms","start":"2026-07-01T13:06:40.839324Z","end":"2026-07-01T13:06:41.155296Z","steps":["trace[1326184834] 'process raft request' (duration: 315.444395ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:41.155373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:40.839292Z","time spent":"316.04512ms","remote":"127.0.0.1:45214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T13:06:41.155595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.843026ms","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-07-01T13:06:41.155685Z","caller":"traceutil/trace.go:171","msg":"trace[1356016722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:585; }","duration":"151.989586ms","start":"2026-07-01T13:06:41.003669Z","end":"2026-07-01T13:06:41.155659Z","steps":["trace[1356016722] 'agreement among raft nodes before linearized reading' (duration: 151.714104ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:41.560568Z","caller":"traceutil/trace.go:171","msg":"trace[2038452211] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"400.041838ms","start":"2026-07-01T13:06:41.160453Z","end":"2026-07-01T13:06:41.560494Z","steps":["trace[2038452211] 'process raft request' (duration: 398.729159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:06:41.560712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:06:41.160441Z","time spent":"400.184039ms","remote":"127.0.0.1:45262","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T13:06:55.341492Z","caller":"traceutil/trace.go:171","msg":"trace[316967206] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"117.952751ms","start":"2026-07-01T13:06:55.223503Z","end":"2026-07-01T13:06:55.341455Z","steps":["trace[316967206] 'process raft request' (duration: 117.685769ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:06:55.507811Z","caller":"traceutil/trace.go:171","msg":"trace[210761780] linearizableReadLoop","detail":"{readStateIndex:781; appliedIndex:779; }","duration":"259.615542ms","start":"2026-07-01T13:06:55.248156Z","end":"2026-07-01T13:06:55.507772Z","steps":["trace[210761780] 'read index received' (duration: 93.153102ms)","trace[210761780] 'applied index is now lower than readState.Index' (duration: 166.46079ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:06:55.507962Z","caller":"traceutil/trace.go:171","msg":"trace[178362236] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"284.34585ms","start":"2026-07-01T13:06:55.223589Z","end":"2026-07-01T13:06:55.507935Z","steps":["trace[178362236] 'process raft request' (duration: 228.30677ms)","trace[178362236] 'compare' (duration: 55.706268ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T13:06:55.508113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.931095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-v8jmh\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-07-01T13:06:55.508151Z","caller":"traceutil/trace.go:171","msg":"trace[1141570623] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-v8jmh; range_end:; response_count:1; response_revision:753; }","duration":"260.078426ms","start":"2026-07-01T13:06:55.248061Z","end":"2026-07-01T13:06:55.50814Z","steps":["trace[1141570623] 'agreement among raft nodes before linearized reading' (duration: 259.853554ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:08:11.804251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.156484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-57bef889-2495-403e-ad66-5dfb631a8c01\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-01T13:08:11.804409Z","caller":"traceutil/trace.go:171","msg":"trace[233856177] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-57bef889-2495-403e-ad66-5dfb631a8c01; range_end:; response_count:1; response_revision:1817; }","duration":"182.319269ms","start":"2026-07-01T13:08:11.622022Z","end":"2026-07-01T13:08:11.804341Z","steps":["trace[233856177] 'range keys from in-memory index tree' (duration: 181.900797ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:08:12.021403Z","caller":"traceutil/trace.go:171","msg":"trace[1089161924] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"209.278508ms","start":"2026-07-01T13:08:11.812079Z","end":"2026-07-01T13:08:12.021358Z","steps":["trace[1089161924] 'process raft request' (duration: 118.101012ms)","trace[1089161924] 'compare' (duration: 90.899799ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:08:12.022214Z","caller":"traceutil/trace.go:171","msg":"trace[1470888564] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"171.605423ms","start":"2026-07-01T13:08:11.850585Z","end":"2026-07-01T13:08:12.02219Z","steps":["trace[1470888564] 'process raft request' (duration: 170.677468ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:08:12.268884Z","caller":"traceutil/trace.go:171","msg":"trace[964981230] linearizableReadLoop","detail":"{readStateIndex:1893; appliedIndex:1891; }","duration":"228.581831ms","start":"2026-07-01T13:08:12.040283Z","end":"2026-07-01T13:08:12.268865Z","steps":["trace[964981230] 'read index received' (duration: 41.824788ms)","trace[964981230] 'applied index is now lower than readState.Index' (duration: 186.756143ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:08:12.268984Z","caller":"traceutil/trace.go:171","msg":"trace[121272898] transaction","detail":"{read_only:false; response_revision:1822; number_of_response:1; }","duration":"240.904653ms","start":"2026-07-01T13:08:12.028071Z","end":"2026-07-01T13:08:12.268976Z","steps":["trace[121272898] 'process raft request' (duration: 183.978369ms)","trace[121272898] 'compare' (duration: 56.705748ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T13:08:12.269181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.911952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-01T13:08:12.269255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.968061ms","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-07-01T13:08:12.269289Z","caller":"traceutil/trace.go:171","msg":"trace[529608962] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1822; }","duration":"229.038243ms","start":"2026-07-01T13:08:12.040241Z","end":"2026-07-01T13:08:12.26928Z","steps":["trace[529608962] 'agreement among raft nodes before linearized reading' (duration: 228.92495ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:08:12.269259Z","caller":"traceutil/trace.go:171","msg":"trace[1827441425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1822; }","duration":"120.037135ms","start":"2026-07-01T13:08:12.149204Z","end":"2026-07-01T13:08:12.269241Z","steps":["trace[1827441425] 'agreement among raft nodes before linearized reading' (duration: 119.791519ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:08:45.715215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.416121ms","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-07-01T13:08:45.71529Z","caller":"traceutil/trace.go:171","msg":"trace[254695420] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2059; }","duration":"118.554484ms","start":"2026-07-01T13:08:45.59672Z","end":"2026-07-01T13:08:45.715274Z","steps":["trace[254695420] 'range keys from in-memory index tree' (duration: 118.244748ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:08:46.190662Z","caller":"traceutil/trace.go:171","msg":"trace[1343865406] linearizableReadLoop","detail":"{readStateIndex:2139; appliedIndex:2138; }","duration":"143.273765ms","start":"2026-07-01T13:08:46.047366Z","end":"2026-07-01T13:08:46.19064Z","steps":["trace[1343865406] 'read index received' (duration: 143.177203ms)","trace[1343865406] 'applied index is now lower than readState.Index' (duration: 95.591µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:08:46.190707Z","caller":"traceutil/trace.go:171","msg":"trace[861708009] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"148.605884ms","start":"2026-07-01T13:08:46.04208Z","end":"2026-07-01T13:08:46.190686Z","steps":["trace[861708009] 'process raft request' (duration: 148.38304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:08:46.1908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.418627ms","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-07-01T13:08:46.190866Z","caller":"traceutil/trace.go:171","msg":"trace[1415536695] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2061; }","duration":"143.519519ms","start":"2026-07-01T13:08:46.047309Z","end":"2026-07-01T13:08:46.190829Z","steps":["trace[1415536695] 'agreement among raft nodes before linearized reading' (duration: 143.430298ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:08:46.41411Z","caller":"traceutil/trace.go:171","msg":"trace[805656299] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"179.557301ms","start":"2026-07-01T13:08:46.234526Z","end":"2026-07-01T13:08:46.414083Z","steps":["trace[805656299] 'process raft request' (duration: 140.436797ms)","trace[805656299] 'compare' (duration: 39.013681ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:08:46.448799Z","caller":"traceutil/trace.go:171","msg":"trace[430822122] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"200.689515ms","start":"2026-07-01T13:08:46.248088Z","end":"2026-07-01T13:08:46.448777Z","steps":["trace[430822122] 'process raft request' (duration: 200.542662ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:10:18.98303Z","caller":"traceutil/trace.go:171","msg":"trace[227852986] linearizableReadLoop","detail":"{readStateIndex:2769; appliedIndex:2768; }","duration":"107.516446ms","start":"2026-07-01T13:10:18.875491Z","end":"2026-07-01T13:10:18.983008Z","steps":["trace[227852986] 'read index received' (duration: 107.265112ms)","trace[227852986] 'applied index is now lower than readState.Index' (duration: 250.524µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:10:18.983161Z","caller":"traceutil/trace.go:171","msg":"trace[1482095539] transaction","detail":"{read_only:false; response_revision:2670; number_of_response:1; }","duration":"130.378178ms","start":"2026-07-01T13:10:18.852768Z","end":"2026-07-01T13:10:18.983146Z","steps":["trace[1482095539] 'process raft request' (duration: 130.098464ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:10:18.983472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.964363ms","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-07-01T13:10:18.983517Z","caller":"traceutil/trace.go:171","msg":"trace[2069485561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2670; }","duration":"108.035214ms","start":"2026-07-01T13:10:18.875471Z","end":"2026-07-01T13:10:18.983507Z","steps":["trace[2069485561] 'agreement among raft nodes before linearized reading' (duration: 107.797ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:10:18.983751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.190821ms","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-07-01T13:10:18.983855Z","caller":"traceutil/trace.go:171","msg":"trace[1166829943] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2670; }","duration":"107.340614ms","start":"2026-07-01T13:10:18.876488Z","end":"2026-07-01T13:10:18.983829Z","steps":["trace[1166829943] 'agreement among raft nodes before linearized reading' (duration: 107.06238ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:10:19.322619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.007045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-07-01T13:10:19.322713Z","caller":"traceutil/trace.go:171","msg":"trace[1647586757] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2673; }","duration":"154.190328ms","start":"2026-07-01T13:10:19.168499Z","end":"2026-07-01T13:10:19.32269Z","steps":["trace[1647586757] 'range keys from in-memory index tree' (duration: 153.785852ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:10:19.331109Z","caller":"traceutil/trace.go:171","msg":"trace[1670212153] transaction","detail":"{read_only:false; response_revision:2674; number_of_response:1; }","duration":"147.209893ms","start":"2026-07-01T13:10:19.183882Z","end":"2026-07-01T13:10:19.331092Z","steps":["trace[1670212153] 'process raft request' (duration: 147.091121ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:13:48.816227Z","caller":"traceutil/trace.go:171","msg":"trace[2077428712] linearizableReadLoop","detail":"{readStateIndex:4469; appliedIndex:4467; }","duration":"131.026022ms","start":"2026-07-01T13:13:48.685177Z","end":"2026-07-01T13:13:48.816203Z","steps":["trace[2077428712] 'read index received' (duration: 33.185539ms)","trace[2077428712] 'applied index is now lower than readState.Index' (duration: 97.839173ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:13:48.816291Z","caller":"traceutil/trace.go:171","msg":"trace[1192835089] transaction","detail":"{read_only:false; response_revision:4304; number_of_response:1; }","duration":"133.27127ms","start":"2026-07-01T13:13:48.682978Z","end":"2026-07-01T13:13:48.816249Z","steps":["trace[1192835089] 'process raft request' (duration: 133.044364ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:13:48.816496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.32526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1923"} {"level":"warn","ts":"2026-07-01T13:13:48.816495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.254941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T13:13:48.816564Z","caller":"traceutil/trace.go:171","msg":"trace[1345547570] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4304; }","duration":"131.508695ms","start":"2026-07-01T13:13:48.68504Z","end":"2026-07-01T13:13:48.816549Z","steps":["trace[1345547570] 'agreement among raft nodes before linearized reading' (duration: 131.289749ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:13:48.81657Z","caller":"traceutil/trace.go:171","msg":"trace[1816677647] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:4304; }","duration":"128.384744ms","start":"2026-07-01T13:13:48.688171Z","end":"2026-07-01T13:13:48.816556Z","steps":["trace[1816677647] 'agreement among raft nodes before linearized reading' (duration: 128.170449ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:13:50.367278Z","caller":"traceutil/trace.go:171","msg":"trace[1574603244] transaction","detail":"{read_only:false; response_revision:4379; number_of_response:1; }","duration":"140.057355ms","start":"2026-07-01T13:13:50.227181Z","end":"2026-07-01T13:13:50.367238Z","steps":["trace[1574603244] 'process raft request' (duration: 138.985117ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:13:50.370387Z","caller":"traceutil/trace.go:171","msg":"trace[1288382174] transaction","detail":"{read_only:false; response_revision:4380; number_of_response:1; }","duration":"137.028077ms","start":"2026-07-01T13:13:50.233323Z","end":"2026-07-01T13:13:50.370351Z","steps":["trace[1288382174] 'process raft request' (duration: 136.826141ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:13:50.372333Z","caller":"traceutil/trace.go:171","msg":"trace[1666368442] transaction","detail":"{read_only:false; response_revision:4381; number_of_response:1; }","duration":"124.669428ms","start":"2026-07-01T13:13:50.247651Z","end":"2026-07-01T13:13:50.372321Z","steps":["trace[1666368442] 'process raft request' (duration: 122.606935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:13:50.373084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.307761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-07-01T13:13:50.373152Z","caller":"traceutil/trace.go:171","msg":"trace[306814579] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4381; }","duration":"126.400193ms","start":"2026-07-01T13:13:50.246714Z","end":"2026-07-01T13:13:50.373115Z","steps":["trace[306814579] 'agreement among raft nodes before linearized reading' (duration: 126.180877ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:13:50.370352Z","caller":"traceutil/trace.go:171","msg":"trace[92034896] linearizableReadLoop","detail":"{readStateIndex:4546; appliedIndex:4544; }","duration":"123.584031ms","start":"2026-07-01T13:13:50.246742Z","end":"2026-07-01T13:13:50.370326Z","steps":["trace[92034896] 'read index received' (duration: 119.359292ms)","trace[92034896] 'applied index is now lower than readState.Index' (duration: 4.223499ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T13:13:50.377175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.288427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4736"} {"level":"info","ts":"2026-07-01T13:13:50.377236Z","caller":"traceutil/trace.go:171","msg":"trace[536915751] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4381; }","duration":"122.40379ms","start":"2026-07-01T13:13:50.254812Z","end":"2026-07-01T13:13:50.377215Z","steps":["trace[536915751] 'agreement among raft nodes before linearized reading' (duration: 122.175055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:13:54.110624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.596562ms","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-07-01T13:13:54.110688Z","caller":"traceutil/trace.go:171","msg":"trace[718858130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4460; }","duration":"110.692985ms","start":"2026-07-01T13:13:53.999984Z","end":"2026-07-01T13:13:54.110677Z","steps":["trace[718858130] 'agreement among raft nodes before linearized reading' (duration: 110.536871ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:13:54.112346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.373592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-07-01T13:13:54.112472Z","caller":"traceutil/trace.go:171","msg":"trace[1952826337] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4461; }","duration":"111.520416ms","start":"2026-07-01T13:13:54.000928Z","end":"2026-07-01T13:13:54.112448Z","steps":["trace[1952826337] 'agreement among raft nodes before linearized reading' (duration: 111.27176ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:14:02.335787Z","caller":"traceutil/trace.go:171","msg":"trace[398770690] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"117.804585ms","start":"2026-07-01T13:14:02.217925Z","end":"2026-07-01T13:14:02.33573Z","steps":["trace[398770690] 'process raft request' (duration: 117.653932ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:14:02.355854Z","caller":"traceutil/trace.go:171","msg":"trace[306020700] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"137.70702ms","start":"2026-07-01T13:14:02.2181Z","end":"2026-07-01T13:14:02.355807Z","steps":["trace[306020700] 'process raft request' (duration: 137.441683ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:14:02.355862Z","caller":"traceutil/trace.go:171","msg":"trace[2129752672] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"135.482004ms","start":"2026-07-01T13:14:02.220347Z","end":"2026-07-01T13:14:02.355829Z","steps":["trace[2129752672] 'process raft request' (duration: 135.366981ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:14:02.668557Z","caller":"traceutil/trace.go:171","msg":"trace[741487875] linearizableReadLoop","detail":"{readStateIndex:4789; appliedIndex:4788; }","duration":"263.093172ms","start":"2026-07-01T13:14:02.405436Z","end":"2026-07-01T13:14:02.668529Z","steps":["trace[741487875] 'read index received' (duration: 262.878547ms)","trace[741487875] 'applied index is now lower than readState.Index' (duration: 213.695µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T13:14:02.668784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.336378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-37a02858-f2fa-45b4-bd96-57e3059c89c8\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-07-01T13:14:02.668831Z","caller":"traceutil/trace.go:171","msg":"trace[2048012737] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-37a02858-f2fa-45b4-bd96-57e3059c89c8; range_end:; response_count:1; response_revision:4618; }","duration":"263.438401ms","start":"2026-07-01T13:14:02.40538Z","end":"2026-07-01T13:14:02.668818Z","steps":["trace[2048012737] 'agreement among raft nodes before linearized reading' (duration: 263.252656ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:14:02.668869Z","caller":"traceutil/trace.go:171","msg":"trace[476176353] transaction","detail":"{read_only:false; response_revision:4618; number_of_response:1; }","duration":"300.929122ms","start":"2026-07-01T13:14:02.36792Z","end":"2026-07-01T13:14:02.668849Z","steps":["trace[476176353] 'process raft request' (duration: 300.459391ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:14:02.668983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T13:14:02.367892Z","time spent":"301.029154ms","remote":"127.0.0.1:45214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11832,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T13:14:02.825384Z","caller":"traceutil/trace.go:171","msg":"trace[1950958691] transaction","detail":"{read_only:false; response_revision:4620; number_of_response:1; }","duration":"150.136798ms","start":"2026-07-01T13:14:02.675222Z","end":"2026-07-01T13:14:02.825359Z","steps":["trace[1950958691] 'process raft request' (duration: 149.908602ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:14:02.82555Z","caller":"traceutil/trace.go:171","msg":"trace[968302509] transaction","detail":"{read_only:false; response_revision:4621; number_of_response:1; }","duration":"145.651457ms","start":"2026-07-01T13:14:02.679874Z","end":"2026-07-01T13:14:02.825526Z","steps":["trace[968302509] 'process raft request' (duration: 145.427491ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:14:02.826938Z","caller":"traceutil/trace.go:171","msg":"trace[995094351] transaction","detail":"{read_only:false; response_revision:4622; number_of_response:1; }","duration":"125.995619ms","start":"2026-07-01T13:14:02.700934Z","end":"2026-07-01T13:14:02.826929Z","steps":["trace[995094351] 'process raft request' (duration: 125.921307ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:14:16.448199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.466703ms","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-07-01T13:14:16.448286Z","caller":"traceutil/trace.go:171","msg":"trace[1619773603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4792; }","duration":"261.563115ms","start":"2026-07-01T13:14:16.186707Z","end":"2026-07-01T13:14:16.44827Z","steps":["trace[1619773603] 'range keys from in-memory index tree' (duration: 261.327759ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:14:16.451033Z","caller":"traceutil/trace.go:171","msg":"trace[1553928182] linearizableReadLoop","detail":"{readStateIndex:4971; appliedIndex:4970; }","duration":"122.537925ms","start":"2026-07-01T13:14:16.328472Z","end":"2026-07-01T13:14:16.45101Z","steps":["trace[1553928182] 'read index received' (duration: 122.364451ms)","trace[1553928182] 'applied index is now lower than readState.Index' (duration: 172.494µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T13:14:16.451141Z","caller":"traceutil/trace.go:171","msg":"trace[1205404183] transaction","detail":"{read_only:false; response_revision:4793; number_of_response:1; }","duration":"209.789988ms","start":"2026-07-01T13:14:16.24134Z","end":"2026-07-01T13:14:16.45113Z","steps":["trace[1205404183] 'process raft request' (duration: 209.539562ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T13:14:16.452135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.649842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-07-01T13:14:16.452227Z","caller":"traceutil/trace.go:171","msg":"trace[901408189] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4793; }","duration":"123.787606ms","start":"2026-07-01T13:14:16.328419Z","end":"2026-07-01T13:14:16.452207Z","steps":["trace[901408189] 'agreement among raft nodes before linearized reading' (duration: 123.310794ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T13:15:57.291358Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874} {"level":"info","ts":"2026-07-01T13:15:57.370291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"77.504161ms","hash":3087692416,"current-db-size-bytes":54677504,"current-db-size":"55 MB","current-db-size-in-use-bytes":29515776,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-01T13:15:57.370375Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3087692416,"revision":2874,"compact-revision":-1} {"level":"info","ts":"2026-07-01T13:20:57.299805Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5593} {"level":"info","ts":"2026-07-01T13:20:57.373346Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5593,"took":"72.083454ms","hash":2421052721,"current-db-size-bytes":54677504,"current-db-size":"55 MB","current-db-size-in-use-bytes":18210816,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-01T13:20:57.373396Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2421052721,"revision":5593,"compact-revision":2874}