{"level":"warn","ts":"2026-05-29T05:08:35.583049Z","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-29T05:08:35.583139Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38: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-29T05:08:35.58321Z","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-29T05:08:35.583222Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-29T05:08:35.583237Z","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-29T05:08:35.583821Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-05-29T05:08:35.583888Z","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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38: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-29T05:08:35.588136Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.084765ms"} {"level":"info","ts":"2026-05-29T05:08:35.595923Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-05-29T05:08:35.596022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-05-29T05:08:35.596045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-05-29T05:08:35.596063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-29T05:08:35.596077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-05-29T05:08:35.596117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-05-29T05:08:35.603483Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-29T05:08:35.604707Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-29T05:08:35.60637Z","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-29T05:08:35.608345Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-29T05:08:35.608449Z","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-29T05:08:35.608553Z","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-29T05:08:35.608564Z","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-29T05:08:35.608594Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-29T05:08:35.610397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-05-29T05:08:35.610663Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-05-29T05:08:35.614266Z","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-29T05:08:35.614605Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-29T05:08:35.614644Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-29T05:08:35.615702Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-29T05:08:35.615751Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-05-29T05:08:35.796902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-05-29T05:08:35.796954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-29T05:08:35.796986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-05-29T05:08:35.797001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-05-29T05:08:35.797021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-29T05:08:35.79704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-05-29T05:08:35.797047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-05-29T05:08:35.799023Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-05-29T05:08:35.800369Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:08:35.801289Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T05:08:35.801648Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-29T05:08:35.801888Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-29T05:08:35.801911Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-29T05:08:35.801943Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:08:35.802032Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:08:35.802056Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-29T05:08:35.80383Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-29T05:08:35.804025Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"warn","ts":"2026-05-29T05:08:37.820387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.01866ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-05-29T05:08:37.820522Z","caller":"traceutil/trace.go:171","msg":"trace[1819570035] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"216.874661ms","start":"2026-05-29T05:08:37.603625Z","end":"2026-05-29T05:08:37.820499Z","steps":["trace[1819570035] 'process raft request' (duration: 105.230174ms)","trace[1819570035] 'compare' (duration: 110.892539ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:08:37.820728Z","caller":"traceutil/trace.go:171","msg":"trace[1705236701] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"215.443546ms","start":"2026-05-29T05:08:37.605277Z","end":"2026-05-29T05:08:37.82072Z","steps":["trace[1705236701] 'process raft request' (duration: 215.269915ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:37.820742Z","caller":"traceutil/trace.go:171","msg":"trace[427972314] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"211.273079ms","start":"2026-05-29T05:08:37.609456Z","end":"2026-05-29T05:08:37.820729Z","steps":["trace[427972314] 'process raft request' (duration: 211.240079ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:37.820871Z","caller":"traceutil/trace.go:171","msg":"trace[440046556] linearizableReadLoop","detail":"{readStateIndex:10; appliedIndex:9; }","duration":"216.952432ms","start":"2026-05-29T05:08:37.603909Z","end":"2026-05-29T05:08:37.820861Z","steps":["trace[440046556] 'read index received' (duration: 105.008302ms)","trace[440046556] 'applied index is now lower than readState.Index' (duration: 111.94298ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:08:37.820791Z","caller":"traceutil/trace.go:171","msg":"trace[750980708] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"215.013011ms","start":"2026-05-29T05:08:37.605732Z","end":"2026-05-29T05:08:37.820745Z","steps":["trace[750980708] 'process raft request' (duration: 214.91582ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:37.820938Z","caller":"traceutil/trace.go:171","msg":"trace[1822859996] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"214.738028ms","start":"2026-05-29T05:08:37.60619Z","end":"2026-05-29T05:08:37.820928Z","steps":["trace[1822859996] 'process raft request' (duration: 214.479455ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:37.820993Z","caller":"traceutil/trace.go:171","msg":"trace[1886197846] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"216.447897ms","start":"2026-05-29T05:08:37.60453Z","end":"2026-05-29T05:08:37.820978Z","steps":["trace[1886197846] 'process raft request' (duration: 215.973762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:37.821203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.285765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-29T05:08:37.821238Z","caller":"traceutil/trace.go:171","msg":"trace[1922507899] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:14; }","duration":"217.338806ms","start":"2026-05-29T05:08:37.603889Z","end":"2026-05-29T05:08:37.821228Z","steps":["trace[1922507899] 'agreement among raft nodes before linearized reading' (duration: 217.222285ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:37.821305Z","caller":"traceutil/trace.go:171","msg":"trace[1475761076] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"215.85762ms","start":"2026-05-29T05:08:37.605438Z","end":"2026-05-29T05:08:37.821296Z","steps":["trace[1475761076] 'process raft request' (duration: 215.135493ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:37.821375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.2105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-29T05:08:37.821408Z","caller":"traceutil/trace.go:171","msg":"trace[1263161440] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:14; }","duration":"170.256671ms","start":"2026-05-29T05:08:37.651143Z","end":"2026-05-29T05:08:37.8214Z","steps":["trace[1263161440] 'agreement among raft nodes before linearized reading' (duration: 170.1961ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:37.821427Z","caller":"traceutil/trace.go:171","msg":"trace[832536224] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"215.870402ms","start":"2026-05-29T05:08:37.605534Z","end":"2026-05-29T05:08:37.821404Z","steps":["trace[832536224] 'process raft request' (duration: 215.084922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:42.750434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.693169ms","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-29T05:08:42.750547Z","caller":"traceutil/trace.go:171","msg":"trace[602381046] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:279; }","duration":"198.83649ms","start":"2026-05-29T05:08:42.551681Z","end":"2026-05-29T05:08:42.750518Z","steps":["trace[602381046] 'range keys from in-memory index tree' (duration: 198.607977ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:42.882261Z","caller":"traceutil/trace.go:171","msg":"trace[1381573599] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"127.457683ms","start":"2026-05-29T05:08:42.754771Z","end":"2026-05-29T05:08:42.882229Z","steps":["trace[1381573599] 'process raft request' (duration: 127.356892ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:43.191694Z","caller":"traceutil/trace.go:171","msg":"trace[1066857264] transaction","detail":"{read_only:false; response_revision:281; number_of_response:1; }","duration":"303.492997ms","start":"2026-05-29T05:08:42.888175Z","end":"2026-05-29T05:08:43.191668Z","steps":["trace[1066857264] 'process raft request' (duration: 303.352145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:43.192277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:08:42.888158Z","time spent":"303.611948ms","remote":"127.0.0.1:41000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":178,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-29T05:08:43.193419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.436987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-29T05:08:43.193501Z","caller":"traceutil/trace.go:171","msg":"trace[891781893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:281; }","duration":"286.545709ms","start":"2026-05-29T05:08:42.906934Z","end":"2026-05-29T05:08:43.19348Z","steps":["trace[891781893] 'agreement among raft nodes before linearized reading' (duration: 286.381587ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:43.19386Z","caller":"traceutil/trace.go:171","msg":"trace[234460146] linearizableReadLoop","detail":"{readStateIndex:289; appliedIndex:288; }","duration":"286.293816ms","start":"2026-05-29T05:08:42.906971Z","end":"2026-05-29T05:08:43.193265Z","steps":["trace[234460146] 'read index received' (duration: 284.521478ms)","trace[234460146] 'applied index is now lower than readState.Index' (duration: 1.770048ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:08:43.194028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.704736ms","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-05-29T05:08:43.194066Z","caller":"traceutil/trace.go:171","msg":"trace[657383956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:281; }","duration":"162.767767ms","start":"2026-05-29T05:08:43.031289Z","end":"2026-05-29T05:08:43.194057Z","steps":["trace[657383956] 'agreement among raft nodes before linearized reading' (duration: 162.699116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:43.194206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.244391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-29T05:08:43.19431Z","caller":"traceutil/trace.go:171","msg":"trace[2145207800] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:281; }","duration":"160.367992ms","start":"2026-05-29T05:08:43.033921Z","end":"2026-05-29T05:08:43.194289Z","steps":["trace[2145207800] 'agreement among raft nodes before linearized reading' (duration: 160.17734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:59.287572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.958127ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:08:59.288001Z","caller":"traceutil/trace.go:171","msg":"trace[1642813953] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"262.842515ms","start":"2026-05-29T05:08:59.025129Z","end":"2026-05-29T05:08:59.287972Z","steps":["trace[1642813953] 'process raft request' (duration: 148.429253ms)","trace[1642813953] 'compare' (duration: 113.858916ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:08:59.28816Z","caller":"traceutil/trace.go:171","msg":"trace[1162676807] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"256.639319ms","start":"2026-05-29T05:08:59.031511Z","end":"2026-05-29T05:08:59.28815Z","steps":["trace[1162676807] 'process raft request' (duration: 256.381766ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.288236Z","caller":"traceutil/trace.go:171","msg":"trace[812071510] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"263.033537ms","start":"2026-05-29T05:08:59.025195Z","end":"2026-05-29T05:08:59.288228Z","steps":["trace[812071510] 'process raft request' (duration: 262.625363ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.288382Z","caller":"traceutil/trace.go:171","msg":"trace[287570874] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"256.555078ms","start":"2026-05-29T05:08:59.031809Z","end":"2026-05-29T05:08:59.288364Z","steps":["trace[287570874] 'process raft request' (duration: 256.135963ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.288416Z","caller":"traceutil/trace.go:171","msg":"trace[1063886301] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"256.935781ms","start":"2026-05-29T05:08:59.03147Z","end":"2026-05-29T05:08:59.288405Z","steps":["trace[1063886301] 'process raft request' (duration: 256.393835ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.288472Z","caller":"traceutil/trace.go:171","msg":"trace[1546966019] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:463; }","duration":"259.949349ms","start":"2026-05-29T05:08:59.028513Z","end":"2026-05-29T05:08:59.288462Z","steps":["trace[1546966019] 'read index received' (duration: 59.817509ms)","trace[1546966019] 'applied index is now lower than readState.Index' (duration: 200.13086ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:08:59.288578Z","caller":"traceutil/trace.go:171","msg":"trace[1302410042] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"257.001122ms","start":"2026-05-29T05:08:59.031565Z","end":"2026-05-29T05:08:59.288566Z","steps":["trace[1302410042] 'process raft request' (duration: 256.355806ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.288595Z","caller":"traceutil/trace.go:171","msg":"trace[388579318] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"255.167885ms","start":"2026-05-29T05:08:59.033418Z","end":"2026-05-29T05:08:59.288585Z","steps":["trace[388579318] 'process raft request' (duration: 254.552698ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.288745Z","caller":"traceutil/trace.go:171","msg":"trace[2137977748] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"247.336754ms","start":"2026-05-29T05:08:59.041383Z","end":"2026-05-29T05:08:59.28872Z","steps":["trace[2137977748] 'process raft request' (duration: 246.614127ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.28885Z","caller":"traceutil/trace.go:171","msg":"trace[778850408] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"241.397558ms","start":"2026-05-29T05:08:59.047446Z","end":"2026-05-29T05:08:59.288844Z","steps":["trace[778850408] 'process raft request' (duration: 240.719292ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:59.289013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.493753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:08:59.289094Z","caller":"traceutil/trace.go:171","msg":"trace[55873724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:462; }","duration":"260.596955ms","start":"2026-05-29T05:08:59.028488Z","end":"2026-05-29T05:08:59.289085Z","steps":["trace[55873724] 'agreement among raft nodes before linearized reading' (duration: 260.484524ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.289089Z","caller":"traceutil/trace.go:171","msg":"trace[439642238] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"230.76682ms","start":"2026-05-29T05:08:59.058306Z","end":"2026-05-29T05:08:59.289073Z","steps":["trace[439642238] 'process raft request' (duration: 230.058064ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.310429Z","caller":"traceutil/trace.go:171","msg":"trace[267422886] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"217.634581ms","start":"2026-05-29T05:08:59.092779Z","end":"2026-05-29T05:08:59.310413Z","steps":["trace[267422886] 'process raft request' (duration: 217.440488ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.310438Z","caller":"traceutil/trace.go:171","msg":"trace[946227747] transaction","detail":"{read_only:false; number_of_response:1; response_revision:464; }","duration":"217.577971ms","start":"2026-05-29T05:08:59.09284Z","end":"2026-05-29T05:08:59.310418Z","steps":["trace[946227747] 'process raft request' (duration: 217.540199ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.310509Z","caller":"traceutil/trace.go:171","msg":"trace[15278751] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"217.696531ms","start":"2026-05-29T05:08:59.092806Z","end":"2026-05-29T05:08:59.310502Z","steps":["trace[15278751] 'process raft request' (duration: 217.525399ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.386796Z","caller":"traceutil/trace.go:171","msg":"trace[1022525736] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"192.795343ms","start":"2026-05-29T05:08:59.193984Z","end":"2026-05-29T05:08:59.386779Z","steps":["trace[1022525736] 'process raft request' (duration: 192.47113ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:59.387225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.821913ms","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-05-29T05:08:59.387269Z","caller":"traceutil/trace.go:171","msg":"trace[1944399979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:473; }","duration":"104.877854ms","start":"2026-05-29T05:08:59.282381Z","end":"2026-05-29T05:08:59.387259Z","steps":["trace[1944399979] 'agreement among raft nodes before linearized reading' (duration: 104.752743ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:59.387271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.772695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-29T05:08:59.387353Z","caller":"traceutil/trace.go:171","msg":"trace[128548493] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:473; }","duration":"276.867756ms","start":"2026-05-29T05:08:59.110467Z","end":"2026-05-29T05:08:59.387334Z","steps":["trace[128548493] 'agreement among raft nodes before linearized reading' (duration: 276.707344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:59.474759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.4223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-29T05:08:59.474903Z","caller":"traceutil/trace.go:171","msg":"trace[507013874] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:473; }","duration":"204.603941ms","start":"2026-05-29T05:08:59.270279Z","end":"2026-05-29T05:08:59.474883Z","steps":["trace[507013874] 'agreement among raft nodes before linearized reading' (duration: 117.242318ms)","trace[507013874] 'range keys from in-memory index tree' (duration: 87.162631ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:08:59.475103Z","caller":"traceutil/trace.go:171","msg":"trace[214000792] transaction","detail":"{read_only:false; number_of_response:0; response_revision:473; }","duration":"162.713276ms","start":"2026-05-29T05:08:59.312362Z","end":"2026-05-29T05:08:59.475076Z","steps":["trace[214000792] 'process raft request' (duration: 149.946359ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.475236Z","caller":"traceutil/trace.go:171","msg":"trace[128276047] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"157.69274ms","start":"2026-05-29T05:08:59.317533Z","end":"2026-05-29T05:08:59.475225Z","steps":["trace[128276047] 'process raft request' (duration: 157.555109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:59.475282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.262413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:08:59.475283Z","caller":"traceutil/trace.go:171","msg":"trace[939028965] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"161.032ms","start":"2026-05-29T05:08:59.314173Z","end":"2026-05-29T05:08:59.475205Z","steps":["trace[939028965] 'process raft request' (duration: 160.734767ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.475361Z","caller":"traceutil/trace.go:171","msg":"trace[743377695] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:476; }","duration":"185.367304ms","start":"2026-05-29T05:08:59.289979Z","end":"2026-05-29T05:08:59.475347Z","steps":["trace[743377695] 'agreement among raft nodes before linearized reading' (duration: 185.243293ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.475363Z","caller":"traceutil/trace.go:171","msg":"trace[896904103] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"154.376039ms","start":"2026-05-29T05:08:59.320957Z","end":"2026-05-29T05:08:59.475333Z","steps":["trace[896904103] 'process raft request' (duration: 154.201477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:08:59.475456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.103817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-29T05:08:59.475535Z","caller":"traceutil/trace.go:171","msg":"trace[4313719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:476; }","duration":"178.204617ms","start":"2026-05-29T05:08:59.297311Z","end":"2026-05-29T05:08:59.475516Z","steps":["trace[4313719] 'agreement among raft nodes before linearized reading' (duration: 178.045846ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.494951Z","caller":"traceutil/trace.go:171","msg":"trace[820653651] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"103.756053ms","start":"2026-05-29T05:08:59.391184Z","end":"2026-05-29T05:08:59.494941Z","steps":["trace[820653651] 'process raft request' (duration: 103.519621ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:08:59.49521Z","caller":"traceutil/trace.go:171","msg":"trace[906054912] transaction","detail":"{read_only:false; number_of_response:0; response_revision:477; }","duration":"103.948125ms","start":"2026-05-29T05:08:59.391247Z","end":"2026-05-29T05:08:59.495195Z","steps":["trace[906054912] 'process raft request' (duration: 103.533931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:09:06.195341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.156274ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:09:06.19555Z","caller":"traceutil/trace.go:171","msg":"trace[1360179057] linearizableReadLoop","detail":"{readStateIndex:582; appliedIndex:580; }","duration":"261.300212ms","start":"2026-05-29T05:09:05.934232Z","end":"2026-05-29T05:09:06.195532Z","steps":["trace[1360179057] 'read index received' (duration: 108.558012ms)","trace[1360179057] 'applied index is now lower than readState.Index' (duration: 152.74117ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:09:06.195646Z","caller":"traceutil/trace.go:171","msg":"trace[1618411501] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"451.702704ms","start":"2026-05-29T05:09:05.743935Z","end":"2026-05-29T05:09:06.195637Z","steps":["trace[1618411501] 'process raft request' (duration: 451.549513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:09:06.19569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:09:05.743919Z","time spent":"451.751434ms","remote":"127.0.0.1:41024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:09:06.195776Z","caller":"traceutil/trace.go:171","msg":"trace[1899083230] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"578.295388ms","start":"2026-05-29T05:09:05.617429Z","end":"2026-05-29T05:09:06.195724Z","steps":["trace[1899083230] 'process raft request' (duration: 425.376377ms)","trace[1899083230] 'compare' (duration: 152.007203ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:09:06.195971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:09:05.61741Z","time spent":"578.443659ms","remote":"127.0.0.1:41038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-29T05:09:06.196065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.838436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4gh79\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-29T05:09:06.196091Z","caller":"traceutil/trace.go:171","msg":"trace[1626123059] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4gh79; range_end:; response_count:1; response_revision:564; }","duration":"261.901469ms","start":"2026-05-29T05:09:05.934182Z","end":"2026-05-29T05:09:06.196084Z","steps":["trace[1626123059] 'agreement among raft nodes before linearized reading' (duration: 261.797257ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:09:06.196295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.836544ms","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-29T05:09:06.196312Z","caller":"traceutil/trace.go:171","msg":"trace[1459686703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:564; }","duration":"192.893296ms","start":"2026-05-29T05:09:06.003414Z","end":"2026-05-29T05:09:06.196307Z","steps":["trace[1459686703] 'agreement among raft nodes before linearized reading' (duration: 192.810555ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:11:22.686562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.009739ms","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-29T05:11:22.686838Z","caller":"traceutil/trace.go:171","msg":"trace[815352308] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1619; }","duration":"102.289963ms","start":"2026-05-29T05:11:22.584509Z","end":"2026-05-29T05:11:22.686799Z","steps":["trace[815352308] 'range keys from in-memory index tree' (duration: 101.990929ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:11:22.695375Z","caller":"traceutil/trace.go:171","msg":"trace[1224923527] transaction","detail":"{read_only:false; response_revision:1620; number_of_response:1; }","duration":"108.804437ms","start":"2026-05-29T05:11:22.586536Z","end":"2026-05-29T05:11:22.695341Z","steps":["trace[1224923527] 'process raft request' (duration: 108.668795ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:11:43.044979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.673008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:11:43.04511Z","caller":"traceutil/trace.go:171","msg":"trace[719796839] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2241; }","duration":"196.568361ms","start":"2026-05-29T05:11:42.848524Z","end":"2026-05-29T05:11:43.045092Z","steps":["trace[719796839] 'read index received' (duration: 83.624178ms)","trace[719796839] 'applied index is now lower than readState.Index' (duration: 112.942903ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:11:43.045166Z","caller":"traceutil/trace.go:171","msg":"trace[1549128607] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"290.003512ms","start":"2026-05-29T05:11:42.755126Z","end":"2026-05-29T05:11:43.045129Z","steps":["trace[1549128607] 'process raft request' (duration: 177.069149ms)","trace[1549128607] 'compare' (duration: 112.518296ms)"],"step_count":2} {"level":"warn","ts":"2026-05-29T05:11:43.045402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.881986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-29T05:11:43.045458Z","caller":"traceutil/trace.go:171","msg":"trace[159548799] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2156; }","duration":"196.975177ms","start":"2026-05-29T05:11:42.848468Z","end":"2026-05-29T05:11:43.045444Z","steps":["trace[159548799] 'agreement among raft nodes before linearized reading' (duration: 196.758484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:11:43.046188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.327428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-05-29T05:11:43.046645Z","caller":"traceutil/trace.go:171","msg":"trace[711602235] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2156; }","duration":"172.823205ms","start":"2026-05-29T05:11:42.873798Z","end":"2026-05-29T05:11:43.046622Z","steps":["trace[711602235] 'agreement among raft nodes before linearized reading' (duration: 171.567057ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:11:43.253766Z","caller":"traceutil/trace.go:171","msg":"trace[1130737099] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"204.182363ms","start":"2026-05-29T05:11:43.049542Z","end":"2026-05-29T05:11:43.253725Z","steps":["trace[1130737099] 'process raft request' (duration: 198.46033ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:11:43.254092Z","caller":"traceutil/trace.go:171","msg":"trace[503630393] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"203.235889ms","start":"2026-05-29T05:11:43.050846Z","end":"2026-05-29T05:11:43.254082Z","steps":["trace[503630393] 'process raft request' (duration: 202.782072ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:11:43.254154Z","caller":"traceutil/trace.go:171","msg":"trace[1637000480] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"202.711372ms","start":"2026-05-29T05:11:43.051418Z","end":"2026-05-29T05:11:43.25413Z","steps":["trace[1637000480] 'process raft request' (duration: 202.57778ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:11:58.518848Z","caller":"traceutil/trace.go:171","msg":"trace[541248014] transaction","detail":"{read_only:false; response_revision:2296; number_of_response:1; }","duration":"122.989041ms","start":"2026-05-29T05:11:58.395837Z","end":"2026-05-29T05:11:58.518826Z","steps":["trace[541248014] 'process raft request' (duration: 122.744448ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:12:19.537Z","caller":"traceutil/trace.go:171","msg":"trace[52474074] transaction","detail":"{read_only:false; response_revision:2448; number_of_response:1; }","duration":"117.462451ms","start":"2026-05-29T05:12:19.419505Z","end":"2026-05-29T05:12:19.536967Z","steps":["trace[52474074] 'process raft request' (duration: 117.287319ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:12:20.775017Z","caller":"traceutil/trace.go:171","msg":"trace[1902234383] transaction","detail":"{read_only:false; response_revision:2453; number_of_response:1; }","duration":"154.942169ms","start":"2026-05-29T05:12:20.620047Z","end":"2026-05-29T05:12:20.774989Z","steps":["trace[1902234383] 'process raft request' (duration: 154.763007ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:12:20.796425Z","caller":"traceutil/trace.go:171","msg":"trace[1515526725] transaction","detail":"{read_only:false; response_revision:2454; number_of_response:1; }","duration":"175.265615ms","start":"2026-05-29T05:12:20.62113Z","end":"2026-05-29T05:12:20.796396Z","steps":["trace[1515526725] 'process raft request' (duration: 175.056353ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:12:20.796623Z","caller":"traceutil/trace.go:171","msg":"trace[533183345] transaction","detail":"{read_only:false; response_revision:2455; number_of_response:1; }","duration":"123.379726ms","start":"2026-05-29T05:12:20.673186Z","end":"2026-05-29T05:12:20.796565Z","steps":["trace[533183345] 'process raft request' (duration: 123.154413ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:13:19.887966Z","caller":"traceutil/trace.go:171","msg":"trace[536322792] linearizableReadLoop","detail":"{readStateIndex:2945; appliedIndex:2944; }","duration":"151.298157ms","start":"2026-05-29T05:13:19.736629Z","end":"2026-05-29T05:13:19.887927Z","steps":["trace[536322792] 'read index received' (duration: 151.125265ms)","trace[536322792] 'applied index is now lower than readState.Index' (duration: 172.182µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:13:19.888243Z","caller":"traceutil/trace.go:171","msg":"trace[1981109583] transaction","detail":"{read_only:false; response_revision:2836; number_of_response:1; }","duration":"167.725644ms","start":"2026-05-29T05:13:19.720505Z","end":"2026-05-29T05:13:19.88823Z","steps":["trace[1981109583] 'process raft request' (duration: 167.30408ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:13:19.888431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.783163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-29T05:13:19.888474Z","caller":"traceutil/trace.go:171","msg":"trace[1774172157] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:2836; }","duration":"151.851043ms","start":"2026-05-29T05:13:19.736611Z","end":"2026-05-29T05:13:19.888462Z","steps":["trace[1774172157] 'agreement among raft nodes before linearized reading' (duration: 151.778692ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:13:19.888757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.189481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-29T05:13:19.888795Z","caller":"traceutil/trace.go:171","msg":"trace[2094531618] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2836; }","duration":"134.227712ms","start":"2026-05-29T05:13:19.754558Z","end":"2026-05-29T05:13:19.888786Z","steps":["trace[2094531618] 'agreement among raft nodes before linearized reading' (duration: 134.04255ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:13:53.664401Z","caller":"traceutil/trace.go:171","msg":"trace[1144777172] transaction","detail":"{read_only:false; response_revision:3023; number_of_response:1; }","duration":"123.357828ms","start":"2026-05-29T05:13:53.54101Z","end":"2026-05-29T05:13:53.664368Z","steps":["trace[1144777172] 'process raft request' (duration: 122.120548ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:13:54.154888Z","caller":"traceutil/trace.go:171","msg":"trace[1188317777] linearizableReadLoop","detail":"{readStateIndex:3139; appliedIndex:3138; }","duration":"107.871805ms","start":"2026-05-29T05:13:54.046999Z","end":"2026-05-29T05:13:54.154871Z","steps":["trace[1188317777] 'read index received' (duration: 107.687449ms)","trace[1188317777] 'applied index is now lower than readState.Index' (duration: 183.666µs)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:13:54.155117Z","caller":"traceutil/trace.go:171","msg":"trace[1007393125] transaction","detail":"{read_only:false; response_revision:3024; number_of_response:1; }","duration":"108.37434ms","start":"2026-05-29T05:13:54.046732Z","end":"2026-05-29T05:13:54.155106Z","steps":["trace[1007393125] 'process raft request' (duration: 108.000168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:13:54.155414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.399961ms","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-29T05:13:54.155457Z","caller":"traceutil/trace.go:171","msg":"trace[1400662315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3024; }","duration":"108.488924ms","start":"2026-05-29T05:13:54.046957Z","end":"2026-05-29T05:13:54.155446Z","steps":["trace[1400662315] 'agreement among raft nodes before linearized reading' (duration: 108.35427ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:14:58.162721Z","caller":"traceutil/trace.go:171","msg":"trace[431115068] transaction","detail":"{read_only:false; response_revision:3360; number_of_response:1; }","duration":"110.585871ms","start":"2026-05-29T05:14:58.052109Z","end":"2026-05-29T05:14:58.162695Z","steps":["trace[431115068] 'process raft request' (duration: 110.425377ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:17:37.261996Z","caller":"traceutil/trace.go:171","msg":"trace[523918886] transaction","detail":"{read_only:false; response_revision:5265; number_of_response:1; }","duration":"107.993334ms","start":"2026-05-29T05:17:37.15396Z","end":"2026-05-29T05:17:37.261953Z","steps":["trace[523918886] 'process raft request' (duration: 107.76403ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:17:43.408835Z","caller":"traceutil/trace.go:171","msg":"trace[1382665137] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"171.600254ms","start":"2026-05-29T05:17:43.237208Z","end":"2026-05-29T05:17:43.408809Z","steps":["trace[1382665137] 'process raft request' (duration: 171.38938ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:17:43.541751Z","caller":"traceutil/trace.go:171","msg":"trace[1315237485] linearizableReadLoop","detail":"{readStateIndex:5514; appliedIndex:5511; }","duration":"253.664044ms","start":"2026-05-29T05:17:43.288061Z","end":"2026-05-29T05:17:43.541725Z","steps":["trace[1315237485] 'read index received' (duration: 120.666933ms)","trace[1315237485] 'applied index is now lower than readState.Index' (duration: 132.995961ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:17:43.541866Z","caller":"traceutil/trace.go:171","msg":"trace[615919112] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"301.476393ms","start":"2026-05-29T05:17:43.240317Z","end":"2026-05-29T05:17:43.541794Z","steps":["trace[615919112] 'process raft request' (duration: 291.85095ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:17:43.541809Z","caller":"traceutil/trace.go:171","msg":"trace[2048937008] transaction","detail":"{read_only:false; response_revision:5319; number_of_response:1; }","duration":"259.636175ms","start":"2026-05-29T05:17:43.282139Z","end":"2026-05-29T05:17:43.541775Z","steps":["trace[2048937008] 'process raft request' (duration: 259.517753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:17:43.541992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.653614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-29T05:17:43.542033Z","caller":"traceutil/trace.go:171","msg":"trace[340539423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5319; }","duration":"253.738445ms","start":"2026-05-29T05:17:43.288284Z","end":"2026-05-29T05:17:43.542022Z","steps":["trace[340539423] 'agreement among raft nodes before linearized reading' (duration: 253.583043ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:17:43.54201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.921959ms","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-05-29T05:17:43.542099Z","caller":"traceutil/trace.go:171","msg":"trace[881969493] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5319; }","duration":"254.05303ms","start":"2026-05-29T05:17:43.288026Z","end":"2026-05-29T05:17:43.542079Z","steps":["trace[881969493] 'agreement among raft nodes before linearized reading' (duration: 253.789246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:17:43.542161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-29T05:17:43.240298Z","time spent":"301.676516ms","remote":"127.0.0.1:40882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":924,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-29T05:17:43.971773Z","caller":"traceutil/trace.go:171","msg":"trace[1639561875] transaction","detail":"{read_only:false; response_revision:5330; number_of_response:1; }","duration":"145.549994ms","start":"2026-05-29T05:17:43.826198Z","end":"2026-05-29T05:17:43.971748Z","steps":["trace[1639561875] 'process raft request' (duration: 145.385021ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:17:51.768797Z","caller":"traceutil/trace.go:171","msg":"trace[681704645] transaction","detail":"{read_only:false; response_revision:5436; number_of_response:1; }","duration":"117.327954ms","start":"2026-05-29T05:17:51.651442Z","end":"2026-05-29T05:17:51.76877Z","steps":["trace[681704645] 'process raft request' (duration: 117.039629ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:18:17.62708Z","caller":"traceutil/trace.go:171","msg":"trace[1258544254] transaction","detail":"{read_only:false; response_revision:5600; number_of_response:1; }","duration":"103.196094ms","start":"2026-05-29T05:18:17.523855Z","end":"2026-05-29T05:18:17.627051Z","steps":["trace[1258544254] 'process raft request' (duration: 102.712646ms)"],"step_count":1} {"level":"warn","ts":"2026-05-29T05:18:23.045589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.789377ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-29T05:18:23.045782Z","caller":"traceutil/trace.go:171","msg":"trace[1714865250] transaction","detail":"{read_only:false; response_revision:5628; number_of_response:1; }","duration":"196.391328ms","start":"2026-05-29T05:18:22.849372Z","end":"2026-05-29T05:18:23.045764Z","steps":["trace[1714865250] 'process raft request' (duration: 80.350917ms)","trace[1714865250] 'compare' (duration: 115.703996ms)"],"step_count":2} {"level":"info","ts":"2026-05-29T05:18:36.331462Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2931} {"level":"info","ts":"2026-05-29T05:18:36.400283Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2931,"took":"67.065997ms","hash":839191289,"current-db-size-bytes":54636544,"current-db-size":"55 MB","current-db-size-in-use-bytes":31277056,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-29T05:18:36.400345Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":839191289,"revision":2931,"compact-revision":-1} {"level":"info","ts":"2026-05-29T05:19:41.208378Z","caller":"traceutil/trace.go:171","msg":"trace[728465453] transaction","detail":"{read_only:false; response_revision:6241; number_of_response:1; }","duration":"111.477255ms","start":"2026-05-29T05:19:41.096874Z","end":"2026-05-29T05:19:41.208351Z","steps":["trace[728465453] 'process raft request' (duration: 111.334292ms)"],"step_count":1} {"level":"info","ts":"2026-05-29T05:20:01.496254Z","caller":"traceutil/trace.go:171","msg":"trace[1062114361] transaction","detail":"{read_only:false; response_revision:6403; number_of_response:1; }","duration":"104.748494ms","start":"2026-05-29T05:20:01.391485Z","end":"2026-05-29T05:20:01.496234Z","steps":["trace[1062114361] 'process raft request' (duration: 59.092982ms)","trace[1062114361] 'compare' (duration: 45.086604ms)"],"step_count":2}