{"level":"warn","ts":"2026-09-11T03:56:26.808226Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-11T03:56:26.808329Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.76: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://162.253.55.76:2380","--initial-cluster=instance=https://162.253.55.76:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.76:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.76: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-09-11T03:56:26.808406Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-11T03:56:26.808421Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.76:2380"]} {"level":"info","ts":"2026-09-11T03:56:26.808443Z","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-09-11T03:56:26.809181Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"]} {"level":"info","ts":"2026-09-11T03:56:26.809263Z","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://162.253.55.76:2380"],"listen-peer-urls":["https://162.253.55.76:2380"],"advertise-client-urls":["https://162.253.55.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.76: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-09-11T03:56:26.815579Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.099425ms"} {"level":"info","ts":"2026-09-11T03:56:26.822117Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"30ad0c2b6ecdd25e","cluster-id":"855d190e6ef0a61f"} {"level":"info","ts":"2026-09-11T03:56:26.822186Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=()"} {"level":"info","ts":"2026-09-11T03:56:26.82221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became follower at term 0"} {"level":"info","ts":"2026-09-11T03:56:26.822223Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 30ad0c2b6ecdd25e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-11T03:56:26.822233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became follower at term 1"} {"level":"info","ts":"2026-09-11T03:56:26.822274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=(3507473065473593950)"} {"level":"warn","ts":"2026-09-11T03:56:26.832279Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-11T03:56:26.833716Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-11T03:56:26.834934Z","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-09-11T03:56:26.840077Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"30ad0c2b6ecdd25e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-11T03:56:26.840256Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"30ad0c2b6ecdd25e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-11T03:56:26.84055Z","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-09-11T03:56:26.840793Z","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-09-11T03:56:26.840823Z","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-09-11T03:56:26.843007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e switched to configuration voters=(3507473065473593950)"} {"level":"info","ts":"2026-09-11T03:56:26.843424Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"855d190e6ef0a61f","local-member-id":"30ad0c2b6ecdd25e","added-peer-id":"30ad0c2b6ecdd25e","added-peer-peer-urls":["https://162.253.55.76:2380"]} {"level":"info","ts":"2026-09-11T03:56:26.844262Z","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-09-11T03:56:26.844436Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"30ad0c2b6ecdd25e","initial-advertise-peer-urls":["https://162.253.55.76:2380"],"listen-peer-urls":["https://162.253.55.76:2380"],"advertise-client-urls":["https://162.253.55.76:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.76:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-11T03:56:26.844484Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-11T03:56:26.844552Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.76:2380"} {"level":"info","ts":"2026-09-11T03:56:26.844721Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.76:2380"} {"level":"info","ts":"2026-09-11T03:56:27.622783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e is starting a new election at term 1"} {"level":"info","ts":"2026-09-11T03:56:27.622884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became pre-candidate at term 1"} {"level":"info","ts":"2026-09-11T03:56:27.622923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e received MsgPreVoteResp from 30ad0c2b6ecdd25e at term 1"} {"level":"info","ts":"2026-09-11T03:56:27.62295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became candidate at term 2"} {"level":"info","ts":"2026-09-11T03:56:27.622967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e received MsgVoteResp from 30ad0c2b6ecdd25e at term 2"} {"level":"info","ts":"2026-09-11T03:56:27.622982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"30ad0c2b6ecdd25e became leader at term 2"} {"level":"info","ts":"2026-09-11T03:56:27.622996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 30ad0c2b6ecdd25e elected leader 30ad0c2b6ecdd25e at term 2"} {"level":"info","ts":"2026-09-11T03:56:27.625594Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T03:56:27.626999Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-11T03:56:27.626986Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"30ad0c2b6ecdd25e","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.76:2379]}","request-path":"/0/members/30ad0c2b6ecdd25e/attributes","cluster-id":"855d190e6ef0a61f","publish-timeout":"7s"} {"level":"info","ts":"2026-09-11T03:56:27.627631Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-11T03:56:27.627664Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-11T03:56:27.627174Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-11T03:56:27.63002Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-11T03:56:27.630909Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"855d190e6ef0a61f","local-member-id":"30ad0c2b6ecdd25e","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T03:56:27.631032Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T03:56:27.631072Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-11T03:56:27.631887Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.76:2379"} {"level":"warn","ts":"2026-09-11T03:56:31.988367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.750499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-11T03:56:31.988702Z","caller":"traceutil/trace.go:171","msg":"trace[1604158811] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"764.985739ms","start":"2026-09-11T03:56:31.223642Z","end":"2026-09-11T03:56:31.988628Z","steps":["trace[1604158811] 'process raft request' (duration: 193.277031ms)","trace[1604158811] 'compare' (duration: 570.634445ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T03:56:31.988898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:56:31.223627Z","time spent":"765.231997ms","remote":"127.0.0.1:39776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":101,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T03:56:32.469187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.003605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-11T03:56:32.469488Z","caller":"traceutil/trace.go:171","msg":"trace[1004347890] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"1.123827534s","start":"2026-09-11T03:56:31.345628Z","end":"2026-09-11T03:56:32.469456Z","steps":["trace[1004347890] 'process raft request' (duration: 1.123753342s)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:56:32.469518Z","caller":"traceutil/trace.go:171","msg":"trace[1329089023] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"1.165538638s","start":"2026-09-11T03:56:31.303906Z","end":"2026-09-11T03:56:32.469445Z","steps":["trace[1329089023] 'process raft request' (duration: 940.191512ms)","trace[1329089023] 'compare' (duration: 224.82653ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T03:56:32.469563Z","caller":"traceutil/trace.go:171","msg":"trace[602512550] linearizableReadLoop","detail":"{readStateIndex:242; appliedIndex:240; }","duration":"1.152713187s","start":"2026-09-11T03:56:31.316815Z","end":"2026-09-11T03:56:32.469529Z","steps":["trace[602512550] 'read index received' (duration: 100.119158ms)","trace[602512550] 'applied index is now lower than readState.Index' (duration: 1.052591389s)"],"step_count":2} {"level":"warn","ts":"2026-09-11T03:56:32.469644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:56:31.345601Z","time spent":"1.123985729s","remote":"127.0.0.1:39800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-11T03:56:32.469551Z","caller":"traceutil/trace.go:171","msg":"trace[1423572262] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"478.692895ms","start":"2026-09-11T03:56:31.990838Z","end":"2026-09-11T03:56:32.469531Z","steps":["trace[1423572262] 'process raft request' (duration: 478.615323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:56:32.469727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.152891643s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-09-11T03:56:32.469769Z","caller":"traceutil/trace.go:171","msg":"trace[1374414361] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:238; }","duration":"1.152945904s","start":"2026-09-11T03:56:31.31681Z","end":"2026-09-11T03:56:32.469756Z","steps":["trace[1374414361] 'agreement among raft nodes before linearized reading' (duration: 1.15281124s)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:56:32.469806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:56:31.316781Z","time spent":"1.153015466s","remote":"127.0.0.1:39968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-11T03:56:32.469692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:56:31.303878Z","time spent":"1.165729424s","remote":"127.0.0.1:39882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-11T03:56:32.469943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:56:31.990808Z","time spent":"478.960694ms","remote":"127.0.0.1:39894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":689,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-11T03:57:16.629288Z","caller":"traceutil/trace.go:171","msg":"trace[2135093360] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"335.028796ms","start":"2026-09-11T03:57:16.294234Z","end":"2026-09-11T03:57:16.629262Z","steps":["trace[2135093360] 'process raft request' (duration: 334.376598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:57:16.629581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:57:16.294204Z","time spent":"335.278888ms","remote":"127.0.0.1:39798","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T03:57:17.281491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.067501ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-11T03:57:17.281693Z","caller":"traceutil/trace.go:171","msg":"trace[1844937101] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"575.064305ms","start":"2026-09-11T03:57:16.706615Z","end":"2026-09-11T03:57:17.28168Z","steps":["trace[1844937101] 'read index received' (duration: 134.881µs)","trace[1844937101] 'applied index is now lower than readState.Index' (duration: 574.928684ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T03:57:17.281805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.183307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-09-11T03:57:17.281829Z","caller":"traceutil/trace.go:171","msg":"trace[1480523623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"575.258157ms","start":"2026-09-11T03:57:16.706562Z","end":"2026-09-11T03:57:17.281821Z","steps":["trace[1480523623] 'agreement among raft nodes before linearized reading' (duration: 575.202666ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:57:17.281857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:57:16.706538Z","time spent":"575.313127ms","remote":"127.0.0.1:39968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-11T03:57:17.282154Z","caller":"traceutil/trace.go:171","msg":"trace[969806811] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"575.072447ms","start":"2026-09-11T03:57:16.707074Z","end":"2026-09-11T03:57:17.282146Z","steps":["trace[969806811] 'process raft request' (duration: 574.51657ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:57:17.28221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:57:16.70705Z","time spent":"575.118977ms","remote":"127.0.0.1:40198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-11T03:57:17.312327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.657918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-11T03:57:17.31237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.892119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T03:57:17.31242Z","caller":"traceutil/trace.go:171","msg":"trace[1426980617] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"470.98281ms","start":"2026-09-11T03:57:16.841421Z","end":"2026-09-11T03:57:17.312404Z","steps":["trace[1426980617] 'agreement among raft nodes before linearized reading' (duration: 440.732009ms)","trace[1426980617] 'range keys from in-memory index tree' (duration: 30.17498ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T03:57:17.312419Z","caller":"traceutil/trace.go:171","msg":"trace[1391674222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:649; }","duration":"582.821599ms","start":"2026-09-11T03:57:16.729574Z","end":"2026-09-11T03:57:17.312396Z","steps":["trace[1391674222] 'agreement among raft nodes before linearized reading' (duration: 552.561519ms)","trace[1391674222] 'range keys from in-memory index tree' (duration: 30.104079ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T03:57:17.31246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:57:16.841394Z","time spent":"471.05821ms","remote":"127.0.0.1:39712","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-09-11T03:57:17.312483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:57:16.729551Z","time spent":"582.925151ms","remote":"127.0.0.1:39968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-11T03:57:33.577672Z","caller":"traceutil/trace.go:171","msg":"trace[1899859412] linearizableReadLoop","detail":"{readStateIndex:847; appliedIndex:846; }","duration":"181.912282ms","start":"2026-09-11T03:57:33.395735Z","end":"2026-09-11T03:57:33.577647Z","steps":["trace[1899859412] 'read index received' (duration: 181.73417ms)","trace[1899859412] 'applied index is now lower than readState.Index' (duration: 176.922µs)"],"step_count":2} {"level":"info","ts":"2026-09-11T03:57:33.577809Z","caller":"traceutil/trace.go:171","msg":"trace[1625161990] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"241.378872ms","start":"2026-09-11T03:57:33.336421Z","end":"2026-09-11T03:57:33.5778Z","steps":["trace[1625161990] 'process raft request' (duration: 241.087367ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:57:33.577982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.53339ms","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-09-11T03:57:33.578045Z","caller":"traceutil/trace.go:171","msg":"trace[1325167192] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:814; }","duration":"123.637231ms","start":"2026-09-11T03:57:33.454395Z","end":"2026-09-11T03:57:33.578032Z","steps":["trace[1325167192] 'agreement among raft nodes before linearized reading' (duration: 123.479139ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:57:33.578223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.189444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T03:57:33.578271Z","caller":"traceutil/trace.go:171","msg":"trace[281305374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"119.245024ms","start":"2026-09-11T03:57:33.459011Z","end":"2026-09-11T03:57:33.578256Z","steps":["trace[281305374] 'agreement among raft nodes before linearized reading' (duration: 119.165703ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:57:33.578386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.652073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-09-11T03:57:33.57824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.239725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-11T03:57:33.578412Z","caller":"traceutil/trace.go:171","msg":"trace[1808444934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:814; }","duration":"182.705835ms","start":"2026-09-11T03:57:33.3957Z","end":"2026-09-11T03:57:33.578405Z","steps":["trace[1808444934] 'agreement among raft nodes before linearized reading' (duration: 182.645754ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:57:33.578421Z","caller":"traceutil/trace.go:171","msg":"trace[186076683] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:814; }","duration":"123.460329ms","start":"2026-09-11T03:57:33.454951Z","end":"2026-09-11T03:57:33.578411Z","steps":["trace[186076683] 'agreement among raft nodes before linearized reading' (duration: 123.243035ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:57:33.743573Z","caller":"traceutil/trace.go:171","msg":"trace[1161713645] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"160.427574ms","start":"2026-09-11T03:57:33.583122Z","end":"2026-09-11T03:57:33.74355Z","steps":["trace[1161713645] 'process raft request' (duration: 160.391653ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:57:33.743625Z","caller":"traceutil/trace.go:171","msg":"trace[91862291] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"160.497075ms","start":"2026-09-11T03:57:33.58309Z","end":"2026-09-11T03:57:33.743587Z","steps":["trace[91862291] 'process raft request' (duration: 160.308652ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:57:33.746732Z","caller":"traceutil/trace.go:171","msg":"trace[1064499336] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"163.287387ms","start":"2026-09-11T03:57:33.583417Z","end":"2026-09-11T03:57:33.746705Z","steps":["trace[1064499336] 'process raft request' (duration: 163.087634ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:58:31.402988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.240339ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-11T03:58:31.403128Z","caller":"traceutil/trace.go:171","msg":"trace[478533776] transaction","detail":"{read_only:false; response_revision:1490; number_of_response:1; }","duration":"141.787398ms","start":"2026-09-11T03:58:31.26132Z","end":"2026-09-11T03:58:31.403108Z","steps":["trace[478533776] 'process raft request' (duration: 31.323542ms)","trace[478533776] 'compare' (duration: 110.044995ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T03:58:31.412487Z","caller":"traceutil/trace.go:171","msg":"trace[1390781614] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"148.606999ms","start":"2026-09-11T03:58:31.26386Z","end":"2026-09-11T03:58:31.412467Z","steps":["trace[1390781614] 'process raft request' (duration: 148.501206ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:58:32.883785Z","caller":"traceutil/trace.go:171","msg":"trace[717015302] transaction","detail":"{read_only:false; response_revision:1498; number_of_response:1; }","duration":"216.31296ms","start":"2026-09-11T03:58:32.667443Z","end":"2026-09-11T03:58:32.883756Z","steps":["trace[717015302] 'process raft request' (duration: 216.116736ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:58:57.793771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.393099ms","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":"warn","ts":"2026-09-11T03:58:57.794034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.576152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T03:58:57.794079Z","caller":"traceutil/trace.go:171","msg":"trace[1739193132] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1902; }","duration":"235.661244ms","start":"2026-09-11T03:58:57.558407Z","end":"2026-09-11T03:58:57.794068Z","steps":["trace[1739193132] 'count revisions from in-memory index tree' (duration: 235.434548ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:58:57.79409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.166679ms","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-09-11T03:58:57.79419Z","caller":"traceutil/trace.go:171","msg":"trace[2127294616] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1902; }","duration":"123.315903ms","start":"2026-09-11T03:58:57.670854Z","end":"2026-09-11T03:58:57.79417Z","steps":["trace[2127294616] 'range keys from in-memory index tree' (duration: 122.954293ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:58:57.793767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.379009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2df3dd19-49bd-4f99-a811-b6b055a80c0c\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-11T03:58:57.793849Z","caller":"traceutil/trace.go:171","msg":"trace[206363393] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1902; }","duration":"160.497162ms","start":"2026-09-11T03:58:57.633333Z","end":"2026-09-11T03:58:57.79383Z","steps":["trace[206363393] 'range keys from in-memory index tree' (duration: 160.230465ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:58:57.794421Z","caller":"traceutil/trace.go:171","msg":"trace[219685299] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2df3dd19-49bd-4f99-a811-b6b055a80c0c; range_end:; response_count:1; response_revision:1902; }","duration":"161.059446ms","start":"2026-09-11T03:58:57.633333Z","end":"2026-09-11T03:58:57.794393Z","steps":["trace[219685299] 'range keys from in-memory index tree' (duration: 160.188394ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:58:57.968149Z","caller":"traceutil/trace.go:171","msg":"trace[553625550] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"169.430481ms","start":"2026-09-11T03:58:57.798684Z","end":"2026-09-11T03:58:57.968114Z","steps":["trace[553625550] 'process raft request' (duration: 101.092464ms)","trace[553625550] 'compare' (duration: 68.04591ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T03:58:57.968345Z","caller":"traceutil/trace.go:171","msg":"trace[754901122] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"165.944901ms","start":"2026-09-11T03:58:57.802389Z","end":"2026-09-11T03:58:57.968334Z","steps":["trace[754901122] 'process raft request' (duration: 165.756167ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:58:57.96827Z","caller":"traceutil/trace.go:171","msg":"trace[1395099120] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1982; }","duration":"117.75786ms","start":"2026-09-11T03:58:57.850489Z","end":"2026-09-11T03:58:57.968247Z","steps":["trace[1395099120] 'read index received' (duration: 49.228109ms)","trace[1395099120] 'applied index is now lower than readState.Index' (duration: 68.528731ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T03:58:57.968818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.292144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-11T03:58:57.96889Z","caller":"traceutil/trace.go:171","msg":"trace[1739008016] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1905; }","duration":"118.428488ms","start":"2026-09-11T03:58:57.850445Z","end":"2026-09-11T03:58:57.968873Z","steps":["trace[1739008016] 'agreement among raft nodes before linearized reading' (duration: 118.282224ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:59:27.12855Z","caller":"traceutil/trace.go:171","msg":"trace[611424803] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"119.189234ms","start":"2026-09-11T03:59:27.009335Z","end":"2026-09-11T03:59:27.128524Z","steps":["trace[611424803] 'process raft request' (duration: 119.03253ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:59:33.329891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.139498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-11T03:59:33.32997Z","caller":"traceutil/trace.go:171","msg":"trace[2009087640] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2150; }","duration":"331.266172ms","start":"2026-09-11T03:59:32.998686Z","end":"2026-09-11T03:59:33.329952Z","steps":["trace[2009087640] 'count revisions from in-memory index tree' (duration: 331.025886ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:59:33.330009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T03:59:32.99861Z","time spent":"331.389345ms","remote":"127.0.0.1:40174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":12,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-09-11T03:59:33.330346Z","caller":"traceutil/trace.go:171","msg":"trace[1067879260] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"146.581283ms","start":"2026-09-11T03:59:33.183737Z","end":"2026-09-11T03:59:33.330318Z","steps":["trace[1067879260] 'process raft request' (duration: 135.389339ms)","trace[1067879260] 'compare' (duration: 10.443834ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T03:59:33.336409Z","caller":"traceutil/trace.go:171","msg":"trace[1341987525] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2238; }","duration":"127.759162ms","start":"2026-09-11T03:59:33.208617Z","end":"2026-09-11T03:59:33.336377Z","steps":["trace[1341987525] 'read index received' (duration: 110.522393ms)","trace[1341987525] 'applied index is now lower than readState.Index' (duration: 17.235839ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T03:59:33.33651Z","caller":"traceutil/trace.go:171","msg":"trace[2002046473] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"134.242018ms","start":"2026-09-11T03:59:33.20225Z","end":"2026-09-11T03:59:33.336492Z","steps":["trace[2002046473] 'process raft request' (duration: 133.982661ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T03:59:33.336729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.090241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-09-11T03:59:33.336771Z","caller":"traceutil/trace.go:171","msg":"trace[527830069] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2153; }","duration":"128.175453ms","start":"2026-09-11T03:59:33.208581Z","end":"2026-09-11T03:59:33.336757Z","steps":["trace[527830069] 'agreement among raft nodes before linearized reading' (duration: 127.940287ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:59:33.337079Z","caller":"traceutil/trace.go:171","msg":"trace[344630432] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"143.266464ms","start":"2026-09-11T03:59:33.193025Z","end":"2026-09-11T03:59:33.336292Z","steps":["trace[344630432] 'process raft request' (duration: 143.10454ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T03:59:33.525144Z","caller":"traceutil/trace.go:171","msg":"trace[1465626114] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"184.396091ms","start":"2026-09-11T03:59:33.340724Z","end":"2026-09-11T03:59:33.52512Z","steps":["trace[1465626114] 'process raft request' (duration: 184.158074ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T04:00:42.10704Z","caller":"traceutil/trace.go:171","msg":"trace[821719431] transaction","detail":"{read_only:false; response_revision:2621; number_of_response:1; }","duration":"204.475082ms","start":"2026-09-11T04:00:41.902537Z","end":"2026-09-11T04:00:42.107012Z","steps":["trace[821719431] 'process raft request' (duration: 204.05177ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T04:06:08.622268Z","caller":"traceutil/trace.go:171","msg":"trace[1846720399] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"155.771302ms","start":"2026-09-11T04:06:08.46645Z","end":"2026-09-11T04:06:08.622221Z","steps":["trace[1846720399] 'process raft request' (duration: 155.580967ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T04:06:14.072213Z","caller":"traceutil/trace.go:171","msg":"trace[1347602710] transaction","detail":"{read_only:false; response_revision:5131; number_of_response:1; }","duration":"255.76307ms","start":"2026-09-11T04:06:13.816408Z","end":"2026-09-11T04:06:14.072171Z","steps":["trace[1347602710] 'process raft request' (duration: 255.588715ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T04:06:14.072239Z","caller":"traceutil/trace.go:171","msg":"trace[1582593636] linearizableReadLoop","detail":"{readStateIndex:5330; appliedIndex:5329; }","duration":"232.769212ms","start":"2026-09-11T04:06:13.839364Z","end":"2026-09-11T04:06:14.072134Z","steps":["trace[1582593636] 'read index received' (duration: 232.559137ms)","trace[1582593636] 'applied index is now lower than readState.Index' (duration: 208.815µs)"],"step_count":2} {"level":"warn","ts":"2026-09-11T04:06:14.0724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.015989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T04:06:14.072477Z","caller":"traceutil/trace.go:171","msg":"trace[1796772392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5131; }","duration":"233.134013ms","start":"2026-09-11T04:06:13.839323Z","end":"2026-09-11T04:06:14.072457Z","steps":["trace[1796772392] 'agreement among raft nodes before linearized reading' (duration: 232.966878ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T04:06:14.244126Z","caller":"traceutil/trace.go:171","msg":"trace[1567551079] linearizableReadLoop","detail":"{readStateIndex:5332; appliedIndex:5331; }","duration":"101.144746ms","start":"2026-09-11T04:06:14.142956Z","end":"2026-09-11T04:06:14.244101Z","steps":["trace[1567551079] 'read index received' (duration: 88.688102ms)","trace[1567551079] 'applied index is now lower than readState.Index' (duration: 12.455354ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T04:06:14.244235Z","caller":"traceutil/trace.go:171","msg":"trace[837962550] transaction","detail":"{read_only:false; response_revision:5133; number_of_response:1; }","duration":"162.805586ms","start":"2026-09-11T04:06:14.081385Z","end":"2026-09-11T04:06:14.244191Z","steps":["trace[837962550] 'process raft request' (duration: 150.261669ms)","trace[837962550] 'compare' (duration: 12.345571ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T04:06:14.24431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.322231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-11T04:06:14.244535Z","caller":"traceutil/trace.go:171","msg":"trace[1400281503] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:5133; }","duration":"101.423904ms","start":"2026-09-11T04:06:14.142911Z","end":"2026-09-11T04:06:14.244335Z","steps":["trace[1400281503] 'agreement among raft nodes before linearized reading' (duration: 101.335942ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T04:06:27.754371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.782011ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-11T04:06:27.754483Z","caller":"traceutil/trace.go:171","msg":"trace[2054957503] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5304; }","duration":"294.956996ms","start":"2026-09-11T04:06:27.459503Z","end":"2026-09-11T04:06:27.75446Z","steps":["trace[2054957503] 'range keys from in-memory index tree' (duration: 294.556415ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T04:06:27.754539Z","caller":"traceutil/trace.go:171","msg":"trace[124227378] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"103.245519ms","start":"2026-09-11T04:06:27.651255Z","end":"2026-09-11T04:06:27.754501Z","steps":["trace[124227378] 'process raft request' (duration: 77.309189ms)","trace[124227378] 'compare' (duration: 25.799027ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T04:06:27.755083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.769422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-11T04:06:27.755103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.649503ms","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-09-11T04:06:27.755161Z","caller":"traceutil/trace.go:171","msg":"trace[420657485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5304; }","duration":"368.762386ms","start":"2026-09-11T04:06:27.386387Z","end":"2026-09-11T04:06:27.755149Z","steps":["trace[420657485] 'range keys from in-memory index tree' (duration: 367.375516ms)"],"step_count":1} {"level":"info","ts":"2026-09-11T04:06:27.755162Z","caller":"traceutil/trace.go:171","msg":"trace[128913455] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:5304; }","duration":"113.940376ms","start":"2026-09-11T04:06:27.641204Z","end":"2026-09-11T04:06:27.755145Z","steps":["trace[128913455] 'count revisions from in-memory index tree' (duration: 112.668309ms)"],"step_count":1} {"level":"warn","ts":"2026-09-11T04:06:27.75519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T04:06:27.386365Z","time spent":"368.817677ms","remote":"127.0.0.1:39968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-11T04:06:27.815736Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2869} {"level":"warn","ts":"2026-09-11T04:06:27.991213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.870012ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-11T04:06:27.991435Z","caller":"traceutil/trace.go:171","msg":"trace[1896311597] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"231.504704ms","start":"2026-09-11T04:06:27.759896Z","end":"2026-09-11T04:06:27.991401Z","steps":["trace[1896311597] 'process raft request' (duration: 60.319893ms)","trace[1896311597] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-scheduler; req_size:461; } (duration: 170.626135ms)"],"step_count":2} {"level":"warn","ts":"2026-09-11T04:06:28.113486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.974665ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-11T04:06:28.113639Z","caller":"traceutil/trace.go:171","msg":"trace[823447610] linearizableReadLoop","detail":"{readStateIndex:5514; appliedIndex:5512; }","duration":"137.457037ms","start":"2026-09-11T04:06:27.976159Z","end":"2026-09-11T04:06:28.113616Z","steps":["trace[823447610] 'read index received' (duration: 94.922µs)","trace[823447610] 'applied index is now lower than readState.Index' (duration: 137.358285ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T04:06:28.113751Z","caller":"traceutil/trace.go:171","msg":"trace[42170272] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"352.782289ms","start":"2026-09-11T04:06:27.760867Z","end":"2026-09-11T04:06:28.113649Z","steps":["trace[42170272] 'process raft request' (duration: 230.511685ms)","trace[42170272] 'compare' (duration: 16.931454ms)","trace[42170272] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; req_size:541; } (duration: 104.787354ms)"],"step_count":3} {"level":"warn","ts":"2026-09-11T04:06:28.114167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-11T04:06:27.760839Z","time spent":"353.17099ms","remote":"127.0.0.1:39968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-11T04:06:28.139183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.977996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-09-11T04:06:28.139305Z","caller":"traceutil/trace.go:171","msg":"trace[1984407793] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5307; }","duration":"163.154692ms","start":"2026-09-11T04:06:27.976118Z","end":"2026-09-11T04:06:28.139272Z","steps":["trace[1984407793] 'agreement among raft nodes before linearized reading' (duration: 137.55645ms)","trace[1984407793] 'range keys from in-memory index tree' (duration: 25.252061ms)"],"step_count":2} {"level":"info","ts":"2026-09-11T04:06:28.161335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2869,"took":"344.257115ms","hash":499006250,"current-db-size-bytes":52584448,"current-db-size":"53 MB","current-db-size-in-use-bytes":27746304,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-11T04:06:28.161422Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":499006250,"revision":2869,"compact-revision":-1} {"level":"info","ts":"2026-09-11T04:11:27.822159Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5305} {"level":"info","ts":"2026-09-11T04:11:27.908826Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5305,"took":"85.08794ms","hash":4078387145,"current-db-size-bytes":52584448,"current-db-size":"53 MB","current-db-size-in-use-bytes":19644416,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-11T04:11:27.908868Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4078387145,"revision":5305,"compact-revision":2869}