{"level":"warn","ts":"2026-04-20T08:05:26.725331Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:05:26.725417Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.206: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.19.213.206:2380","--initial-cluster=instance=https://199.19.213.206:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.206:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.206:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T08:05:26.72548Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T08:05:26.72549Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.206:2380"]} {"level":"info","ts":"2026-04-20T08:05:26.72551Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T08:05:26.72614Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"]} {"level":"info","ts":"2026-04-20T08:05:26.726209Z","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.19.213.206:2380"],"listen-peer-urls":["https://199.19.213.206:2380"],"advertise-client-urls":["https://199.19.213.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.206:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T08:05:26.73054Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.118092ms"} {"level":"info","ts":"2026-04-20T08:05:26.738665Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b696d7a595057bfe","cluster-id":"9b00ba6f3f3b7ac2"} {"level":"info","ts":"2026-04-20T08:05:26.738772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T08:05:26.738807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became follower at term 0"} {"level":"info","ts":"2026-04-20T08:05:26.738832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b696d7a595057bfe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T08:05:26.73885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became follower at term 1"} {"level":"info","ts":"2026-04-20T08:05:26.738916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=(13156940467579223038)"} {"level":"warn","ts":"2026-04-20T08:05:26.74602Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T08:05:26.747451Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T08:05:26.748674Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T08:05:26.750893Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b696d7a595057bfe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T08:05:26.751175Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b696d7a595057bfe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T08:05:26.751429Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:05:26.753037Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:05:26.75308Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T08:05:26.757537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe switched to configuration voters=(13156940467579223038)"} {"level":"info","ts":"2026-04-20T08:05:26.757761Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9b00ba6f3f3b7ac2","local-member-id":"b696d7a595057bfe","added-peer-id":"b696d7a595057bfe","added-peer-peer-urls":["https://199.19.213.206:2380"]} {"level":"info","ts":"2026-04-20T08:05:26.758986Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T08:05:26.759343Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b696d7a595057bfe","initial-advertise-peer-urls":["https://199.19.213.206:2380"],"listen-peer-urls":["https://199.19.213.206:2380"],"advertise-client-urls":["https://199.19.213.206:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.206:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T08:05:26.7594Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T08:05:26.759088Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.206:2380"} {"level":"info","ts":"2026-04-20T08:05:26.759963Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.206:2380"} {"level":"info","ts":"2026-04-20T08:05:27.640127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T08:05:27.640212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T08:05:27.640275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe received MsgPreVoteResp from b696d7a595057bfe at term 1"} {"level":"info","ts":"2026-04-20T08:05:27.6403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became candidate at term 2"} {"level":"info","ts":"2026-04-20T08:05:27.640312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe received MsgVoteResp from b696d7a595057bfe at term 2"} {"level":"info","ts":"2026-04-20T08:05:27.64033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b696d7a595057bfe became leader at term 2"} {"level":"info","ts":"2026-04-20T08:05:27.640346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b696d7a595057bfe elected leader b696d7a595057bfe at term 2"} {"level":"info","ts":"2026-04-20T08:05:27.641672Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b696d7a595057bfe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.206:2379]}","request-path":"/0/members/b696d7a595057bfe/attributes","cluster-id":"9b00ba6f3f3b7ac2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T08:05:27.641725Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:05:27.641768Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T08:05:27.642087Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T08:05:27.642187Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T08:05:27.645797Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.206:2379"} {"level":"info","ts":"2026-04-20T08:05:27.645935Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:05:27.646186Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T08:05:27.646961Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9b00ba6f3f3b7ac2","local-member-id":"b696d7a595057bfe","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:05:27.647245Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:05:27.647301Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T08:05:31.982066Z","caller":"traceutil/trace.go:171","msg":"trace[32813296] transaction","detail":"{read_only:false; response_revision:250; number_of_response:1; }","duration":"440.679111ms","start":"2026-04-20T08:05:31.541363Z","end":"2026-04-20T08:05:31.982042Z","steps":["trace[32813296] 'process raft request' (duration: 440.538677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:31.983045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:05:31.541345Z","time spent":"440.862547ms","remote":"127.0.0.1:48090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:05:32.236893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.102371ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:05:32.237048Z","caller":"traceutil/trace.go:171","msg":"trace[139983003] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"246.290483ms","start":"2026-04-20T08:05:31.990738Z","end":"2026-04-20T08:05:32.237029Z","steps":["trace[139983003] 'process raft request' (duration: 109.812201ms)","trace[139983003] 'compare' (duration: 135.605626ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:05:32.37643Z","caller":"traceutil/trace.go:171","msg":"trace[335926932] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"130.251412ms","start":"2026-04-20T08:05:32.246149Z","end":"2026-04-20T08:05:32.3764Z","steps":["trace[335926932] 'process raft request' (duration: 129.312303ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:05:58.603711Z","caller":"traceutil/trace.go:171","msg":"trace[825526509] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"380.738495ms","start":"2026-04-20T08:05:58.222933Z","end":"2026-04-20T08:05:58.603671Z","steps":["trace[825526509] 'process raft request' (duration: 361.256448ms)","trace[825526509] 'compare' (duration: 19.323443ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:05:58.603955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:05:58.222906Z","time spent":"380.935939ms","remote":"127.0.0.1:47942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:05:58.606689Z","caller":"traceutil/trace.go:171","msg":"trace[1743858362] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"371.427076ms","start":"2026-04-20T08:05:58.235227Z","end":"2026-04-20T08:05:58.606654Z","steps":["trace[1743858362] 'process raft request' (duration: 371.13611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:58.606805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:05:58.235218Z","time spent":"371.529858ms","remote":"127.0.0.1:47942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:05:58.607137Z","caller":"traceutil/trace.go:171","msg":"trace[914418392] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"373.302071ms","start":"2026-04-20T08:05:58.233348Z","end":"2026-04-20T08:05:58.60665Z","steps":["trace[914418392] 'process raft request' (duration: 372.707348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:05:58.60738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:05:58.233319Z","time spent":"373.947725ms","remote":"127.0.0.1:47942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T08:06:04.714901Z","caller":"traceutil/trace.go:171","msg":"trace[1066256716] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"204.360925ms","start":"2026-04-20T08:06:04.510505Z","end":"2026-04-20T08:06:04.714866Z","steps":["trace[1066256716] 'process raft request' (duration: 204.130149ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:06:04.768793Z","caller":"traceutil/trace.go:171","msg":"trace[1472242991] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:639; }","duration":"127.475073ms","start":"2026-04-20T08:06:04.641286Z","end":"2026-04-20T08:06:04.768761Z","steps":["trace[1472242991] 'read index received' (duration: 73.466076ms)","trace[1472242991] 'applied index is now lower than readState.Index' (duration: 54.007947ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:06:04.768937Z","caller":"traceutil/trace.go:171","msg":"trace[887408250] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"253.514452ms","start":"2026-04-20T08:06:04.515379Z","end":"2026-04-20T08:06:04.768893Z","steps":["trace[887408250] 'process raft request' (duration: 252.847358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:04.769034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.725658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T08:06:04.769073Z","caller":"traceutil/trace.go:171","msg":"trace[870487561] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:621; }","duration":"127.8278ms","start":"2026-04-20T08:06:04.641234Z","end":"2026-04-20T08:06:04.769061Z","steps":["trace[870487561] 'agreement among raft nodes before linearized reading' (duration: 127.638646ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:05.159451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.083603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:06:05.159574Z","caller":"traceutil/trace.go:171","msg":"trace[532034570] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"383.655573ms","start":"2026-04-20T08:06:04.775895Z","end":"2026-04-20T08:06:05.159551Z","steps":["trace[532034570] 'process raft request' (duration: 45.374976ms)","trace[532034570] 'compare' (duration: 337.935079ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:06:05.15971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:06:04.77587Z","time spent":"383.789995ms","remote":"127.0.0.1:48194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:06:05.177868Z","caller":"traceutil/trace.go:171","msg":"trace[1827539729] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"343.163703ms","start":"2026-04-20T08:06:04.834667Z","end":"2026-04-20T08:06:05.177831Z","steps":["trace[1827539729] 'process raft request' (duration: 343.03515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:06:05.178606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:06:04.834629Z","time spent":"343.320305ms","remote":"127.0.0.1:48438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T08:06:06.770365Z","caller":"traceutil/trace.go:171","msg":"trace[868067731] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"124.838235ms","start":"2026-04-20T08:06:06.645503Z","end":"2026-04-20T08:06:06.770341Z","steps":["trace[868067731] 'process raft request' (duration: 124.701912ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:06:19.391748Z","caller":"traceutil/trace.go:171","msg":"trace[125743176] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"165.090777ms","start":"2026-04-20T08:06:19.226632Z","end":"2026-04-20T08:06:19.391723Z","steps":["trace[125743176] 'process raft request' (duration: 164.938845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:09.309303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.388671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:07:09.309384Z","caller":"traceutil/trace.go:171","msg":"trace[773672076] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1425; }","duration":"130.527013ms","start":"2026-04-20T08:07:09.178839Z","end":"2026-04-20T08:07:09.309366Z","steps":["trace[773672076] 'range keys from in-memory index tree' (duration: 130.29468ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:35.663801Z","caller":"traceutil/trace.go:171","msg":"trace[1819694854] linearizableReadLoop","detail":"{readStateIndex:1903; appliedIndex:1902; }","duration":"265.006349ms","start":"2026-04-20T08:07:35.39877Z","end":"2026-04-20T08:07:35.663777Z","steps":["trace[1819694854] 'read index received' (duration: 264.849857ms)","trace[1819694854] 'applied index is now lower than readState.Index' (duration: 155.292µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:07:35.663936Z","caller":"traceutil/trace.go:171","msg":"trace[1510316877] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"373.745891ms","start":"2026-04-20T08:07:35.29016Z","end":"2026-04-20T08:07:35.663906Z","steps":["trace[1510316877] 'process raft request' (duration: 373.464238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:35.663991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.197682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:07:35.664045Z","caller":"traceutil/trace.go:171","msg":"trace[1369488160] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1836; }","duration":"265.348873ms","start":"2026-04-20T08:07:35.398684Z","end":"2026-04-20T08:07:35.664032Z","steps":["trace[1369488160] 'agreement among raft nodes before linearized reading' (duration: 265.215871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:35.664135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:07:35.290139Z","time spent":"373.887853ms","remote":"127.0.0.1:48194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:07:35.695134Z","caller":"traceutil/trace.go:171","msg":"trace[1656096566] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"135.43037ms","start":"2026-04-20T08:07:35.559683Z","end":"2026-04-20T08:07:35.695113Z","steps":["trace[1656096566] 'process raft request' (duration: 135.339789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:35.695286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.696252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:07:35.695414Z","caller":"traceutil/trace.go:171","msg":"trace[562669520] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1837; }","duration":"138.877894ms","start":"2026-04-20T08:07:35.556509Z","end":"2026-04-20T08:07:35.695387Z","steps":["trace[562669520] 'agreement among raft nodes before linearized reading' (duration: 138.681082ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:36.225799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.531413ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-20T08:07:36.22613Z","caller":"traceutil/trace.go:171","msg":"trace[870952186] linearizableReadLoop","detail":"{readStateIndex:1908; appliedIndex:1907; }","duration":"320.94421ms","start":"2026-04-20T08:07:35.90516Z","end":"2026-04-20T08:07:36.226104Z","steps":["trace[870952186] 'read index received' (duration: 86.189793ms)","trace[870952186] 'applied index is now lower than readState.Index' (duration: 234.751927ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:07:36.226168Z","caller":"traceutil/trace.go:171","msg":"trace[220491070] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"236.585398ms","start":"2026-04-20T08:07:35.989556Z","end":"2026-04-20T08:07:36.226142Z","steps":["trace[220491070] 'process raft request' (duration: 236.393056ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:36.233735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.313091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2e4bbe17-3f0f-4af3-b610-9b2197592f29\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-20T08:07:36.233807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.89374ms","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-04-20T08:07:36.233845Z","caller":"traceutil/trace.go:171","msg":"trace[1522667778] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2e4bbe17-3f0f-4af3-b610-9b2197592f29; range_end:; response_count:1; response_revision:1841; }","duration":"277.455572ms","start":"2026-04-20T08:07:35.95636Z","end":"2026-04-20T08:07:36.233816Z","steps":["trace[1522667778] 'agreement among raft nodes before linearized reading' (duration: 269.92948ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:36.23388Z","caller":"traceutil/trace.go:171","msg":"trace[1263835117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1841; }","duration":"300.020661ms","start":"2026-04-20T08:07:35.93384Z","end":"2026-04-20T08:07:36.233861Z","steps":["trace[1263835117] 'agreement among raft nodes before linearized reading' (duration: 292.416927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:36.233905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.731355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-20T08:07:36.233923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:07:35.933814Z","time spent":"300.100501ms","remote":"127.0.0.1:48194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-20T08:07:36.233957Z","caller":"traceutil/trace.go:171","msg":"trace[29141087] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1841; }","duration":"328.819127ms","start":"2026-04-20T08:07:35.905121Z","end":"2026-04-20T08:07:36.233941Z","steps":["trace[29141087] 'agreement among raft nodes before linearized reading' (duration: 321.114442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:36.233995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:07:35.905106Z","time spent":"328.880187ms","remote":"127.0.0.1:48194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T08:07:36.234021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.312228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-20T08:07:36.234094Z","caller":"traceutil/trace.go:171","msg":"trace[983956184] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1841; }","duration":"181.428289ms","start":"2026-04-20T08:07:36.052644Z","end":"2026-04-20T08:07:36.234072Z","steps":["trace[983956184] 'agreement among raft nodes before linearized reading' (duration: 173.638364ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:07:50.491165Z","caller":"traceutil/trace.go:171","msg":"trace[1156553795] linearizableReadLoop","detail":"{readStateIndex:2030; appliedIndex:2029; }","duration":"174.781504ms","start":"2026-04-20T08:07:50.316356Z","end":"2026-04-20T08:07:50.491138Z","steps":["trace[1156553795] 'read index received' (duration: 174.529191ms)","trace[1156553795] 'applied index is now lower than readState.Index' (duration: 250.923µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:07:50.491254Z","caller":"traceutil/trace.go:171","msg":"trace[677877785] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"213.940271ms","start":"2026-04-20T08:07:50.277261Z","end":"2026-04-20T08:07:50.491201Z","steps":["trace[677877785] 'process raft request' (duration: 213.687669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:50.491533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.148128ms","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-04-20T08:07:50.491617Z","caller":"traceutil/trace.go:171","msg":"trace[766753155] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1960; }","duration":"175.286509ms","start":"2026-04-20T08:07:50.316311Z","end":"2026-04-20T08:07:50.491597Z","steps":["trace[766753155] 'agreement among raft nodes before linearized reading' (duration: 174.949945ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:07:50.49174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.244453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T08:07:50.49192Z","caller":"traceutil/trace.go:171","msg":"trace[488242110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1960; }","duration":"171.457255ms","start":"2026-04-20T08:07:50.320451Z","end":"2026-04-20T08:07:50.491909Z","steps":["trace[488242110] 'agreement among raft nodes before linearized reading' (duration: 170.839437ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:08:06.049953Z","caller":"traceutil/trace.go:171","msg":"trace[903868361] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"219.485953ms","start":"2026-04-20T08:08:05.830423Z","end":"2026-04-20T08:08:06.049909Z","steps":["trace[903868361] 'process raft request' (duration: 191.132016ms)","trace[903868361] 'compare' (duration: 28.048663ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:08:06.991424Z","caller":"traceutil/trace.go:171","msg":"trace[2081850156] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"200.699087ms","start":"2026-04-20T08:08:06.790691Z","end":"2026-04-20T08:08:06.99139Z","steps":["trace[2081850156] 'process raft request' (duration: 200.434015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:08:07.226879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.929365ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:08:07.227015Z","caller":"traceutil/trace.go:171","msg":"trace[1612831196] linearizableReadLoop","detail":"{readStateIndex:2143; appliedIndex:2142; }","duration":"126.610538ms","start":"2026-04-20T08:08:07.100383Z","end":"2026-04-20T08:08:07.226994Z","steps":["trace[1612831196] 'read index received' (duration: 98.461µs)","trace[1612831196] 'applied index is now lower than readState.Index' (duration: 126.510257ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:08:07.227076Z","caller":"traceutil/trace.go:171","msg":"trace[898660359] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"316.718626ms","start":"2026-04-20T08:08:06.910325Z","end":"2026-04-20T08:08:07.227044Z","steps":["trace[898660359] 'process raft request' (duration: 177.473717ms)","trace[898660359] 'compare' (duration: 138.736243ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:08:07.227247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.882691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-04-20T08:08:07.227248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:08:06.910296Z","time spent":"316.858307ms","remote":"127.0.0.1:48194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:08:07.227294Z","caller":"traceutil/trace.go:171","msg":"trace[1659140280] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2069; }","duration":"126.983252ms","start":"2026-04-20T08:08:07.100296Z","end":"2026-04-20T08:08:07.227279Z","steps":["trace[1659140280] 'agreement among raft nodes before linearized reading' (duration: 126.7841ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:46.960685Z","caller":"traceutil/trace.go:171","msg":"trace[1285227105] transaction","detail":"{read_only:false; response_revision:4668; number_of_response:1; }","duration":"120.816879ms","start":"2026-04-20T08:13:46.839842Z","end":"2026-04-20T08:13:46.960659Z","steps":["trace[1285227105] 'process raft request' (duration: 120.153369ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:13:49.540296Z","caller":"traceutil/trace.go:171","msg":"trace[1661136543] transaction","detail":"{read_only:false; response_revision:4741; number_of_response:1; }","duration":"265.802635ms","start":"2026-04-20T08:13:49.274467Z","end":"2026-04-20T08:13:49.54027Z","steps":["trace[1661136543] 'process raft request' (duration: 192.174117ms)","trace[1661136543] 'compare' (duration: 73.238643ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:04.119611Z","caller":"traceutil/trace.go:171","msg":"trace[1354881664] linearizableReadLoop","detail":"{readStateIndex:5094; appliedIndex:5093; }","duration":"142.346965ms","start":"2026-04-20T08:14:03.977234Z","end":"2026-04-20T08:14:04.119581Z","steps":["trace[1354881664] 'read index received' (duration: 142.020781ms)","trace[1354881664] 'applied index is now lower than readState.Index' (duration: 325.194µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:04.119695Z","caller":"traceutil/trace.go:171","msg":"trace[1468827386] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"316.186462ms","start":"2026-04-20T08:14:03.80348Z","end":"2026-04-20T08:14:04.119667Z","steps":["trace[1468827386] 'process raft request' (duration: 315.939428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.119844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:03.803461Z","time spent":"316.309564ms","remote":"127.0.0.1:48090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11504,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:14:04.119867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.624749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10395"} {"level":"info","ts":"2026-04-20T08:14:04.11991Z","caller":"traceutil/trace.go:171","msg":"trace[332999654] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4913; }","duration":"142.738801ms","start":"2026-04-20T08:14:03.977159Z","end":"2026-04-20T08:14:04.119898Z","steps":["trace[332999654] 'agreement among raft nodes before linearized reading' (duration: 142.574288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.119975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.377636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-20T08:14:04.12004Z","caller":"traceutil/trace.go:171","msg":"trace[1660909068] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4913; }","duration":"117.451057ms","start":"2026-04-20T08:14:04.002573Z","end":"2026-04-20T08:14:04.120024Z","steps":["trace[1660909068] 'agreement among raft nodes before linearized reading' (duration: 117.287445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.120072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.767463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-20T08:14:04.120113Z","caller":"traceutil/trace.go:171","msg":"trace[1207968749] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4913; }","duration":"130.829983ms","start":"2026-04-20T08:14:03.989273Z","end":"2026-04-20T08:14:04.120103Z","steps":["trace[1207968749] 'agreement among raft nodes before linearized reading' (duration: 130.684181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.120298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.192161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T08:14:04.120434Z","caller":"traceutil/trace.go:171","msg":"trace[323694681] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4913; }","duration":"134.387403ms","start":"2026-04-20T08:14:03.986022Z","end":"2026-04-20T08:14:04.12041Z","steps":["trace[323694681] 'agreement among raft nodes before linearized reading' (duration: 133.813526ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.335173Z","caller":"traceutil/trace.go:171","msg":"trace[1379589514] linearizableReadLoop","detail":"{readStateIndex:5095; appliedIndex:5094; }","duration":"209.36105ms","start":"2026-04-20T08:14:04.125786Z","end":"2026-04-20T08:14:04.335147Z","steps":["trace[1379589514] 'read index received' (duration: 149.667067ms)","trace[1379589514] 'applied index is now lower than readState.Index' (duration: 59.693213ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:04.335273Z","caller":"traceutil/trace.go:171","msg":"trace[1859039006] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"210.436333ms","start":"2026-04-20T08:14:04.124825Z","end":"2026-04-20T08:14:04.335262Z","steps":["trace[1859039006] 'process raft request' (duration: 150.66791ms)","trace[1859039006] 'compare' (duration: 59.367308ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:14:04.335521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.704514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-33aac436-c33b-4631-a00c-ecf7dac5fcbb\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-20T08:14:04.335627Z","caller":"traceutil/trace.go:171","msg":"trace[1337017017] range","detail":"{range_begin:/registry/persistentvolumes/pvc-33aac436-c33b-4631-a00c-ecf7dac5fcbb; range_end:; response_count:1; response_revision:4914; }","duration":"209.875236ms","start":"2026-04-20T08:14:04.125728Z","end":"2026-04-20T08:14:04.335603Z","steps":["trace[1337017017] 'agreement among raft nodes before linearized reading' (duration: 209.541001ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.380768Z","caller":"traceutil/trace.go:171","msg":"trace[596947479] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"254.485587ms","start":"2026-04-20T08:14:04.126257Z","end":"2026-04-20T08:14:04.380742Z","steps":["trace[596947479] 'process raft request' (duration: 254.286334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.38106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.948805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T08:14:04.38114Z","caller":"traceutil/trace.go:171","msg":"trace[1258355546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4917; }","duration":"199.078036ms","start":"2026-04-20T08:14:04.182045Z","end":"2026-04-20T08:14:04.381123Z","steps":["trace[1258355546] 'agreement among raft nodes before linearized reading' (duration: 198.960864ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.3812Z","caller":"traceutil/trace.go:171","msg":"trace[593094132] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"252.466461ms","start":"2026-04-20T08:14:04.128713Z","end":"2026-04-20T08:14:04.381179Z","steps":["trace[593094132] 'process raft request' (duration: 251.979213ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.381456Z","caller":"traceutil/trace.go:171","msg":"trace[519332331] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"250.933648ms","start":"2026-04-20T08:14:04.130504Z","end":"2026-04-20T08:14:04.381438Z","steps":["trace[519332331] 'process raft request' (duration: 250.40694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.38158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.202156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-20T08:14:04.381651Z","caller":"traceutil/trace.go:171","msg":"trace[1066216384] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4917; }","duration":"120.308678ms","start":"2026-04-20T08:14:04.261322Z","end":"2026-04-20T08:14:04.381631Z","steps":["trace[1066216384] 'agreement among raft nodes before linearized reading' (duration: 120.131426ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.546137Z","caller":"traceutil/trace.go:171","msg":"trace[1412990375] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"155.276004ms","start":"2026-04-20T08:14:04.390828Z","end":"2026-04-20T08:14:04.546104Z","steps":["trace[1412990375] 'process raft request' (duration: 85.165986ms)","trace[1412990375] 'compare' (duration: 69.765923ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:04.546205Z","caller":"traceutil/trace.go:171","msg":"trace[860591679] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"155.305035ms","start":"2026-04-20T08:14:04.39089Z","end":"2026-04-20T08:14:04.546195Z","steps":["trace[860591679] 'process raft request' (duration: 155.073322ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.546468Z","caller":"traceutil/trace.go:171","msg":"trace[141734002] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"155.428257ms","start":"2026-04-20T08:14:04.391028Z","end":"2026-04-20T08:14:04.546457Z","steps":["trace[141734002] 'process raft request' (duration: 155.044071ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.546142Z","caller":"traceutil/trace.go:171","msg":"trace[1354813185] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"155.128422ms","start":"2026-04-20T08:14:04.390989Z","end":"2026-04-20T08:14:04.546117Z","steps":["trace[1354813185] 'process raft request' (duration: 155.042791ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.546719Z","caller":"traceutil/trace.go:171","msg":"trace[881336143] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"130.193706ms","start":"2026-04-20T08:14:04.416509Z","end":"2026-04-20T08:14:04.546703Z","steps":["trace[881336143] 'process raft request' (duration: 129.953432ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.546818Z","caller":"traceutil/trace.go:171","msg":"trace[352614631] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"151.154037ms","start":"2026-04-20T08:14:04.395606Z","end":"2026-04-20T08:14:04.54676Z","steps":["trace[352614631] 'process raft request' (duration: 150.676631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.86166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.967361ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T08:14:04.862067Z","caller":"traceutil/trace.go:171","msg":"trace[58580366] transaction","detail":"{read_only:false; response_revision:4926; number_of_response:1; }","duration":"305.53508ms","start":"2026-04-20T08:14:04.556501Z","end":"2026-04-20T08:14:04.862036Z","steps":["trace[58580366] 'process raft request' (duration: 173.059812ms)","trace[58580366] 'compare' (duration: 131.780379ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:04.862142Z","caller":"traceutil/trace.go:171","msg":"trace[402323159] transaction","detail":"{read_only:false; response_revision:4927; number_of_response:1; }","duration":"302.121363ms","start":"2026-04-20T08:14:04.559988Z","end":"2026-04-20T08:14:04.862109Z","steps":["trace[402323159] 'process raft request' (duration: 301.85566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.862294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:04.556468Z","time spent":"305.745443ms","remote":"127.0.0.1:48208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1563,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T08:14:04.862336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T08:14:04.559975Z","time spent":"302.257695ms","remote":"127.0.0.1:48414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T08:14:04.86268Z","caller":"traceutil/trace.go:171","msg":"trace[1433145226] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"284.552879ms","start":"2026-04-20T08:14:04.578111Z","end":"2026-04-20T08:14:04.862663Z","steps":["trace[1433145226] 'process raft request' (duration: 283.824038ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:04.862104Z","caller":"traceutil/trace.go:171","msg":"trace[1138539216] linearizableReadLoop","detail":"{readStateIndex:5109; appliedIndex:5106; }","duration":"221.791442ms","start":"2026-04-20T08:14:04.640295Z","end":"2026-04-20T08:14:04.862087Z","steps":["trace[1138539216] 'read index received' (duration: 89.279184ms)","trace[1138539216] 'applied index is now lower than readState.Index' (duration: 132.511138ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T08:14:04.862321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.030196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-20T08:14:04.863019Z","caller":"traceutil/trace.go:171","msg":"trace[1455017843] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4928; }","duration":"222.778156ms","start":"2026-04-20T08:14:04.64023Z","end":"2026-04-20T08:14:04.863008Z","steps":["trace[1455017843] 'agreement among raft nodes before linearized reading' (duration: 221.909464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.863101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.694589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T08:14:04.863148Z","caller":"traceutil/trace.go:171","msg":"trace[1379339815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4928; }","duration":"200.794901ms","start":"2026-04-20T08:14:04.662343Z","end":"2026-04-20T08:14:04.863138Z","steps":["trace[1379339815] 'agreement among raft nodes before linearized reading' (duration: 200.675269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T08:14:04.863321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.618127ms","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-04-20T08:14:04.863396Z","caller":"traceutil/trace.go:171","msg":"trace[497711207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4928; }","duration":"200.717348ms","start":"2026-04-20T08:14:04.662669Z","end":"2026-04-20T08:14:04.863387Z","steps":["trace[497711207] 'agreement among raft nodes before linearized reading' (duration: 200.561546ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:05.044207Z","caller":"traceutil/trace.go:171","msg":"trace[1905994580] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"175.03744ms","start":"2026-04-20T08:14:04.869142Z","end":"2026-04-20T08:14:05.044179Z","steps":["trace[1905994580] 'process raft request' (duration: 97.599741ms)","trace[1905994580] 'compare' (duration: 77.159325ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T08:14:05.044553Z","caller":"traceutil/trace.go:171","msg":"trace[36556332] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"175.195422ms","start":"2026-04-20T08:14:04.869341Z","end":"2026-04-20T08:14:05.044536Z","steps":["trace[36556332] 'process raft request' (duration: 174.788426ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:14:05.044762Z","caller":"traceutil/trace.go:171","msg":"trace[1903553156] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"168.948885ms","start":"2026-04-20T08:14:04.875799Z","end":"2026-04-20T08:14:05.044748Z","steps":["trace[1903553156] 'process raft request' (duration: 168.741102ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:15:27.694429Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2929} {"level":"info","ts":"2026-04-20T08:15:27.767496Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2929,"took":"71.967251ms","hash":1674322768,"current-db-size-bytes":53198848,"current-db-size":"53 MB","current-db-size-in-use-bytes":28786688,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T08:15:27.767553Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1674322768,"revision":2929,"compact-revision":-1} {"level":"info","ts":"2026-04-20T08:17:52.174293Z","caller":"traceutil/trace.go:171","msg":"trace[1850126920] transaction","detail":"{read_only:false; response_revision:6575; number_of_response:1; }","duration":"139.466119ms","start":"2026-04-20T08:17:52.034805Z","end":"2026-04-20T08:17:52.174271Z","steps":["trace[1850126920] 'process raft request' (duration: 139.060014ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T08:20:27.70061Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5553} {"level":"info","ts":"2026-04-20T08:20:27.775084Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5553,"took":"72.831584ms","hash":3172923912,"current-db-size-bytes":53198848,"current-db-size":"53 MB","current-db-size-in-use-bytes":18235392,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-20T08:20:27.775141Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3172923912,"revision":5553,"compact-revision":2929}