{"level":"warn","ts":"2026-05-30T01:45:25.56525Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T01:45:25.565376Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-30T01:45:25.565453Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T01:45:25.565462Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-05-30T01:45:25.565481Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-30T01:45:25.566129Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]} {"level":"info","ts":"2026-05-30T01:45:25.566203Z","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.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-30T01:45:25.571458Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.063756ms"} {"level":"info","ts":"2026-05-30T01:45:25.578902Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"} {"level":"info","ts":"2026-05-30T01:45:25.578973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T01:45:25.578993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"} {"level":"info","ts":"2026-05-30T01:45:25.579002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T01:45:25.579009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"} {"level":"info","ts":"2026-05-30T01:45:25.579037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"warn","ts":"2026-05-30T01:45:25.584555Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T01:45:25.585843Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T01:45:25.586864Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-30T01:45:25.588825Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T01:45:25.589112Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T01:45:25.589218Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-30T01:45:25.589308Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-30T01:45:25.589317Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-30T01:45:25.591375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"info","ts":"2026-05-30T01:45:25.591469Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-05-30T01:45:25.592648Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-30T01:45:25.592979Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T01:45:25.593014Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T01:45:25.593147Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-05-30T01:45:25.593199Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-05-30T01:45:25.779819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T01:45:25.779886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T01:45:25.779935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"} {"level":"info","ts":"2026-05-30T01:45:25.77996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"} {"level":"info","ts":"2026-05-30T01:45:25.779976Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-05-30T01:45:25.779996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"} {"level":"info","ts":"2026-05-30T01:45:25.780022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-05-30T01:45:25.780937Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:45:25.781663Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T01:45:25.781673Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T01:45:25.78189Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T01:45:25.782215Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:45:25.782438Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:45:25.782533Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:45:25.783832Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T01:45:25.78421Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T01:45:25.785022Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T01:45:25.796295Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"} {"level":"info","ts":"2026-05-30T01:45:30.894637Z","caller":"traceutil/trace.go:171","msg":"trace[38169689] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"130.585255ms","start":"2026-05-30T01:45:30.764034Z","end":"2026-05-30T01:45:30.894619Z","steps":["trace[38169689] 'process raft request' (duration: 130.470724ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:30.894671Z","caller":"traceutil/trace.go:171","msg":"trace[680624591] linearizableReadLoop","detail":"{readStateIndex:288; appliedIndex:288; }","duration":"105.461154ms","start":"2026-05-30T01:45:30.78919Z","end":"2026-05-30T01:45:30.894652Z","steps":["trace[680624591] 'read index received' (duration: 105.453034ms)","trace[680624591] 'applied index is now lower than readState.Index' (duration: 6.85µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:45:30.894803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.590285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:45:30.894878Z","caller":"traceutil/trace.go:171","msg":"trace[1883175051] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:282; }","duration":"105.718777ms","start":"2026-05-30T01:45:30.789147Z","end":"2026-05-30T01:45:30.894866Z","steps":["trace[1883175051] 'agreement among raft nodes before linearized reading' (duration: 105.589816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.148758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.634139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:45:31.148877Z","caller":"traceutil/trace.go:171","msg":"trace[406410350] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"254.149972ms","start":"2026-05-30T01:45:30.89471Z","end":"2026-05-30T01:45:31.14886Z","steps":["trace[406410350] 'read index received' (duration: 90.04994ms)","trace[406410350] 'applied index is now lower than readState.Index' (duration: 164.098822ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:45:31.148973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.677083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-30T01:45:31.149003Z","caller":"traceutil/trace.go:171","msg":"trace[941942367] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:283; }","duration":"267.739414ms","start":"2026-05-30T01:45:30.881256Z","end":"2026-05-30T01:45:31.148995Z","steps":["trace[941942367] 'agreement among raft nodes before linearized reading' (duration: 267.673643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.149103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.704493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:45:31.149151Z","caller":"traceutil/trace.go:171","msg":"trace[834075255] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:283; }","duration":"267.767025ms","start":"2026-05-30T01:45:30.881371Z","end":"2026-05-30T01:45:31.149137Z","steps":["trace[834075255] 'agreement among raft nodes before linearized reading' (duration: 267.508753ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:31.149135Z","caller":"traceutil/trace.go:171","msg":"trace[791584614] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"266.177213ms","start":"2026-05-30T01:45:30.882872Z","end":"2026-05-30T01:45:31.149049Z","steps":["trace[791584614] 'process raft request' (duration: 101.754669ms)","trace[791584614] 'compare' (duration: 163.501518ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:45:31.149238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.502449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-30T01:45:31.149319Z","caller":"traceutil/trace.go:171","msg":"trace[353520873] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"358.651511ms","start":"2026-05-30T01:45:30.790648Z","end":"2026-05-30T01:45:31.1493Z","steps":["trace[353520873] 'agreement among raft nodes before linearized reading' (duration: 358.454669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.14936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.790622Z","time spent":"358.729981ms","remote":"127.0.0.1:55368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-30T01:45:31.330427Z","caller":"traceutil/trace.go:171","msg":"trace[1437370505] transaction","detail":"{read_only:false; number_of_response:0; response_revision:283; }","duration":"356.962235ms","start":"2026-05-30T01:45:30.973422Z","end":"2026-05-30T01:45:31.330385Z","steps":["trace[1437370505] 'process raft request' (duration: 310.718945ms)","trace[1437370505] 'compare' (duration: 46.17353ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:45:31.330624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.973381Z","time spent":"357.163686ms","remote":"127.0.0.1:55438","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:45:31.333967Z","caller":"traceutil/trace.go:171","msg":"trace[2142436229] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"342.696258ms","start":"2026-05-30T01:45:30.991245Z","end":"2026-05-30T01:45:31.333941Z","steps":["trace[2142436229] 'process raft request' (duration: 342.536447ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:31.334001Z","caller":"traceutil/trace.go:171","msg":"trace[2084936161] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"342.603318ms","start":"2026-05-30T01:45:30.991358Z","end":"2026-05-30T01:45:31.333961Z","steps":["trace[2084936161] 'process raft request' (duration: 342.517077ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:31.334022Z","caller":"traceutil/trace.go:171","msg":"trace[1630544210] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"341.807232ms","start":"2026-05-30T01:45:30.992195Z","end":"2026-05-30T01:45:31.334002Z","steps":["trace[1630544210] 'process raft request' (duration: 341.732372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.334075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.991228Z","time spent":"342.801598ms","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T01:45:31.334091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.992188Z","time spent":"341.869713ms","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:45:31.334217Z","caller":"traceutil/trace.go:171","msg":"trace[1256250533] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"341.748922ms","start":"2026-05-30T01:45:30.992455Z","end":"2026-05-30T01:45:31.334203Z","steps":["trace[1256250533] 'process raft request' (duration: 341.51236ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:31.334155Z","caller":"traceutil/trace.go:171","msg":"trace[955589265] linearizableReadLoop","detail":"{readStateIndex:295; appliedIndex:289; }","duration":"185.234641ms","start":"2026-05-30T01:45:31.148902Z","end":"2026-05-30T01:45:31.334137Z","steps":["trace[955589265] 'read index received' (duration: 135.330197ms)","trace[955589265] 'applied index is now lower than readState.Index' (duration: 49.903094ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:45:31.334222Z","caller":"traceutil/trace.go:171","msg":"trace[904577648] transaction","detail":"{read_only:false; response_revision:285; number_of_response:1; }","duration":"178.954009ms","start":"2026-05-30T01:45:31.155216Z","end":"2026-05-30T01:45:31.33417Z","steps":["trace[904577648] 'process raft request' (duration: 178.810468ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.334281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.992447Z","time spent":"341.804922ms","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:45:31.334511Z","caller":"traceutil/trace.go:171","msg":"trace[303770242] transaction","detail":"{read_only:false; number_of_response:0; response_revision:284; }","duration":"341.356849ms","start":"2026-05-30T01:45:30.993145Z","end":"2026-05-30T01:45:31.334501Z","steps":["trace[303770242] 'process raft request' (duration: 340.854955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.334516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.34231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-30T01:45:31.334565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.993139Z","time spent":"341.400289ms","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:45:31.33457Z","caller":"traceutil/trace.go:171","msg":"trace[1931918462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:286; }","duration":"437.41502ms","start":"2026-05-30T01:45:30.897137Z","end":"2026-05-30T01:45:31.334552Z","steps":["trace[1931918462] 'agreement among raft nodes before linearized reading' (duration: 437.223889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.33461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.897125Z","time spent":"437.47414ms","remote":"127.0.0.1:55514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T01:45:31.334759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.023133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T01:45:31.334516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.901219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-05-30T01:45:31.33479Z","caller":"traceutil/trace.go:171","msg":"trace[1339213912] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:286; }","duration":"435.065373ms","start":"2026-05-30T01:45:30.899714Z","end":"2026-05-30T01:45:31.334779Z","steps":["trace[1339213912] 'agreement among raft nodes before linearized reading' (duration: 435.015603ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.334816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.899706Z","time spent":"435.103764ms","remote":"127.0.0.1:55366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/coredns\" "} {"level":"info","ts":"2026-05-30T01:45:31.334811Z","caller":"traceutil/trace.go:171","msg":"trace[1733699109] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:286; }","duration":"182.232242ms","start":"2026-05-30T01:45:31.152564Z","end":"2026-05-30T01:45:31.334796Z","steps":["trace[1733699109] 'agreement among raft nodes before linearized reading' (duration: 181.876249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.334888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.141711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-30T01:45:31.334935Z","caller":"traceutil/trace.go:171","msg":"trace[1532486573] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"177.69537ms","start":"2026-05-30T01:45:31.157227Z","end":"2026-05-30T01:45:31.334923Z","steps":["trace[1532486573] 'process raft request' (duration: 176.861505ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:31.334966Z","caller":"traceutil/trace.go:171","msg":"trace[1988458523] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:286; }","duration":"182.228541ms","start":"2026-05-30T01:45:31.152692Z","end":"2026-05-30T01:45:31.334921Z","steps":["trace[1988458523] 'agreement among raft nodes before linearized reading' (duration: 182.07658ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:31.335269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:30.991352Z","time spent":"342.690869ms","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:46:04.504865Z","caller":"traceutil/trace.go:171","msg":"trace[1694231045] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"160.664297ms","start":"2026-05-30T01:46:04.344176Z","end":"2026-05-30T01:46:04.50484Z","steps":["trace[1694231045] 'process raft request' (duration: 145.581169ms)","trace[1694231045] 'compare' (duration: 14.987158ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:04.506613Z","caller":"traceutil/trace.go:171","msg":"trace[947232815] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:582; }","duration":"108.745927ms","start":"2026-05-30T01:46:04.397856Z","end":"2026-05-30T01:46:04.506602Z","steps":["trace[947232815] 'read index received' (duration: 91.981289ms)","trace[947232815] 'applied index is now lower than readState.Index' (duration: 16.763978ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:04.506678Z","caller":"traceutil/trace.go:171","msg":"trace[735625310] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"152.192013ms","start":"2026-05-30T01:46:04.35446Z","end":"2026-05-30T01:46:04.506652Z","steps":["trace[735625310] 'process raft request' (duration: 152.010522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:04.506807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.929457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:04.50686Z","caller":"traceutil/trace.go:171","msg":"trace[1600734571] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:563; }","duration":"108.999208ms","start":"2026-05-30T01:46:04.397851Z","end":"2026-05-30T01:46:04.506851Z","steps":["trace[1600734571] 'agreement among raft nodes before linearized reading' (duration: 108.908977ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:04.50693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.922207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:04.506992Z","caller":"traceutil/trace.go:171","msg":"trace[114092683] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:563; }","duration":"109.030918ms","start":"2026-05-30T01:46:04.397947Z","end":"2026-05-30T01:46:04.506978Z","steps":["trace[114092683] 'agreement among raft nodes before linearized reading' (duration: 108.921438ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:04.506723Z","caller":"traceutil/trace.go:171","msg":"trace[1619188002] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"140.09889ms","start":"2026-05-30T01:46:04.366615Z","end":"2026-05-30T01:46:04.506714Z","steps":["trace[1619188002] 'process raft request' (duration: 139.926539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:04.50727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.631926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:04.507297Z","caller":"traceutil/trace.go:171","msg":"trace[832271124] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:563; }","duration":"108.695646ms","start":"2026-05-30T01:46:04.398595Z","end":"2026-05-30T01:46:04.507291Z","steps":["trace[832271124] 'agreement among raft nodes before linearized reading' (duration: 108.658146ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:04.700523Z","caller":"traceutil/trace.go:171","msg":"trace[1546220239] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"162.986049ms","start":"2026-05-30T01:46:04.537511Z","end":"2026-05-30T01:46:04.700497Z","steps":["trace[1546220239] 'process raft request' (duration: 138.522762ms)","trace[1546220239] 'compare' (duration: 24.331016ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:04.702018Z","caller":"traceutil/trace.go:171","msg":"trace[1733276693] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"129.983807ms","start":"2026-05-30T01:46:04.572023Z","end":"2026-05-30T01:46:04.702007Z","steps":["trace[1733276693] 'process raft request' (duration: 129.564825ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:04.702045Z","caller":"traceutil/trace.go:171","msg":"trace[1948108371] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"114.983709ms","start":"2026-05-30T01:46:04.587044Z","end":"2026-05-30T01:46:04.702027Z","steps":["trace[1948108371] 'process raft request' (duration: 114.608457ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:04.702074Z","caller":"traceutil/trace.go:171","msg":"trace[710518904] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"140.934134ms","start":"2026-05-30T01:46:04.561123Z","end":"2026-05-30T01:46:04.702057Z","steps":["trace[710518904] 'process raft request' (duration: 140.319331ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:04.702151Z","caller":"traceutil/trace.go:171","msg":"trace[143007190] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"130.087487ms","start":"2026-05-30T01:46:04.572016Z","end":"2026-05-30T01:46:04.702103Z","steps":["trace[143007190] 'process raft request' (duration: 129.507434ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:10.852083Z","caller":"traceutil/trace.go:171","msg":"trace[621639891] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"108.794811ms","start":"2026-05-30T01:46:10.743249Z","end":"2026-05-30T01:46:10.852044Z","steps":["trace[621639891] 'process raft request' (duration: 108.61937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:11.392912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.812692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:46:11.393342Z","caller":"traceutil/trace.go:171","msg":"trace[1432794388] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"374.47826ms","start":"2026-05-30T01:46:11.018832Z","end":"2026-05-30T01:46:11.39331Z","steps":["trace[1432794388] 'process raft request' (duration: 219.155026ms)","trace[1432794388] 'compare' (duration: 154.608401ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:46:11.393513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:11.018807Z","time spent":"374.658011ms","remote":"127.0.0.1:55802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:46:11.405041Z","caller":"traceutil/trace.go:171","msg":"trace[396059946] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"377.853307ms","start":"2026-05-30T01:46:11.027139Z","end":"2026-05-30T01:46:11.404992Z","steps":["trace[396059946] 'process raft request' (duration: 377.712467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:11.40546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:11.02712Z","time spent":"377.985398ms","remote":"127.0.0.1:55440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:46:12.329363Z","caller":"traceutil/trace.go:171","msg":"trace[1901808388] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"124.433666ms","start":"2026-05-30T01:46:12.204895Z","end":"2026-05-30T01:46:12.329328Z","steps":["trace[1901808388] 'process raft request' (duration: 124.238315ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:26.414472Z","caller":"traceutil/trace.go:171","msg":"trace[755633393] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"278.996703ms","start":"2026-05-30T01:46:26.135441Z","end":"2026-05-30T01:46:26.414438Z","steps":["trace[755633393] 'process raft request' (duration: 278.151132ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:59.511614Z","caller":"traceutil/trace.go:171","msg":"trace[1344684284] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"273.307432ms","start":"2026-05-30T01:46:59.238181Z","end":"2026-05-30T01:46:59.511488Z","steps":["trace[1344684284] 'process raft request' (duration: 273.155868ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:19.388131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.237666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-defaultbackend-6987ff55cf-9w7bp\" ","response":"range_response_count:1 size:4218"} {"level":"info","ts":"2026-05-30T01:47:19.38826Z","caller":"traceutil/trace.go:171","msg":"trace[753632678] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-defaultbackend-6987ff55cf-9w7bp; range_end:; response_count:1; response_revision:1435; }","duration":"104.823951ms","start":"2026-05-30T01:47:19.283401Z","end":"2026-05-30T01:47:19.388225Z","steps":["trace[753632678] 'range keys from in-memory index tree' (duration: 100.036032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:33.230968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.04134ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:47:33.23129Z","caller":"traceutil/trace.go:171","msg":"trace[1818910356] transaction","detail":"{read_only:false; response_revision:1660; number_of_response:1; }","duration":"134.073278ms","start":"2026-05-30T01:47:33.097187Z","end":"2026-05-30T01:47:33.23126Z","steps":["trace[1818910356] 'process raft request' (duration: 133.947395ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:33.231598Z","caller":"traceutil/trace.go:171","msg":"trace[1053436416] linearizableReadLoop","detail":"{readStateIndex:1722; appliedIndex:1721; }","duration":"136.160617ms","start":"2026-05-30T01:47:33.095378Z","end":"2026-05-30T01:47:33.231538Z","steps":["trace[1053436416] 'read index received' (duration: 34.587497ms)","trace[1053436416] 'applied index is now lower than readState.Index' (duration: 101.56871ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:47:33.231813Z","caller":"traceutil/trace.go:171","msg":"trace[2071882138] transaction","detail":"{read_only:false; response_revision:1659; number_of_response:1; }","duration":"139.64181ms","start":"2026-05-30T01:47:33.092105Z","end":"2026-05-30T01:47:33.231746Z","steps":["trace[2071882138] 'process raft request' (duration: 37.664843ms)","trace[2071882138] 'compare' (duration: 100.873327ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:47:33.232096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.623888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-cluster-operator\" ","response":"range_response_count:1 size:1080"} {"level":"info","ts":"2026-05-30T01:47:33.232195Z","caller":"traceutil/trace.go:171","msg":"trace[1629090406] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-cluster-operator; range_end:; response_count:1; response_revision:1660; }","duration":"134.768521ms","start":"2026-05-30T01:47:33.097402Z","end":"2026-05-30T01:47:33.232171Z","steps":["trace[1629090406] 'agreement among raft nodes before linearized reading' (duration: 134.417075ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:33.232259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.687696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-messaging-topology-operator\" ","response":"range_response_count:1 size:1113"} {"level":"info","ts":"2026-05-30T01:47:33.232911Z","caller":"traceutil/trace.go:171","msg":"trace[706829840] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-messaging-topology-operator; range_end:; response_count:1; response_revision:1660; }","duration":"137.109404ms","start":"2026-05-30T01:47:33.095371Z","end":"2026-05-30T01:47:33.23248Z","steps":["trace[706829840] 'agreement among raft nodes before linearized reading' (duration: 136.412051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:48.723007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.976402ms","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-05-30T01:47:48.723096Z","caller":"traceutil/trace.go:171","msg":"trace[1405149620] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1879; }","duration":"354.118674ms","start":"2026-05-30T01:47:48.368959Z","end":"2026-05-30T01:47:48.723077Z","steps":["trace[1405149620] 'range keys from in-memory index tree' (duration: 353.766819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:48.723136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:48.368934Z","time spent":"354.193485ms","remote":"127.0.0.1:60504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-30T01:47:48.723434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.355414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:47:48.723817Z","caller":"traceutil/trace.go:171","msg":"trace[728125399] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"204.800161ms","start":"2026-05-30T01:47:48.518996Z","end":"2026-05-30T01:47:48.723796Z","steps":["trace[728125399] 'read index received' (duration: 86.312µs)","trace[728125399] 'applied index is now lower than readState.Index' (duration: 204.711889ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:47:48.724083Z","caller":"traceutil/trace.go:171","msg":"trace[1377971773] transaction","detail":"{read_only:false; response_revision:1880; number_of_response:1; }","duration":"286.850313ms","start":"2026-05-30T01:47:48.437191Z","end":"2026-05-30T01:47:48.724041Z","steps":["trace[1377971773] 'process raft request' (duration: 62.772177ms)","trace[1377971773] 'compare' (duration: 222.964708ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:47:48.724078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.064635ms","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-05-30T01:47:48.724306Z","caller":"traceutil/trace.go:171","msg":"trace[1418879206] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"181.298426ms","start":"2026-05-30T01:47:48.542995Z","end":"2026-05-30T01:47:48.724293Z","steps":["trace[1418879206] 'process raft request' (duration: 181.187735ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:48.724323Z","caller":"traceutil/trace.go:171","msg":"trace[1896776468] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1880; }","duration":"205.375121ms","start":"2026-05-30T01:47:48.518938Z","end":"2026-05-30T01:47:48.724313Z","steps":["trace[1896776468] 'agreement among raft nodes before linearized reading' (duration: 204.967944ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:48.731734Z","caller":"traceutil/trace.go:171","msg":"trace[55388523] transaction","detail":"{read_only:false; response_revision:1882; number_of_response:1; }","duration":"187.544899ms","start":"2026-05-30T01:47:48.544169Z","end":"2026-05-30T01:47:48.731714Z","steps":["trace[55388523] 'process raft request' (duration: 187.391676ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:48.732292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.994618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f4166b61-6037-4dcd-a9ab-5f0072cb0996\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-30T01:47:48.732427Z","caller":"traceutil/trace.go:171","msg":"trace[1503132114] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f4166b61-6037-4dcd-a9ab-5f0072cb0996; range_end:; response_count:1; response_revision:1882; }","duration":"190.420535ms","start":"2026-05-30T01:47:48.54196Z","end":"2026-05-30T01:47:48.732381Z","steps":["trace[1503132114] 'agreement among raft nodes before linearized reading' (duration: 189.729954ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:23.072486Z","caller":"traceutil/trace.go:171","msg":"trace[1853428430] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"129.485142ms","start":"2026-05-30T01:48:22.942954Z","end":"2026-05-30T01:48:23.072439Z","steps":["trace[1853428430] 'process raft request' (duration: 129.154588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:23.373971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.414404ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:48:23.374098Z","caller":"traceutil/trace.go:171","msg":"trace[1001660784] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2127; }","duration":"295.577336ms","start":"2026-05-30T01:48:23.078502Z","end":"2026-05-30T01:48:23.374079Z","steps":["trace[1001660784] 'range keys from in-memory index tree' (duration: 295.395923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:23.375158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.213167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:48:23.375315Z","caller":"traceutil/trace.go:171","msg":"trace[432712246] transaction","detail":"{read_only:false; response_revision:2128; number_of_response:1; }","duration":"428.380301ms","start":"2026-05-30T01:48:22.946893Z","end":"2026-05-30T01:48:23.375274Z","steps":["trace[432712246] 'process raft request' (duration: 220.91034ms)","trace[432712246] 'compare' (duration: 206.200414ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:48:23.375433Z","caller":"traceutil/trace.go:171","msg":"trace[864109706] linearizableReadLoop","detail":"{readStateIndex:2207; appliedIndex:2205; }","duration":"335.236745ms","start":"2026-05-30T01:48:23.040171Z","end":"2026-05-30T01:48:23.375408Z","steps":["trace[864109706] 'read index received' (duration: 31.877138ms)","trace[864109706] 'applied index is now lower than readState.Index' (duration: 303.356737ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:48:23.375459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:22.946879Z","time spent":"428.512672ms","remote":"127.0.0.1:55514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:48:23.375492Z","caller":"traceutil/trace.go:171","msg":"trace[1452977848] transaction","detail":"{read_only:false; response_revision:2129; number_of_response:1; }","duration":"261.809232ms","start":"2026-05-30T01:48:23.113666Z","end":"2026-05-30T01:48:23.375475Z","steps":["trace[1452977848] 'process raft request' (duration: 261.600289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:23.375829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.57ms","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-05-30T01:48:23.375884Z","caller":"traceutil/trace.go:171","msg":"trace[2093530917] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2129; }","duration":"335.736392ms","start":"2026-05-30T01:48:23.040133Z","end":"2026-05-30T01:48:23.37587Z","steps":["trace[2093530917] 'agreement among raft nodes before linearized reading' (duration: 335.409608ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:23.375928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:23.040117Z","time spent":"335.798383ms","remote":"127.0.0.1:55514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T01:48:23.376002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.470787ms","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-05-30T01:48:23.376112Z","caller":"traceutil/trace.go:171","msg":"trace[1785229725] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2129; }","duration":"312.655029ms","start":"2026-05-30T01:48:23.063431Z","end":"2026-05-30T01:48:23.376086Z","steps":["trace[1785229725] 'agreement among raft nodes before linearized reading' (duration: 312.207463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:23.376178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:23.063397Z","time spent":"312.769801ms","remote":"127.0.0.1:60504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-30T01:48:23.376157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.469219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-05-30T01:48:23.376258Z","caller":"traceutil/trace.go:171","msg":"trace[1278637736] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2129; }","duration":"271.621941ms","start":"2026-05-30T01:48:23.104617Z","end":"2026-05-30T01:48:23.376239Z","steps":["trace[1278637736] 'agreement among raft nodes before linearized reading' (duration: 271.380568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:23.615861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.465636ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:48:23.616072Z","caller":"traceutil/trace.go:171","msg":"trace[381320049] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"235.482277ms","start":"2026-05-30T01:48:23.380527Z","end":"2026-05-30T01:48:23.61601Z","steps":["trace[381320049] 'process raft request' (duration: 121.602825ms)","trace[381320049] 'compare' (duration: 113.191113ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:50:00.737766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.401958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-30T01:50:00.73816Z","caller":"traceutil/trace.go:171","msg":"trace[1580671039] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2760; }","duration":"158.820843ms","start":"2026-05-30T01:50:00.579284Z","end":"2026-05-30T01:50:00.738104Z","steps":["trace[1580671039] 'range keys from in-memory index tree' (duration: 158.126115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:50:06.263716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.783764ms","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-05-30T01:50:06.263863Z","caller":"traceutil/trace.go:171","msg":"trace[97614555] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2787; }","duration":"145.970196ms","start":"2026-05-30T01:50:06.117861Z","end":"2026-05-30T01:50:06.263832Z","steps":["trace[97614555] 'range keys from in-memory index tree' (duration: 145.598152ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:53:51.589471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.302847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-30T01:53:51.589448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.880132ms","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-05-30T01:53:51.589555Z","caller":"traceutil/trace.go:171","msg":"trace[1699312890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4601; }","duration":"125.432869ms","start":"2026-05-30T01:53:51.464101Z","end":"2026-05-30T01:53:51.589534Z","steps":["trace[1699312890] 'range keys from in-memory index tree' (duration: 125.105132ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:53:51.589588Z","caller":"traceutil/trace.go:171","msg":"trace[1332002751] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4601; }","duration":"113.091456ms","start":"2026-05-30T01:53:51.476468Z","end":"2026-05-30T01:53:51.589559Z","steps":["trace[1332002751] 'range keys from in-memory index tree' (duration: 112.580836ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:53:51.604073Z","caller":"traceutil/trace.go:171","msg":"trace[1258090836] linearizableReadLoop","detail":"{readStateIndex:4773; appliedIndex:4772; }","duration":"101.253575ms","start":"2026-05-30T01:53:51.502778Z","end":"2026-05-30T01:53:51.604032Z","steps":["trace[1258090836] 'read index received' (duration: 100.343395ms)","trace[1258090836] 'applied index is now lower than readState.Index' (duration: 908.82µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:53:51.604111Z","caller":"traceutil/trace.go:171","msg":"trace[1896613308] transaction","detail":"{read_only:false; response_revision:4602; number_of_response:1; }","duration":"113.451885ms","start":"2026-05-30T01:53:51.490636Z","end":"2026-05-30T01:53:51.604088Z","steps":["trace[1896613308] 'process raft request' (duration: 113.164849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:53:51.604261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.47139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-30T01:53:51.604297Z","caller":"traceutil/trace.go:171","msg":"trace[1796574896] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4602; }","duration":"101.532131ms","start":"2026-05-30T01:53:51.502754Z","end":"2026-05-30T01:53:51.604286Z","steps":["trace[1796574896] 'agreement among raft nodes before linearized reading' (duration: 101.403728ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:53:58.541924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.29306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:53:58.542115Z","caller":"traceutil/trace.go:171","msg":"trace[594732651] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"276.268694ms","start":"2026-05-30T01:53:58.265822Z","end":"2026-05-30T01:53:58.542091Z","steps":["trace[594732651] 'process raft request' (duration: 132.663688ms)","trace[594732651] 'compare' (duration: 142.466493ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:53:58.544539Z","caller":"traceutil/trace.go:171","msg":"trace[567016412] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"172.344096ms","start":"2026-05-30T01:53:58.372124Z","end":"2026-05-30T01:53:58.544468Z","steps":["trace[567016412] 'process raft request' (duration: 172.247564ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:53:58.544692Z","caller":"traceutil/trace.go:171","msg":"trace[589840751] linearizableReadLoop","detail":"{readStateIndex:4943; appliedIndex:4941; }","duration":"211.294289ms","start":"2026-05-30T01:53:58.333362Z","end":"2026-05-30T01:53:58.544657Z","steps":["trace[589840751] 'read index received' (duration: 65.1439ms)","trace[589840751] 'applied index is now lower than readState.Index' (duration: 146.149049ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:53:58.545037Z","caller":"traceutil/trace.go:171","msg":"trace[1940274114] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"168.917155ms","start":"2026-05-30T01:53:58.376101Z","end":"2026-05-30T01:53:58.545018Z","steps":["trace[1940274114] 'process raft request' (duration: 168.320042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:53:58.54559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.222518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6654b9a2-eb89-4612-9441-43670ff251a3\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-05-30T01:53:58.545642Z","caller":"traceutil/trace.go:171","msg":"trace[929541081] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6654b9a2-eb89-4612-9441-43670ff251a3; range_end:; response_count:1; response_revision:4769; }","duration":"212.363361ms","start":"2026-05-30T01:53:58.333263Z","end":"2026-05-30T01:53:58.545627Z","steps":["trace[929541081] 'agreement among raft nodes before linearized reading' (duration: 211.992663ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:53:58.545856Z","caller":"traceutil/trace.go:171","msg":"trace[1485965211] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"263.306564ms","start":"2026-05-30T01:53:58.282533Z","end":"2026-05-30T01:53:58.545839Z","steps":["trace[1485965211] 'process raft request' (duration: 261.648289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:53:58.545871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.632805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-7fc598ff44-c2mwr\" ","response":"range_response_count:1 size:11257"} {"level":"info","ts":"2026-05-30T01:53:58.545907Z","caller":"traceutil/trace.go:171","msg":"trace[101374253] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-7fc598ff44-c2mwr; range_end:; response_count:1; response_revision:4769; }","duration":"176.953212ms","start":"2026-05-30T01:53:58.368942Z","end":"2026-05-30T01:53:58.545895Z","steps":["trace[101374253] 'agreement among raft nodes before linearized reading' (duration: 176.85747ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:11.983523Z","caller":"traceutil/trace.go:171","msg":"trace[1155696452] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"142.875748ms","start":"2026-05-30T01:54:11.840619Z","end":"2026-05-30T01:54:11.983495Z","steps":["trace[1155696452] 'process raft request' (duration: 142.703445ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:12.129128Z","caller":"traceutil/trace.go:171","msg":"trace[202429854] linearizableReadLoop","detail":"{readStateIndex:5137; appliedIndex:5134; }","duration":"120.4415ms","start":"2026-05-30T01:54:12.00866Z","end":"2026-05-30T01:54:12.129102Z","steps":["trace[202429854] 'read index received' (duration: 18.588584ms)","trace[202429854] 'applied index is now lower than readState.Index' (duration: 101.851806ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:12.129252Z","caller":"traceutil/trace.go:171","msg":"trace[30290450] transaction","detail":"{read_only:false; response_revision:4953; number_of_response:1; }","duration":"136.420432ms","start":"2026-05-30T01:54:11.99282Z","end":"2026-05-30T01:54:12.12924Z","steps":["trace[30290450] 'process raft request' (duration: 93.083001ms)","trace[30290450] 'compare' (duration: 42.78636ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:12.129614Z","caller":"traceutil/trace.go:171","msg":"trace[128577055] transaction","detail":"{read_only:false; response_revision:4954; number_of_response:1; }","duration":"134.178817ms","start":"2026-05-30T01:54:11.995349Z","end":"2026-05-30T01:54:12.129528Z","steps":["trace[128577055] 'process raft request' (duration: 133.594605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:12.130002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.305637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:54:12.130067Z","caller":"traceutil/trace.go:171","msg":"trace[2108543614] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:4954; }","duration":"121.44749ms","start":"2026-05-30T01:54:12.008602Z","end":"2026-05-30T01:54:12.130049Z","steps":["trace[2108543614] 'agreement among raft nodes before linearized reading' (duration: 121.283647ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:55:26.312166Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2895} {"level":"info","ts":"2026-05-30T01:55:26.517907Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2895,"took":"203.930082ms","hash":1865509623,"current-db-size-bytes":53989376,"current-db-size":"54 MB","current-db-size-in-use-bytes":29302784,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-30T01:55:26.518058Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1865509623,"revision":2895,"compact-revision":-1} {"level":"info","ts":"2026-05-30T01:58:03.496313Z","caller":"traceutil/trace.go:171","msg":"trace[256451719] transaction","detail":"{read_only:false; response_revision:6668; number_of_response:1; }","duration":"180.063767ms","start":"2026-05-30T01:58:03.316208Z","end":"2026-05-30T01:58:03.496272Z","steps":["trace[256451719] 'process raft request' (duration: 161.431366ms)","trace[256451719] 'compare' (duration: 18.044713ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:58:03.664807Z","caller":"traceutil/trace.go:171","msg":"trace[7553072] transaction","detail":"{read_only:false; response_revision:6670; number_of_response:1; }","duration":"104.755823ms","start":"2026-05-30T01:58:03.560028Z","end":"2026-05-30T01:58:03.664784Z","steps":["trace[7553072] 'process raft request' (duration: 44.168813ms)","trace[7553072] 'compare' (duration: 60.471129ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T02:00:26.318137Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5571} {"level":"info","ts":"2026-05-30T02:00:26.393864Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5571,"took":"74.385103ms","hash":1071874042,"current-db-size-bytes":53989376,"current-db-size":"54 MB","current-db-size-in-use-bytes":18345984,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-30T02:00:26.393918Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1071874042,"revision":5571,"compact-revision":2895}