{"level":"warn","ts":"2026-06-26T03:27:59.233424Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T03:27:59.233502Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.144: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.144:2380","--initial-cluster=instance=https://199.204.45.144:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.144:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.144: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-06-26T03:27:59.23357Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-26T03:27:59.233582Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-06-26T03:27:59.2336Z","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-06-26T03:27:59.234242Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"]} {"level":"info","ts":"2026-06-26T03:27:59.234322Z","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.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.144: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-06-26T03:27:59.239949Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.44592ms"} {"level":"info","ts":"2026-06-26T03:27:59.248045Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4594e5f716bad646","cluster-id":"ff2e51b364668606"} {"level":"info","ts":"2026-06-26T03:27:59.248121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T03:27:59.24814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 0"} {"level":"info","ts":"2026-06-26T03:27:59.248149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4594e5f716bad646 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T03:27:59.248165Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became follower at term 1"} {"level":"info","ts":"2026-06-26T03:27:59.2482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"warn","ts":"2026-06-26T03:27:59.253703Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T03:27:59.254843Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T03:27:59.255776Z","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-06-26T03:27:59.257992Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4594e5f716bad646","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T03:27:59.258114Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4594e5f716bad646","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T03:27:59.258287Z","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-06-26T03:27:59.258397Z","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-06-26T03:27:59.258427Z","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-06-26T03:27:59.260641Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 switched to configuration voters=(5013885134571230790)"} {"level":"info","ts":"2026-06-26T03:27:59.260808Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","added-peer-id":"4594e5f716bad646","added-peer-peer-urls":["https://199.204.45.144:2380"]} {"level":"info","ts":"2026-06-26T03:27:59.26215Z","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-06-26T03:27:59.262289Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-06-26T03:27:59.262319Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.144:2380"} {"level":"info","ts":"2026-06-26T03:27:59.262565Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4594e5f716bad646","initial-advertise-peer-urls":["https://199.204.45.144:2380"],"listen-peer-urls":["https://199.204.45.144:2380"],"advertise-client-urls":["https://199.204.45.144:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.144:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T03:27:59.262591Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T03:27:59.448385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T03:27:59.448446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T03:27:59.44848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgPreVoteResp from 4594e5f716bad646 at term 1"} {"level":"info","ts":"2026-06-26T03:27:59.448499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became candidate at term 2"} {"level":"info","ts":"2026-06-26T03:27:59.448515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 received MsgVoteResp from 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-06-26T03:27:59.448532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4594e5f716bad646 became leader at term 2"} {"level":"info","ts":"2026-06-26T03:27:59.448553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4594e5f716bad646 elected leader 4594e5f716bad646 at term 2"} {"level":"info","ts":"2026-06-26T03:27:59.449282Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:27:59.450556Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ff2e51b364668606","local-member-id":"4594e5f716bad646","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:27:59.450638Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:27:59.450668Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:27:59.450698Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T03:27:59.450733Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4594e5f716bad646","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.144:2379]}","request-path":"/0/members/4594e5f716bad646/attributes","cluster-id":"ff2e51b364668606","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T03:27:59.451518Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T03:27:59.452653Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.144:2379"} {"level":"info","ts":"2026-06-26T03:27:59.452943Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T03:27:59.452978Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T03:27:59.454575Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-26T03:28:01.087835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.421462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-26T03:28:01.087883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.585715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-26T03:28:01.088006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.68511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:28:01.088086Z","caller":"traceutil/trace.go:171","msg":"trace[868351866] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:6; }","duration":"104.795597ms","start":"2026-06-26T03:28:00.983277Z","end":"2026-06-26T03:28:01.088073Z","steps":["trace[868351866] 'range keys from in-memory index tree' (duration: 104.637846ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:01.088147Z","caller":"traceutil/trace.go:171","msg":"trace[2022409027] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:6; }","duration":"114.858174ms","start":"2026-06-26T03:28:00.973217Z","end":"2026-06-26T03:28:01.088076Z","steps":["trace[2022409027] 'range keys from in-memory index tree' (duration: 114.51215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:01.088369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.050088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:28:01.088391Z","caller":"traceutil/trace.go:171","msg":"trace[2135560390] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:6; }","duration":"115.103101ms","start":"2026-06-26T03:28:00.973282Z","end":"2026-06-26T03:28:01.088386Z","steps":["trace[2135560390] 'range keys from in-memory index tree' (duration: 114.975782ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:01.088003Z","caller":"traceutil/trace.go:171","msg":"trace[1482050155] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:6; }","duration":"111.620837ms","start":"2026-06-26T03:28:00.976364Z","end":"2026-06-26T03:28:01.087985Z","steps":["trace[1482050155] 'range keys from in-memory index tree' (duration: 111.372519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:03.712712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.707575ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"warn","ts":"2026-06-26T03:28:03.712942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:03.314723Z","time spent":"398.215033ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-26T03:28:03.713132Z","caller":"traceutil/trace.go:171","msg":"trace[1619562243] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"1.5668923s","start":"2026-06-26T03:28:02.146206Z","end":"2026-06-26T03:28:03.713099Z","steps":["trace[1619562243] 'process raft request' (duration: 573.86084ms)","trace[1619562243] 'compare' (duration: 991.519512ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:03.713255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:02.146189Z","time spent":"1.567013918s","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1473,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:28:03.713216Z","caller":"traceutil/trace.go:171","msg":"trace[1370359337] linearizableReadLoop","detail":"{readStateIndex:90; appliedIndex:89; }","duration":"1.019294984s","start":"2026-06-26T03:28:02.693885Z","end":"2026-06-26T03:28:03.71318Z","steps":["trace[1370359337] 'read index received' (duration: 26.130244ms)","trace[1370359337] 'applied index is now lower than readState.Index' (duration: 993.158269ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:03.71333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019433874s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:28:03.713405Z","caller":"traceutil/trace.go:171","msg":"trace[106789893] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:86; }","duration":"1.019504769s","start":"2026-06-26T03:28:02.693872Z","end":"2026-06-26T03:28:03.713377Z","steps":["trace[106789893] 'agreement among raft nodes before linearized reading' (duration: 1.019403062s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:03.713477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:02.693814Z","time spent":"1.019649309s","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-06-26T03:28:04.059528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.774907ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-26T03:28:04.059726Z","caller":"traceutil/trace.go:171","msg":"trace[563787022] transaction","detail":"{read_only:false; response_revision:88; number_of_response:1; }","duration":"345.389466ms","start":"2026-06-26T03:28:03.714314Z","end":"2026-06-26T03:28:04.059704Z","steps":["trace[563787022] 'process raft request' (duration: 345.335842ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:04.059739Z","caller":"traceutil/trace.go:171","msg":"trace[1289433889] transaction","detail":"{read_only:false; response_revision:87; number_of_response:1; }","duration":"715.824492ms","start":"2026-06-26T03:28:03.343845Z","end":"2026-06-26T03:28:04.05967Z","steps":["trace[1289433889] 'process raft request' (duration: 493.849401ms)","trace[1289433889] 'compare' (duration: 221.605345ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:04.059809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:03.714293Z","time spent":"345.485493ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:28:04.059791Z","caller":"traceutil/trace.go:171","msg":"trace[584945312] linearizableReadLoop","detail":"{readStateIndex:92; appliedIndex:91; }","duration":"346.441833ms","start":"2026-06-26T03:28:03.713301Z","end":"2026-06-26T03:28:04.059743Z","steps":["trace[584945312] 'read index received' (duration: 124.508354ms)","trace[584945312] 'applied index is now lower than readState.Index' (duration: 221.927208ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:04.060002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:03.343824Z","time spent":"716.050878ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:28:04.061796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.820978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node-problem-detector\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-06-26T03:28:04.061943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.066918586s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:28:04.062011Z","caller":"traceutil/trace.go:171","msg":"trace[325716887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:88; }","duration":"1.067001753s","start":"2026-06-26T03:28:02.994972Z","end":"2026-06-26T03:28:04.061974Z","steps":["trace[325716887] 'agreement among raft nodes before linearized reading' (duration: 1.064969345s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:04.062044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:02.994953Z","time spent":"1.067083488s","remote":"127.0.0.1:33214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T03:28:04.06213Z","caller":"traceutil/trace.go:171","msg":"trace[1969601110] range","detail":"{range_begin:/registry/clusterroles/system:node-problem-detector; range_end:; response_count:0; response_revision:88; }","duration":"345.97097ms","start":"2026-06-26T03:28:03.715909Z","end":"2026-06-26T03:28:04.06188Z","steps":["trace[1969601110] 'agreement among raft nodes before linearized reading' (duration: 344.05051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:04.062175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:03.715889Z","time spent":"346.274361ms","remote":"127.0.0.1:57626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:node-problem-detector\" "} {"level":"warn","ts":"2026-06-26T03:28:04.062911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.40534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-06-26T03:28:04.062994Z","caller":"traceutil/trace.go:171","msg":"trace[427989722] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:88; }","duration":"346.509308ms","start":"2026-06-26T03:28:03.716452Z","end":"2026-06-26T03:28:04.062961Z","steps":["trace[427989722] 'agreement among raft nodes before linearized reading' (duration: 343.756288ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:04.063035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:03.716443Z","time spent":"346.582953ms","remote":"127.0.0.1:57448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3514,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-26T03:28:04.063135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.937626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:28:04.063197Z","caller":"traceutil/trace.go:171","msg":"trace[887872204] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:88; }","duration":"424.056604ms","start":"2026-06-26T03:28:03.639123Z","end":"2026-06-26T03:28:04.06318Z","steps":["trace[887872204] 'agreement among raft nodes before linearized reading' (duration: 420.67974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:04.063305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:03.639094Z","time spent":"424.151271ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T03:28:34.628945Z","caller":"traceutil/trace.go:171","msg":"trace[131778281] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"145.204036ms","start":"2026-06-26T03:28:34.48371Z","end":"2026-06-26T03:28:34.628914Z","steps":["trace[131778281] 'process raft request' (duration: 144.837216ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:35.924754Z","caller":"traceutil/trace.go:171","msg":"trace[1765454580] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"139.047334ms","start":"2026-06-26T03:28:35.785656Z","end":"2026-06-26T03:28:35.924704Z","steps":["trace[1765454580] 'process raft request' (duration: 138.825976ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:36.230793Z","caller":"traceutil/trace.go:171","msg":"trace[1201258251] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:540; }","duration":"292.777087ms","start":"2026-06-26T03:28:35.937992Z","end":"2026-06-26T03:28:36.230769Z","steps":["trace[1201258251] 'read index received' (duration: 221.622586ms)","trace[1201258251] 'applied index is now lower than readState.Index' (duration: 71.153351ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:36.230961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.945432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:28:36.231227Z","caller":"traceutil/trace.go:171","msg":"trace[179474569] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"302.672557ms","start":"2026-06-26T03:28:35.928535Z","end":"2026-06-26T03:28:36.231208Z","steps":["trace[179474569] 'process raft request' (duration: 231.019954ms)","trace[179474569] 'compare' (duration: 70.929102ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:28:36.231134Z","caller":"traceutil/trace.go:171","msg":"trace[1783075728] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:522; }","duration":"293.144298ms","start":"2026-06-26T03:28:35.937975Z","end":"2026-06-26T03:28:36.231119Z","steps":["trace[1783075728] 'agreement among raft nodes before linearized reading' (duration: 292.879266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:36.232672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:35.928518Z","time spent":"302.754883ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:28:36.958285Z","caller":"traceutil/trace.go:171","msg":"trace[1041483844] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"169.078182ms","start":"2026-06-26T03:28:36.789188Z","end":"2026-06-26T03:28:36.958266Z","steps":["trace[1041483844] 'process raft request' (duration: 168.916019ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:37.130805Z","caller":"traceutil/trace.go:171","msg":"trace[2119730245] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"327.20013ms","start":"2026-06-26T03:28:36.803576Z","end":"2026-06-26T03:28:37.130776Z","steps":["trace[2119730245] 'read index received' (duration: 154.773916ms)","trace[2119730245] 'applied index is now lower than readState.Index' (duration: 172.425164ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:37.131018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.423618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:150495"} {"level":"info","ts":"2026-06-26T03:28:37.131061Z","caller":"traceutil/trace.go:171","msg":"trace[1272715007] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:574; }","duration":"327.505744ms","start":"2026-06-26T03:28:36.803543Z","end":"2026-06-26T03:28:37.131049Z","steps":["trace[1272715007] 'agreement among raft nodes before linearized reading' (duration: 327.32878ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:37.131106Z","caller":"traceutil/trace.go:171","msg":"trace[753582758] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"336.396571ms","start":"2026-06-26T03:28:36.7947Z","end":"2026-06-26T03:28:37.131096Z","steps":["trace[753582758] 'process raft request' (duration: 267.402536ms)","trace[753582758] 'compare' (duration: 68.554169ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:37.131115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:36.803531Z","time spent":"327.57425ms","remote":"127.0.0.1:33274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":150518,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-06-26T03:28:37.131166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:36.794674Z","time spent":"336.451757ms","remote":"127.0.0.1:33274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:28:37.142104Z","caller":"traceutil/trace.go:171","msg":"trace[331383167] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"172.150113ms","start":"2026-06-26T03:28:36.969922Z","end":"2026-06-26T03:28:37.142072Z","steps":["trace[331383167] 'process raft request' (duration: 171.916763ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:37.142144Z","caller":"traceutil/trace.go:171","msg":"trace[195764025] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"122.506614ms","start":"2026-06-26T03:28:37.019623Z","end":"2026-06-26T03:28:37.142129Z","steps":["trace[195764025] 'process raft request' (duration: 122.333999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:37.803571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.0306ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:28:37.803655Z","caller":"traceutil/trace.go:171","msg":"trace[363488805] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"653.28357ms","start":"2026-06-26T03:28:37.150356Z","end":"2026-06-26T03:28:37.80364Z","steps":["trace[363488805] 'process raft request' (duration: 519.109177ms)","trace[363488805] 'compare' (duration: 133.869647ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:37.803703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:37.15034Z","time spent":"653.338295ms","remote":"127.0.0.1:33274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18032,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:28:37.804444Z","caller":"traceutil/trace.go:171","msg":"trace[620150206] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:598; }","duration":"478.23347ms","start":"2026-06-26T03:28:37.326177Z","end":"2026-06-26T03:28:37.804411Z","steps":["trace[620150206] 'read index received' (duration: 343.35777ms)","trace[620150206] 'applied index is now lower than readState.Index' (duration: 134.87433ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:28:37.804568Z","caller":"traceutil/trace.go:171","msg":"trace[1511821736] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"606.24038ms","start":"2026-06-26T03:28:37.198294Z","end":"2026-06-26T03:28:37.804534Z","steps":["trace[1511821736] 'process raft request' (duration: 605.991929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:37.804616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.422896ms","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-06-26T03:28:37.804659Z","caller":"traceutil/trace.go:171","msg":"trace[1012490390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"478.526725ms","start":"2026-06-26T03:28:37.32612Z","end":"2026-06-26T03:28:37.804647Z","steps":["trace[1012490390] 'agreement among raft nodes before linearized reading' (duration: 478.401205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:37.804659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:37.198264Z","time spent":"606.352429ms","remote":"127.0.0.1:33274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:28:37.8047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:37.326101Z","time spent":"478.58798ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-26T03:28:42.532311Z","caller":"traceutil/trace.go:171","msg":"trace[290814371] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"155.579884ms","start":"2026-06-26T03:28:42.376705Z","end":"2026-06-26T03:28:42.532285Z","steps":["trace[290814371] 'process raft request' (duration: 155.432842ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:42.709977Z","caller":"traceutil/trace.go:171","msg":"trace[1080521332] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"214.544334ms","start":"2026-06-26T03:28:42.495411Z","end":"2026-06-26T03:28:42.709955Z","steps":["trace[1080521332] 'process raft request' (duration: 206.429912ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:43.29193Z","caller":"traceutil/trace.go:171","msg":"trace[2144555371] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"395.499223ms","start":"2026-06-26T03:28:42.896328Z","end":"2026-06-26T03:28:43.291827Z","steps":["trace[2144555371] 'read index received' (duration: 339.199727ms)","trace[2144555371] 'applied index is now lower than readState.Index' (duration: 56.297046ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:28:43.292563Z","caller":"traceutil/trace.go:171","msg":"trace[1900729015] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"742.323834ms","start":"2026-06-26T03:28:42.550189Z","end":"2026-06-26T03:28:43.292513Z","steps":["trace[1900729015] 'process raft request' (duration: 685.779838ms)","trace[1900729015] 'compare' (duration: 54.294197ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:43.292835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:42.550162Z","time spent":"742.584716ms","remote":"127.0.0.1:57372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:28:43.293762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.421505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:28:43.29386Z","caller":"traceutil/trace.go:171","msg":"trace[1168053756] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"397.515752ms","start":"2026-06-26T03:28:42.896309Z","end":"2026-06-26T03:28:43.293825Z","steps":["trace[1168053756] 'agreement among raft nodes before linearized reading' (duration: 396.055679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:43.293908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:42.896253Z","time spent":"397.645403ms","remote":"127.0.0.1:33226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:28:44.846738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.231477ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:28:44.846867Z","caller":"traceutil/trace.go:171","msg":"trace[422558497] linearizableReadLoop","detail":"{readStateIndex:653; appliedIndex:652; }","duration":"1.016891317s","start":"2026-06-26T03:28:43.829953Z","end":"2026-06-26T03:28:44.846844Z","steps":["trace[422558497] 'read index received' (duration: 443.404279ms)","trace[422558497] 'applied index is now lower than readState.Index' (duration: 573.484987ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:28:44.847254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01729033s","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-06-26T03:28:44.847121Z","caller":"traceutil/trace.go:171","msg":"trace[1520835766] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.499734164s","start":"2026-06-26T03:28:43.347349Z","end":"2026-06-26T03:28:44.847083Z","steps":["trace[1520835766] 'process raft request' (duration: 926.05572ms)","trace[1520835766] 'compare' (duration: 572.929261ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:28:44.847328Z","caller":"traceutil/trace.go:171","msg":"trace[854972929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"1.0174055s","start":"2026-06-26T03:28:43.829905Z","end":"2026-06-26T03:28:44.847311Z","steps":["trace[854972929] 'agreement among raft nodes before linearized reading' (duration: 1.017230585s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:44.847377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:43.829887Z","time spent":"1.017476625s","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:28:44.847479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"953.840282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:28:44.847509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:43.347334Z","time spent":"1.499997755s","remote":"127.0.0.1:57640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:28:44.84756Z","caller":"traceutil/trace.go:171","msg":"trace[1607112201] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:630; }","duration":"953.971704ms","start":"2026-06-26T03:28:43.893566Z","end":"2026-06-26T03:28:44.847538Z","steps":["trace[1607112201] 'agreement among raft nodes before linearized reading' (duration: 953.832572ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:44.847609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:43.893545Z","time spent":"954.05632ms","remote":"127.0.0.1:33214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:28:44.847731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.909074ms","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-06-26T03:28:44.847876Z","caller":"traceutil/trace.go:171","msg":"trace[1797640045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"565.090259ms","start":"2026-06-26T03:28:44.28277Z","end":"2026-06-26T03:28:44.84786Z","steps":["trace[1797640045] 'agreement among raft nodes before linearized reading' (duration: 564.721098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:44.847916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.400564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-26T03:28:44.847954Z","caller":"traceutil/trace.go:171","msg":"trace[1815295566] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:630; }","duration":"581.47174ms","start":"2026-06-26T03:28:44.266472Z","end":"2026-06-26T03:28:44.847944Z","steps":["trace[1815295566] 'agreement among raft nodes before linearized reading' (duration: 581.335438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:44.847986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:44.266453Z","time spent":"581.526824ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-26T03:28:44.847999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:44.282758Z","time spent":"565.171356ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:28:44.848129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.358378ms","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-06-26T03:28:44.848289Z","caller":"traceutil/trace.go:171","msg":"trace[1983393241] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"889.442295ms","start":"2026-06-26T03:28:43.958736Z","end":"2026-06-26T03:28:44.848178Z","steps":["trace[1983393241] 'agreement among raft nodes before linearized reading' (duration: 889.333856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:44.848356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:43.958721Z","time spent":"889.61805ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T03:28:46.816388Z","caller":"traceutil/trace.go:171","msg":"trace[1392658961] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"297.638756ms","start":"2026-06-26T03:28:46.518721Z","end":"2026-06-26T03:28:46.816359Z","steps":["trace[1392658961] 'process raft request' (duration: 297.469462ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:46.822765Z","caller":"traceutil/trace.go:171","msg":"trace[1088624460] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"105.912505ms","start":"2026-06-26T03:28:46.71683Z","end":"2026-06-26T03:28:46.822742Z","steps":["trace[1088624460] 'process raft request' (duration: 105.72906ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:49.657149Z","caller":"traceutil/trace.go:171","msg":"trace[702063303] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"111.568747ms","start":"2026-06-26T03:28:49.545548Z","end":"2026-06-26T03:28:49.657116Z","steps":["trace[702063303] 'process raft request' (duration: 111.384092ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:28:56.656885Z","caller":"traceutil/trace.go:171","msg":"trace[1514676776] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"190.107391ms","start":"2026-06-26T03:28:56.46675Z","end":"2026-06-26T03:28:56.656858Z","steps":["trace[1514676776] 'process raft request' (duration: 189.961479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:59.445399Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203203296302771,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:28:59.775155Z","caller":"traceutil/trace.go:171","msg":"trace[201428254] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"831.805083ms","start":"2026-06-26T03:28:58.943322Z","end":"2026-06-26T03:28:59.775127Z","steps":["trace[201428254] 'process raft request' (duration: 831.648121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:59.775328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:58.943311Z","time spent":"831.917826ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:28:59.899482Z","caller":"traceutil/trace.go:171","msg":"trace[1648894673] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:821; }","duration":"954.849745ms","start":"2026-06-26T03:28:58.944591Z","end":"2026-06-26T03:28:59.899441Z","steps":["trace[1648894673] 'read index received' (duration: 830.416666ms)","trace[1648894673] 'applied index is now lower than readState.Index' (duration: 124.432209ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:28:59.899506Z","caller":"traceutil/trace.go:171","msg":"trace[481513717] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"954.423307ms","start":"2026-06-26T03:28:58.945047Z","end":"2026-06-26T03:28:59.899471Z","steps":["trace[481513717] 'process raft request' (duration: 954.257986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:59.899667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.053154ms","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-06-26T03:28:59.899712Z","caller":"traceutil/trace.go:171","msg":"trace[744547748] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"955.14171ms","start":"2026-06-26T03:28:58.944559Z","end":"2026-06-26T03:28:59.899701Z","steps":["trace[744547748] 'agreement among raft nodes before linearized reading' (duration: 954.994317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:59.899748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:58.944544Z","time spent":"955.195177ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:28:59.899738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:58.945032Z","time spent":"954.56507ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:28:59.899909Z","caller":"traceutil/trace.go:171","msg":"trace[1109256376] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"954.973499ms","start":"2026-06-26T03:28:58.944923Z","end":"2026-06-26T03:28:59.899897Z","steps":["trace[1109256376] 'process raft request' (duration: 954.272294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:59.900003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:58.94491Z","time spent":"955.027996ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:28:59.899999Z","caller":"traceutil/trace.go:171","msg":"trace[1964920365] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"421.023981ms","start":"2026-06-26T03:28:59.47892Z","end":"2026-06-26T03:28:59.899944Z","steps":["trace[1964920365] 'process raft request' (duration: 420.478619ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:28:59.900154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:28:59.478895Z","time spent":"421.179273ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:29:28.818563Z","caller":"traceutil/trace.go:171","msg":"trace[55723291] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"139.103574ms","start":"2026-06-26T03:29:28.679425Z","end":"2026-06-26T03:29:28.818529Z","steps":["trace[55723291] 'process raft request' (duration: 138.963035ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:29:49.853832Z","caller":"traceutil/trace.go:171","msg":"trace[1875642743] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"160.835974ms","start":"2026-06-26T03:29:49.692975Z","end":"2026-06-26T03:29:49.853811Z","steps":["trace[1875642743] 'process raft request' (duration: 160.725873ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:29:50.436276Z","caller":"traceutil/trace.go:171","msg":"trace[289922516] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"303.464239ms","start":"2026-06-26T03:29:50.132795Z","end":"2026-06-26T03:29:50.436259Z","steps":["trace[289922516] 'process raft request' (duration: 303.351877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:29:50.436386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:29:50.132774Z","time spent":"303.55437ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:29:50.470734Z","caller":"traceutil/trace.go:171","msg":"trace[64255390] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"336.00586ms","start":"2026-06-26T03:29:50.134708Z","end":"2026-06-26T03:29:50.470713Z","steps":["trace[64255390] 'process raft request' (duration: 335.853057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:29:50.470874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:29:50.134691Z","time spent":"336.104771ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:29:50.470907Z","caller":"traceutil/trace.go:171","msg":"trace[1063082384] linearizableReadLoop","detail":"{readStateIndex:1496; appliedIndex:1493; }","duration":"269.886108ms","start":"2026-06-26T03:29:50.200993Z","end":"2026-06-26T03:29:50.470879Z","steps":["trace[1063082384] 'read index received' (duration: 235.23776ms)","trace[1063082384] 'applied index is now lower than readState.Index' (duration: 34.646288ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:29:50.471018Z","caller":"traceutil/trace.go:171","msg":"trace[1003948881] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"335.822007ms","start":"2026-06-26T03:29:50.135185Z","end":"2026-06-26T03:29:50.471007Z","steps":["trace[1003948881] 'process raft request' (duration: 335.490041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:29:50.471067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:29:50.135169Z","time spent":"335.873097ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:29:50.471214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.59325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:29:50.471466Z","caller":"traceutil/trace.go:171","msg":"trace[432660984] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1451; }","duration":"168.895415ms","start":"2026-06-26T03:29:50.302553Z","end":"2026-06-26T03:29:50.471448Z","steps":["trace[432660984] 'agreement among raft nodes before linearized reading' (duration: 168.5669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:29:50.471557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.54421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-06-26T03:29:50.471611Z","caller":"traceutil/trace.go:171","msg":"trace[1824294900] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1451; }","duration":"270.642701ms","start":"2026-06-26T03:29:50.200953Z","end":"2026-06-26T03:29:50.471596Z","steps":["trace[1824294900] 'agreement among raft nodes before linearized reading' (duration: 270.064901ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:29:55.914335Z","caller":"traceutil/trace.go:171","msg":"trace[553377820] transaction","detail":"{read_only:false; response_revision:1549; number_of_response:1; }","duration":"145.161243ms","start":"2026-06-26T03:29:55.769144Z","end":"2026-06-26T03:29:55.914305Z","steps":["trace[553377820] 'process raft request' (duration: 58.46692ms)","trace[553377820] 'compare' (duration: 86.434467ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:08.467218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.843264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.467284Z","caller":"traceutil/trace.go:171","msg":"trace[2051174810] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:1749; }","duration":"175.947718ms","start":"2026-06-26T03:30:08.291324Z","end":"2026-06-26T03:30:08.467272Z","steps":["trace[2051174810] 'range keys from in-memory index tree' (duration: 175.787543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.467405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.780348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.467482Z","caller":"traceutil/trace.go:171","msg":"trace[448977564] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:1749; }","duration":"163.883852ms","start":"2026-06-26T03:30:08.303582Z","end":"2026-06-26T03:30:08.467465Z","steps":["trace[448977564] 'count revisions from in-memory index tree' (duration: 163.708537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.467692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.066408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.467723Z","caller":"traceutil/trace.go:171","msg":"trace[72107133] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:1749; }","duration":"164.123649ms","start":"2026-06-26T03:30:08.303592Z","end":"2026-06-26T03:30:08.467716Z","steps":["trace[72107133] 'range keys from in-memory index tree' (duration: 163.994955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.467821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.48019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.467845Z","caller":"traceutil/trace.go:171","msg":"trace[865209188] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:1749; }","duration":"163.51461ms","start":"2026-06-26T03:30:08.304323Z","end":"2026-06-26T03:30:08.467838Z","steps":["trace[865209188] 'range keys from in-memory index tree' (duration: 163.439078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.468003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.518403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.468043Z","caller":"traceutil/trace.go:171","msg":"trace[136573871] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1749; }","duration":"148.559694ms","start":"2026-06-26T03:30:08.319473Z","end":"2026-06-26T03:30:08.468032Z","steps":["trace[136573871] 'range keys from in-memory index tree' (duration: 148.432291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.468164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.01712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.468248Z","caller":"traceutil/trace.go:171","msg":"trace[1393273785] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1749; }","duration":"114.135733ms","start":"2026-06-26T03:30:08.354091Z","end":"2026-06-26T03:30:08.468227Z","steps":["trace[1393273785] 'range keys from in-memory index tree' (duration: 113.965849ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.468285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.963058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.468325Z","caller":"traceutil/trace.go:171","msg":"trace[1352656314] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1749; }","duration":"114.01051ms","start":"2026-06-26T03:30:08.354304Z","end":"2026-06-26T03:30:08.468315Z","steps":["trace[1352656314] 'count revisions from in-memory index tree' (duration: 113.896346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.468438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.890805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.468487Z","caller":"traceutil/trace.go:171","msg":"trace[457308080] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1749; }","duration":"148.964797ms","start":"2026-06-26T03:30:08.31951Z","end":"2026-06-26T03:30:08.468475Z","steps":["trace[457308080] 'count revisions from in-memory index tree' (duration: 148.824603ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.468646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.858654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.468681Z","caller":"traceutil/trace.go:171","msg":"trace[1758317429] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:1749; }","duration":"148.910086ms","start":"2026-06-26T03:30:08.319763Z","end":"2026-06-26T03:30:08.468673Z","steps":["trace[1758317429] 'range keys from in-memory index tree' (duration: 148.797052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.468809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.475912ms","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-06-26T03:30:08.468842Z","caller":"traceutil/trace.go:171","msg":"trace[661045633] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1749; }","duration":"130.521444ms","start":"2026-06-26T03:30:08.338313Z","end":"2026-06-26T03:30:08.468834Z","steps":["trace[661045633] 'count revisions from in-memory index tree' (duration: 130.448022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.468977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.703729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.469004Z","caller":"traceutil/trace.go:171","msg":"trace[131407012] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1749; }","duration":"130.746401ms","start":"2026-06-26T03:30:08.338249Z","end":"2026-06-26T03:30:08.468995Z","steps":["trace[131407012] 'range keys from in-memory index tree' (duration: 130.575505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.469109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.72597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.469138Z","caller":"traceutil/trace.go:171","msg":"trace[1220947504] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:1749; }","duration":"130.764171ms","start":"2026-06-26T03:30:08.338367Z","end":"2026-06-26T03:30:08.469131Z","steps":["trace[1220947504] 'range keys from in-memory index tree' (duration: 130.699219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:08.468249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.887226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:08.469338Z","caller":"traceutil/trace.go:171","msg":"trace[1292214879] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:1749; }","duration":"114.97971ms","start":"2026-06-26T03:30:08.354341Z","end":"2026-06-26T03:30:08.46932Z","steps":["trace[1292214879] 'range keys from in-memory index tree' (duration: 113.863165ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:14.328221Z","caller":"traceutil/trace.go:171","msg":"trace[1699758566] transaction","detail":"{read_only:false; response_revision:1848; number_of_response:1; }","duration":"111.203046ms","start":"2026-06-26T03:30:14.216965Z","end":"2026-06-26T03:30:14.328168Z","steps":["trace[1699758566] 'process raft request' (duration: 100.798854ms)","trace[1699758566] 'compare' (duration: 10.111032ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:15.09284Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15440203203296304820,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:30:15.451668Z","caller":"traceutil/trace.go:171","msg":"trace[40563671] transaction","detail":"{read_only:false; response_revision:1850; number_of_response:1; }","duration":"860.172605ms","start":"2026-06-26T03:30:14.591468Z","end":"2026-06-26T03:30:15.45164Z","steps":["trace[40563671] 'process raft request' (duration: 860.004709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.451995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.591437Z","time spent":"860.31777ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:15.748329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.918172ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:30:15.748765Z","caller":"traceutil/trace.go:171","msg":"trace[1416972881] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"992.494564ms","start":"2026-06-26T03:30:14.756241Z","end":"2026-06-26T03:30:15.748735Z","steps":["trace[1416972881] 'process raft request' (duration: 880.944169ms)","trace[1416972881] 'compare' (duration: 110.521118ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:15.748863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.756214Z","time spent":"992.596878ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:30:15.749247Z","caller":"traceutil/trace.go:171","msg":"trace[1083124820] linearizableReadLoop","detail":"{readStateIndex:1924; appliedIndex:1921; }","duration":"1.157079422s","start":"2026-06-26T03:30:14.592156Z","end":"2026-06-26T03:30:15.749235Z","steps":["trace[1083124820] 'read index received' (duration: 859.343235ms)","trace[1083124820] 'applied index is now lower than readState.Index' (duration: 297.735297ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:15.749625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.110398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8c457d6-25c4-41b9-94ee-248f27820af6\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-26T03:30:15.749698Z","caller":"traceutil/trace.go:171","msg":"trace[1263446432] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c8c457d6-25c4-41b9-94ee-248f27820af6; range_end:; response_count:1; response_revision:1852; }","duration":"936.222102ms","start":"2026-06-26T03:30:14.813464Z","end":"2026-06-26T03:30:15.749686Z","steps":["trace[1263446432] 'agreement among raft nodes before linearized reading' (duration: 936.047416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.749736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.813445Z","time spent":"936.282004ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8c457d6-25c4-41b9-94ee-248f27820af6\" "} {"level":"warn","ts":"2026-06-26T03:30:15.749714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.578211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:15.749808Z","caller":"traceutil/trace.go:171","msg":"trace[1889717870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1852; }","duration":"853.797008ms","start":"2026-06-26T03:30:14.895989Z","end":"2026-06-26T03:30:15.749786Z","steps":["trace[1889717870] 'agreement among raft nodes before linearized reading' (duration: 853.546899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.749853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.895976Z","time spent":"853.870031ms","remote":"127.0.0.1:33214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:30:15.749623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.153799818s","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-06-26T03:30:15.74997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"936.410968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8c457d6-25c4-41b9-94ee-248f27820af6\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-26T03:30:15.750004Z","caller":"traceutil/trace.go:171","msg":"trace[501346866] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c8c457d6-25c4-41b9-94ee-248f27820af6; range_end:; response_count:1; response_revision:1852; }","duration":"936.478691ms","start":"2026-06-26T03:30:14.813516Z","end":"2026-06-26T03:30:15.749994Z","steps":["trace[501346866] 'agreement among raft nodes before linearized reading' (duration: 936.382418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.75004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.813497Z","time spent":"936.537173ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8c457d6-25c4-41b9-94ee-248f27820af6\" "} {"level":"info","ts":"2026-06-26T03:30:15.750171Z","caller":"traceutil/trace.go:171","msg":"trace[1939207622] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1852; }","duration":"1.154216942s","start":"2026-06-26T03:30:14.595773Z","end":"2026-06-26T03:30:15.74999Z","steps":["trace[1939207622] 'agreement among raft nodes before linearized reading' (duration: 1.153665733s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.750235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158076567s","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-06-26T03:30:15.750276Z","caller":"traceutil/trace.go:171","msg":"trace[125516420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1852; }","duration":"1.158145049s","start":"2026-06-26T03:30:14.592122Z","end":"2026-06-26T03:30:15.750267Z","steps":["trace[125516420] 'agreement among raft nodes before linearized reading' (duration: 1.157974423s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.750304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.59211Z","time spent":"1.158188401s","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-26T03:30:15.750507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"949.486345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.144\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-26T03:30:15.750547Z","caller":"traceutil/trace.go:171","msg":"trace[1375111824] range","detail":"{range_begin:/registry/masterleases/199.204.45.144; range_end:; response_count:1; response_revision:1852; }","duration":"949.551387ms","start":"2026-06-26T03:30:14.800986Z","end":"2026-06-26T03:30:15.750537Z","steps":["trace[1375111824] 'agreement among raft nodes before linearized reading' (duration: 949.451294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.75058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.081150206s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-06-26T03:30:15.750582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.800968Z","time spent":"949.607269ms","remote":"127.0.0.1:33252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.144\" "} {"level":"info","ts":"2026-06-26T03:30:15.750615Z","caller":"traceutil/trace.go:171","msg":"trace[1345680118] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1852; }","duration":"1.081232338s","start":"2026-06-26T03:30:14.66937Z","end":"2026-06-26T03:30:15.750603Z","steps":["trace[1345680118] 'agreement among raft nodes before linearized reading' (duration: 1.081138244s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.750643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.669345Z","time spent":"1.08129127s","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-26T03:30:15.750636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"979.861744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-26T03:30:15.749478Z","caller":"traceutil/trace.go:171","msg":"trace[1036294355] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"787.799697ms","start":"2026-06-26T03:30:14.9616Z","end":"2026-06-26T03:30:15.749399Z","steps":["trace[1036294355] 'process raft request' (duration: 787.0714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.750967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.961572Z","time spent":"789.355561ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:15.751017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.153930703s","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-06-26T03:30:15.751099Z","caller":"traceutil/trace.go:171","msg":"trace[190466962] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1852; }","duration":"1.154070478s","start":"2026-06-26T03:30:14.597008Z","end":"2026-06-26T03:30:15.751078Z","steps":["trace[190466962] 'agreement among raft nodes before linearized reading' (duration: 1.153862901s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.751156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.596987Z","time spent":"1.154154771s","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:30:15.751147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.595763Z","time spent":"1.154473612s","remote":"127.0.0.1:51576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-26T03:30:15.750837Z","caller":"traceutil/trace.go:171","msg":"trace[1518027689] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1852; }","duration":"980.119353ms","start":"2026-06-26T03:30:14.770634Z","end":"2026-06-26T03:30:15.750754Z","steps":["trace[1518027689] 'agreement among raft nodes before linearized reading' (duration: 979.805772ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:15.751829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:14.770619Z","time spent":"981.049497ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T03:30:16.219181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:15.751456Z","time spent":"467.721408ms","remote":"127.0.0.1:33252","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-26T03:30:16.219233Z","caller":"traceutil/trace.go:171","msg":"trace[1726071806] linearizableReadLoop","detail":"{readStateIndex:1925; appliedIndex:1925; }","duration":"466.000587ms","start":"2026-06-26T03:30:15.753201Z","end":"2026-06-26T03:30:16.219202Z","steps":["trace[1726071806] 'read index received' (duration: 465.988327ms)","trace[1726071806] 'applied index is now lower than readState.Index' (duration: 9.17µs)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:16.21938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.151472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:16.2196Z","caller":"traceutil/trace.go:171","msg":"trace[1138307534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1852; }","duration":"466.402982ms","start":"2026-06-26T03:30:15.753172Z","end":"2026-06-26T03:30:16.219575Z","steps":["trace[1138307534] 'agreement among raft nodes before linearized reading' (duration: 466.123621ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:16.219667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:15.753154Z","time spent":"466.500666ms","remote":"127.0.0.1:33226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-26T03:30:16.226748Z","caller":"traceutil/trace.go:171","msg":"trace[755625025] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"472.793953ms","start":"2026-06-26T03:30:15.753942Z","end":"2026-06-26T03:30:16.226736Z","steps":["trace[755625025] 'process raft request' (duration: 472.632067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:16.226873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:15.753924Z","time spent":"472.894467ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:30:16.227165Z","caller":"traceutil/trace.go:171","msg":"trace[1231640686] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"471.713884ms","start":"2026-06-26T03:30:15.755428Z","end":"2026-06-26T03:30:16.227142Z","steps":["trace[1231640686] 'process raft request' (duration: 471.263218ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:16.227183Z","caller":"traceutil/trace.go:171","msg":"trace[1824036094] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"471.336341ms","start":"2026-06-26T03:30:15.755832Z","end":"2026-06-26T03:30:16.227168Z","steps":["trace[1824036094] 'process raft request' (duration: 471.283129ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:16.227179Z","caller":"traceutil/trace.go:171","msg":"trace[693505911] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"471.334451ms","start":"2026-06-26T03:30:15.75583Z","end":"2026-06-26T03:30:16.227165Z","steps":["trace[693505911] 'process raft request' (duration: 471.212457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:16.227265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:15.755416Z","time spent":"471.789457ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:16.227273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:15.75582Z","time spent":"471.426754ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:16.227305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.883647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"warn","ts":"2026-06-26T03:30:16.227371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:15.755823Z","time spent":"471.452725ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:30:16.227403Z","caller":"traceutil/trace.go:171","msg":"trace[1482817166] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1857; }","duration":"209.027251ms","start":"2026-06-26T03:30:16.018364Z","end":"2026-06-26T03:30:16.227392Z","steps":["trace[1482817166] 'agreement among raft nodes before linearized reading' (duration: 208.847825ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:16.227358Z","caller":"traceutil/trace.go:171","msg":"trace[455024211] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"469.753305ms","start":"2026-06-26T03:30:15.757596Z","end":"2026-06-26T03:30:16.227349Z","steps":["trace[455024211] 'process raft request' (duration: 469.547017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:16.22922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:15.757582Z","time spent":"471.483187ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:30:40.050542Z","caller":"traceutil/trace.go:171","msg":"trace[762829612] linearizableReadLoop","detail":"{readStateIndex:2122; appliedIndex:2120; }","duration":"154.622727ms","start":"2026-06-26T03:30:39.895895Z","end":"2026-06-26T03:30:40.050517Z","steps":["trace[762829612] 'read index received' (duration: 33.149113ms)","trace[762829612] 'applied index is now lower than readState.Index' (duration: 121.472734ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:40.050686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.774413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:40.05067Z","caller":"traceutil/trace.go:171","msg":"trace[853773226] transaction","detail":"{read_only:false; response_revision:2045; number_of_response:1; }","duration":"176.260706ms","start":"2026-06-26T03:30:39.874348Z","end":"2026-06-26T03:30:40.050609Z","steps":["trace[853773226] 'process raft request' (duration: 176.010444ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:40.050729Z","caller":"traceutil/trace.go:171","msg":"trace[558763593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2045; }","duration":"154.868098ms","start":"2026-06-26T03:30:39.895849Z","end":"2026-06-26T03:30:40.050717Z","steps":["trace[558763593] 'agreement among raft nodes before linearized reading' (duration: 154.785834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:40.109308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.405835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:30:40.109419Z","caller":"traceutil/trace.go:171","msg":"trace[867163144] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:2045; }","duration":"166.580253ms","start":"2026-06-26T03:30:39.942812Z","end":"2026-06-26T03:30:40.109392Z","steps":["trace[867163144] 'agreement among raft nodes before linearized reading' (duration: 166.383833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:40.10948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.228327ms","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-06-26T03:30:40.109558Z","caller":"traceutil/trace.go:171","msg":"trace[1006208562] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2045; }","duration":"197.354544ms","start":"2026-06-26T03:30:39.912185Z","end":"2026-06-26T03:30:40.10954Z","steps":["trace[1006208562] 'agreement among raft nodes before linearized reading' (duration: 197.046889ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:46.670601Z","caller":"traceutil/trace.go:171","msg":"trace[648036691] transaction","detail":"{read_only:false; response_revision:2078; number_of_response:1; }","duration":"220.162239ms","start":"2026-06-26T03:30:46.450399Z","end":"2026-06-26T03:30:46.670561Z","steps":["trace[648036691] 'process raft request' (duration: 172.524828ms)","trace[648036691] 'compare' (duration: 47.455752ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:30:46.670673Z","caller":"traceutil/trace.go:171","msg":"trace[1125768142] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"181.132856ms","start":"2026-06-26T03:30:46.489516Z","end":"2026-06-26T03:30:46.670649Z","steps":["trace[1125768142] 'process raft request' (duration: 181.020321ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:46.670692Z","caller":"traceutil/trace.go:171","msg":"trace[1812347706] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"181.164688ms","start":"2026-06-26T03:30:46.489514Z","end":"2026-06-26T03:30:46.670678Z","steps":["trace[1812347706] 'process raft request' (duration: 181.047242ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:46.670698Z","caller":"traceutil/trace.go:171","msg":"trace[1471763410] transaction","detail":"{read_only:false; response_revision:2079; number_of_response:1; }","duration":"181.181899ms","start":"2026-06-26T03:30:46.489477Z","end":"2026-06-26T03:30:46.670659Z","steps":["trace[1471763410] 'process raft request' (duration: 181.024491ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:46.670611Z","caller":"traceutil/trace.go:171","msg":"trace[1706087776] linearizableReadLoop","detail":"{readStateIndex:2160; appliedIndex:2156; }","duration":"168.837884ms","start":"2026-06-26T03:30:46.501752Z","end":"2026-06-26T03:30:46.67059Z","steps":["trace[1706087776] 'read index received' (duration: 121.183652ms)","trace[1706087776] 'applied index is now lower than readState.Index' (duration: 47.653292ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:46.671038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.275327ms","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-06-26T03:30:46.671068Z","caller":"traceutil/trace.go:171","msg":"trace[730980728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2081; }","duration":"169.359192ms","start":"2026-06-26T03:30:46.5017Z","end":"2026-06-26T03:30:46.671059Z","steps":["trace[730980728] 'agreement among raft nodes before linearized reading' (duration: 169.14625ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:47.82595Z","caller":"traceutil/trace.go:171","msg":"trace[708691749] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"129.496242ms","start":"2026-06-26T03:30:47.696416Z","end":"2026-06-26T03:30:47.825913Z","steps":["trace[708691749] 'process raft request' (duration: 129.2554ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:48.825517Z","caller":"traceutil/trace.go:171","msg":"trace[612445717] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"145.719888ms","start":"2026-06-26T03:30:48.679764Z","end":"2026-06-26T03:30:48.825484Z","steps":["trace[612445717] 'process raft request' (duration: 145.526418ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:48.840156Z","caller":"traceutil/trace.go:171","msg":"trace[1926686958] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"159.617178ms","start":"2026-06-26T03:30:48.680505Z","end":"2026-06-26T03:30:48.840122Z","steps":["trace[1926686958] 'process raft request' (duration: 159.535694ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:48.840188Z","caller":"traceutil/trace.go:171","msg":"trace[1866273720] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"159.717524ms","start":"2026-06-26T03:30:48.680419Z","end":"2026-06-26T03:30:48.840136Z","steps":["trace[1866273720] 'process raft request' (duration: 159.485383ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:48.840525Z","caller":"traceutil/trace.go:171","msg":"trace[1480366135] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"158.984317ms","start":"2026-06-26T03:30:48.681522Z","end":"2026-06-26T03:30:48.840506Z","steps":["trace[1480366135] 'process raft request' (duration: 158.564076ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:48.840674Z","caller":"traceutil/trace.go:171","msg":"trace[1921418328] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"158.149194ms","start":"2026-06-26T03:30:48.682501Z","end":"2026-06-26T03:30:48.84065Z","steps":["trace[1921418328] 'process raft request' (duration: 157.960014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:49.157632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.531871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:30:49.157839Z","caller":"traceutil/trace.go:171","msg":"trace[1186626442] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2093; }","duration":"102.768863ms","start":"2026-06-26T03:30:49.05505Z","end":"2026-06-26T03:30:49.157819Z","steps":["trace[1186626442] 'count revisions from in-memory index tree' (duration: 102.391634ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:50.350312Z","caller":"traceutil/trace.go:171","msg":"trace[103926283] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"397.261901ms","start":"2026-06-26T03:30:49.953006Z","end":"2026-06-26T03:30:50.350268Z","steps":["trace[103926283] 'process raft request' (duration: 396.979256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:50.350703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:49.952951Z","time spent":"397.499863ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:50.881263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.504348ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-26T03:30:50.881551Z","caller":"traceutil/trace.go:171","msg":"trace[70601637] linearizableReadLoop","detail":"{readStateIndex:2176; appliedIndex:2173; }","duration":"701.042356ms","start":"2026-06-26T03:30:50.180493Z","end":"2026-06-26T03:30:50.881535Z","steps":["trace[70601637] 'read index received' (duration: 169.475673ms)","trace[70601637] 'applied index is now lower than readState.Index' (duration: 531.565802ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:30:50.881556Z","caller":"traceutil/trace.go:171","msg":"trace[1378353826] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"908.389314ms","start":"2026-06-26T03:30:49.973138Z","end":"2026-06-26T03:30:50.881528Z","steps":["trace[1378353826] 'process raft request' (duration: 908.222655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:50.881724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:49.97311Z","time spent":"908.514571ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:50.881975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.051791ms","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-06-26T03:30:50.882052Z","caller":"traceutil/trace.go:171","msg":"trace[505643675] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2097; }","duration":"407.191428ms","start":"2026-06-26T03:30:50.474836Z","end":"2026-06-26T03:30:50.882028Z","steps":["trace[505643675] 'agreement among raft nodes before linearized reading' (duration: 406.965786ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:50.882074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.578142ms","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-06-26T03:30:50.882116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:50.474804Z","time spent":"407.290913ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:30:50.882132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.293329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:30:50.882248Z","caller":"traceutil/trace.go:171","msg":"trace[983069013] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2097; }","duration":"234.452377ms","start":"2026-06-26T03:30:50.647749Z","end":"2026-06-26T03:30:50.882202Z","steps":["trace[983069013] 'agreement among raft nodes before linearized reading' (duration: 234.236506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:50.88231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.808764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-06-26T03:30:50.882365Z","caller":"traceutil/trace.go:171","msg":"trace[572028149] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2097; }","duration":"300.901449ms","start":"2026-06-26T03:30:50.581451Z","end":"2026-06-26T03:30:50.882352Z","steps":["trace[572028149] 'agreement among raft nodes before linearized reading' (duration: 300.772092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:50.882427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:50.581428Z","time spent":"300.975043ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-06-26T03:30:50.882471Z","caller":"traceutil/trace.go:171","msg":"trace[259548614] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"360.032184ms","start":"2026-06-26T03:30:50.522425Z","end":"2026-06-26T03:30:50.882457Z","steps":["trace[259548614] 'process raft request' (duration: 359.067984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:50.882554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:50.522389Z","time spent":"360.123659ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:30:50.882126Z","caller":"traceutil/trace.go:171","msg":"trace[1439625744] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2097; }","duration":"701.662577ms","start":"2026-06-26T03:30:50.180449Z","end":"2026-06-26T03:30:50.882112Z","steps":["trace[1439625744] 'agreement among raft nodes before linearized reading' (duration: 701.211874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:50.882972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:50.180427Z","time spent":"702.526711ms","remote":"127.0.0.1:51576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-26T03:30:51.062261Z","caller":"traceutil/trace.go:171","msg":"trace[988272219] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"173.215213ms","start":"2026-06-26T03:30:50.889005Z","end":"2026-06-26T03:30:51.06222Z","steps":["trace[988272219] 'process raft request' (duration: 164.966648ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:51.062619Z","caller":"traceutil/trace.go:171","msg":"trace[691903126] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"173.457906ms","start":"2026-06-26T03:30:50.889126Z","end":"2026-06-26T03:30:51.062584Z","steps":["trace[691903126] 'process raft request' (duration: 173.039254ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:51.062712Z","caller":"traceutil/trace.go:171","msg":"trace[1894782550] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"173.451865ms","start":"2026-06-26T03:30:50.889241Z","end":"2026-06-26T03:30:51.062693Z","steps":["trace[1894782550] 'process raft request' (duration: 173.188732ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:51.062746Z","caller":"traceutil/trace.go:171","msg":"trace[948193422] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"172.664634ms","start":"2026-06-26T03:30:50.890057Z","end":"2026-06-26T03:30:51.062722Z","steps":["trace[948193422] 'process raft request' (duration: 172.560989ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:51.062882Z","caller":"traceutil/trace.go:171","msg":"trace[1677449333] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"173.270806ms","start":"2026-06-26T03:30:50.889597Z","end":"2026-06-26T03:30:51.062868Z","steps":["trace[1677449333] 'process raft request' (duration: 172.972241ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:51.062903Z","caller":"traceutil/trace.go:171","msg":"trace[1284814010] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"172.597191ms","start":"2026-06-26T03:30:50.890294Z","end":"2026-06-26T03:30:51.062891Z","steps":["trace[1284814010] 'process raft request' (duration: 172.378749ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:51.062924Z","caller":"traceutil/trace.go:171","msg":"trace[395017776] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2177; }","duration":"169.714203ms","start":"2026-06-26T03:30:50.893071Z","end":"2026-06-26T03:30:51.062785Z","steps":["trace[395017776] 'read index received' (duration: 76.549357ms)","trace[395017776] 'applied index is now lower than readState.Index' (duration: 93.163736ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:51.063128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.03588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:51.063195Z","caller":"traceutil/trace.go:171","msg":"trace[1647674631] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2104; }","duration":"170.146335ms","start":"2026-06-26T03:30:50.893033Z","end":"2026-06-26T03:30:51.06318Z","steps":["trace[1647674631] 'agreement among raft nodes before linearized reading' (duration: 169.974717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:51.468379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.233768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:30:51.468543Z","caller":"traceutil/trace.go:171","msg":"trace[1670862109] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"346.56188ms","start":"2026-06-26T03:30:51.121932Z","end":"2026-06-26T03:30:51.468494Z","steps":["trace[1670862109] 'process raft request' (duration: 242.704211ms)","trace[1670862109] 'compare' (duration: 103.023986ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:51.468621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:51.121903Z","time spent":"346.681087ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:30:52.082426Z","caller":"traceutil/trace.go:171","msg":"trace[1847121873] linearizableReadLoop","detail":"{readStateIndex:2186; appliedIndex:2185; }","duration":"191.683968ms","start":"2026-06-26T03:30:51.89071Z","end":"2026-06-26T03:30:52.082394Z","steps":["trace[1847121873] 'read index received' (duration: 191.432375ms)","trace[1847121873] 'applied index is now lower than readState.Index' (duration: 250.453µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:30:52.082512Z","caller":"traceutil/trace.go:171","msg":"trace[1872144769] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"202.257432ms","start":"2026-06-26T03:30:51.880223Z","end":"2026-06-26T03:30:52.082481Z","steps":["trace[1872144769] 'process raft request' (duration: 202.0122ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:52.082631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.999048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:52.082676Z","caller":"traceutil/trace.go:171","msg":"trace[1919183558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2106; }","duration":"187.095442ms","start":"2026-06-26T03:30:51.895569Z","end":"2026-06-26T03:30:52.082664Z","steps":["trace[1919183558] 'agreement among raft nodes before linearized reading' (duration: 186.981966ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:52.082704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.985013ms","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-06-26T03:30:52.082778Z","caller":"traceutil/trace.go:171","msg":"trace[2045551113] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2106; }","duration":"192.10727ms","start":"2026-06-26T03:30:51.89065Z","end":"2026-06-26T03:30:52.082757Z","steps":["trace[2045551113] 'agreement among raft nodes before linearized reading' (duration: 191.883638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:52.653605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.035842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:52.653705Z","caller":"traceutil/trace.go:171","msg":"trace[525170007] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2106; }","duration":"361.18488ms","start":"2026-06-26T03:30:52.292499Z","end":"2026-06-26T03:30:52.653684Z","steps":["trace[525170007] 'count revisions from in-memory index tree' (duration: 360.911566ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:52.653975Z","caller":"traceutil/trace.go:171","msg":"trace[1718570849] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"297.863668ms","start":"2026-06-26T03:30:52.356067Z","end":"2026-06-26T03:30:52.65393Z","steps":["trace[1718570849] 'process raft request' (duration: 296.070566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:52.654077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:52.292475Z","time spent":"361.465364ms","remote":"127.0.0.1:60402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:30:53.453929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.692595ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:30:53.454051Z","caller":"traceutil/trace.go:171","msg":"trace[1210469799] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"796.503461ms","start":"2026-06-26T03:30:52.657534Z","end":"2026-06-26T03:30:53.454037Z","steps":["trace[1210469799] 'process raft request' (duration: 392.638437ms)","trace[1210469799] 'compare' (duration: 403.618432ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:53.454097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:52.657504Z","time spent":"796.571194ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:30:53.45432Z","caller":"traceutil/trace.go:171","msg":"trace[773736524] linearizableReadLoop","detail":"{readStateIndex:2189; appliedIndex:2187; }","duration":"480.210307ms","start":"2026-06-26T03:30:52.97405Z","end":"2026-06-26T03:30:53.45426Z","steps":["trace[773736524] 'read index received' (duration: 76.113281ms)","trace[773736524] 'applied index is now lower than readState.Index' (duration: 404.094596ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:30:53.454646Z","caller":"traceutil/trace.go:171","msg":"trace[1736706106] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"566.002313ms","start":"2026-06-26T03:30:52.888598Z","end":"2026-06-26T03:30:53.4546Z","steps":["trace[1736706106] 'process raft request' (duration: 565.405602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.454749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.03504ms","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-06-26T03:30:53.454833Z","caller":"traceutil/trace.go:171","msg":"trace[843738826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2109; }","duration":"384.153256ms","start":"2026-06-26T03:30:53.070662Z","end":"2026-06-26T03:30:53.454815Z","steps":["trace[843738826] 'agreement among raft nodes before linearized reading' (duration: 383.946855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.454881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.07065Z","time spent":"384.22296ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:30:53.454891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:52.888559Z","time spent":"566.200313ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:53.455216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.183829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18bc83f58d5b81a6\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-26T03:30:53.455261Z","caller":"traceutil/trace.go:171","msg":"trace[622597571] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18bc83f58d5b81a6; range_end:; response_count:1; response_revision:2109; }","duration":"264.274753ms","start":"2026-06-26T03:30:53.190974Z","end":"2026-06-26T03:30:53.455249Z","steps":["trace[622597571] 'agreement among raft nodes before linearized reading' (duration: 264.156117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.455371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.213874ms","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-06-26T03:30:53.455426Z","caller":"traceutil/trace.go:171","msg":"trace[1157106659] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2109; }","duration":"386.762532ms","start":"2026-06-26T03:30:53.06865Z","end":"2026-06-26T03:30:53.455412Z","steps":["trace[1157106659] 'agreement among raft nodes before linearized reading' (duration: 386.084807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.4547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.743091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-26T03:30:53.455469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.891543ms","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-06-26T03:30:53.455494Z","caller":"traceutil/trace.go:171","msg":"trace[331249383] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2109; }","duration":"387.572074ms","start":"2026-06-26T03:30:53.067903Z","end":"2026-06-26T03:30:53.455475Z","steps":["trace[331249383] 'agreement among raft nodes before linearized reading' (duration: 386.618265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.455497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.068625Z","time spent":"386.861038ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-26T03:30:53.455563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.067882Z","time spent":"387.663319ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T03:30:53.455508Z","caller":"traceutil/trace.go:171","msg":"trace[2008911462] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2109; }","duration":"365.951616ms","start":"2026-06-26T03:30:53.089547Z","end":"2026-06-26T03:30:53.455499Z","steps":["trace[2008911462] 'agreement among raft nodes before linearized reading' (duration: 365.848731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.455703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.62824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-26T03:30:53.455723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.089534Z","time spent":"366.177017ms","remote":"127.0.0.1:51576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-26T03:30:53.45574Z","caller":"traceutil/trace.go:171","msg":"trace[338683734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2109; }","duration":"481.687373ms","start":"2026-06-26T03:30:52.974042Z","end":"2026-06-26T03:30:53.455729Z","steps":["trace[338683734] 'agreement among raft nodes before linearized reading' (duration: 480.4621ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.455803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:52.973982Z","time spent":"481.81182ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:30:53.455938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.742618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-06-26T03:30:53.455985Z","caller":"traceutil/trace.go:171","msg":"trace[739355924] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2109; }","duration":"385.815712ms","start":"2026-06-26T03:30:53.070156Z","end":"2026-06-26T03:30:53.455972Z","steps":["trace[739355924] 'agreement among raft nodes before linearized reading' (duration: 385.563839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.456027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.070142Z","time spent":"385.873015ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-06-26T03:30:53.455399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.878705ms","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-06-26T03:30:53.457032Z","caller":"traceutil/trace.go:171","msg":"trace[1692199341] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2109; }","duration":"387.530442ms","start":"2026-06-26T03:30:53.069461Z","end":"2026-06-26T03:30:53.456992Z","steps":["trace[1692199341] 'agreement among raft nodes before linearized reading' (duration: 385.171568ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:53.457155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.06945Z","time spent":"387.68685ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-26T03:30:54.223028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.915328ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:30:54.223605Z","caller":"traceutil/trace.go:171","msg":"trace[1247960150] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2190; }","duration":"397.409738ms","start":"2026-06-26T03:30:53.826179Z","end":"2026-06-26T03:30:54.223589Z","steps":["trace[1247960150] 'read index received' (duration: 262.767522ms)","trace[1247960150] 'applied index is now lower than readState.Index' (duration: 134.641086ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:30:54.223694Z","caller":"traceutil/trace.go:171","msg":"trace[1960979255] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"763.347575ms","start":"2026-06-26T03:30:53.460318Z","end":"2026-06-26T03:30:54.223665Z","steps":["trace[1960979255] 'process raft request' (duration: 763.109192ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:54.223722Z","caller":"traceutil/trace.go:171","msg":"trace[696714029] transaction","detail":"{read_only:false; response_revision:2115; number_of_response:1; }","duration":"763.04993ms","start":"2026-06-26T03:30:53.460652Z","end":"2026-06-26T03:30:54.223702Z","steps":["trace[696714029] 'process raft request' (duration: 762.861999ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:54.223848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.460644Z","time spent":"763.126114ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:54.223862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.460293Z","time spent":"763.474312ms","remote":"127.0.0.1:57362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:30:54.22387Z","caller":"traceutil/trace.go:171","msg":"trace[391527491] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"763.476763ms","start":"2026-06-26T03:30:53.46033Z","end":"2026-06-26T03:30:54.223807Z","steps":["trace[391527491] 'process raft request' (duration: 763.147695ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:54.223872Z","caller":"traceutil/trace.go:171","msg":"trace[1232489197] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"763.189927ms","start":"2026-06-26T03:30:53.460668Z","end":"2026-06-26T03:30:54.223858Z","steps":["trace[1232489197] 'process raft request' (duration: 762.88256ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:54.22403Z","caller":"traceutil/trace.go:171","msg":"trace[255802990] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"763.662952ms","start":"2026-06-26T03:30:53.46032Z","end":"2026-06-26T03:30:54.223983Z","steps":["trace[255802990] 'process raft request' (duration: 763.049869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:54.224185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.460659Z","time spent":"763.42594ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:54.224251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.460312Z","time spent":"763.82465ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:54.224309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.128117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:30:54.224349Z","caller":"traceutil/trace.go:171","msg":"trace[1458399092] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:2116; }","duration":"398.20417ms","start":"2026-06-26T03:30:53.826134Z","end":"2026-06-26T03:30:54.224339Z","steps":["trace[1458399092] 'agreement among raft nodes before linearized reading' (duration: 398.136467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:54.22436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.566505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:30:54.224382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.826109Z","time spent":"398.265733ms","remote":"127.0.0.1:57618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":23,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"info","ts":"2026-06-26T03:30:54.224316Z","caller":"traceutil/trace.go:171","msg":"trace[1120721198] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"764.059112ms","start":"2026-06-26T03:30:53.460237Z","end":"2026-06-26T03:30:54.224296Z","steps":["trace[1120721198] 'process raft request' (duration: 628.787962ms)","trace[1120721198] 'compare' (duration: 133.809643ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:30:54.224423Z","caller":"traceutil/trace.go:171","msg":"trace[2049486206] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:2116; }","duration":"308.652309ms","start":"2026-06-26T03:30:53.915753Z","end":"2026-06-26T03:30:54.224406Z","steps":["trace[2049486206] 'agreement among raft nodes before linearized reading' (duration: 308.48652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:54.224195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.466238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:30:54.224477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.915738Z","time spent":"308.722253ms","remote":"127.0.0.1:57412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-06-26T03:30:54.224495Z","caller":"traceutil/trace.go:171","msg":"trace[1360923299] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2116; }","duration":"330.847908ms","start":"2026-06-26T03:30:53.89363Z","end":"2026-06-26T03:30:54.224478Z","steps":["trace[1360923299] 'agreement among raft nodes before linearized reading' (duration: 330.449457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:54.224521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.46022Z","time spent":"764.20296ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:54.22452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.081452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12384"} {"level":"info","ts":"2026-06-26T03:30:54.224589Z","caller":"traceutil/trace.go:171","msg":"trace[1353386176] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2116; }","duration":"318.199148ms","start":"2026-06-26T03:30:53.906373Z","end":"2026-06-26T03:30:54.224572Z","steps":["trace[1353386176] 'agreement among raft nodes before linearized reading' (duration: 317.978476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:30:54.224537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.893606Z","time spent":"330.920541ms","remote":"127.0.0.1:33214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-26T03:30:54.224185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.460303Z","time spent":"763.700924ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:30:54.224657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:30:53.906352Z","time spent":"318.286472ms","remote":"127.0.0.1:57456","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12407,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-26T03:30:54.224244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.388071ms","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-06-26T03:30:54.224805Z","caller":"traceutil/trace.go:171","msg":"trace[1367643381] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2116; }","duration":"137.988172ms","start":"2026-06-26T03:30:54.086805Z","end":"2026-06-26T03:30:54.224793Z","steps":["trace[1367643381] 'agreement among raft nodes before linearized reading' (duration: 137.321317ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:54.382017Z","caller":"traceutil/trace.go:171","msg":"trace[90530762] linearizableReadLoop","detail":"{readStateIndex:2197; appliedIndex:2196; }","duration":"145.609181ms","start":"2026-06-26T03:30:54.236383Z","end":"2026-06-26T03:30:54.381992Z","steps":["trace[90530762] 'read index received' (duration: 136.701644ms)","trace[90530762] 'applied index is now lower than readState.Index' (duration: 8.906567ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:30:54.382157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.750199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:30:54.382196Z","caller":"traceutil/trace.go:171","msg":"trace[634722629] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2117; }","duration":"145.825162ms","start":"2026-06-26T03:30:54.236361Z","end":"2026-06-26T03:30:54.382186Z","steps":["trace[634722629] 'agreement among raft nodes before linearized reading' (duration: 145.741988ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:30:54.382163Z","caller":"traceutil/trace.go:171","msg":"trace[1578679987] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"150.360681ms","start":"2026-06-26T03:30:54.231777Z","end":"2026-06-26T03:30:54.382138Z","steps":["trace[1578679987] 'process raft request' (duration: 141.332657ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:31:04.550255Z","caller":"traceutil/trace.go:171","msg":"trace[1588974579] linearizableReadLoop","detail":"{readStateIndex:2251; appliedIndex:2250; }","duration":"112.117562ms","start":"2026-06-26T03:31:04.438114Z","end":"2026-06-26T03:31:04.550231Z","steps":["trace[1588974579] 'read index received' (duration: 57.444522ms)","trace[1588974579] 'applied index is now lower than readState.Index' (duration: 54.67207ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:31:04.55037Z","caller":"traceutil/trace.go:171","msg":"trace[865108435] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"123.79944ms","start":"2026-06-26T03:31:04.426537Z","end":"2026-06-26T03:31:04.550337Z","steps":["trace[865108435] 'process raft request' (duration: 69.088748ms)","trace[865108435] 'compare' (duration: 54.466788ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:31:04.550582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.300601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:31:04.550632Z","caller":"traceutil/trace.go:171","msg":"trace[1704015358] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2169; }","duration":"112.552835ms","start":"2026-06-26T03:31:04.438066Z","end":"2026-06-26T03:31:04.550619Z","steps":["trace[1704015358] 'agreement among raft nodes before linearized reading' (duration: 112.310602ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:32:27.987077Z","caller":"traceutil/trace.go:171","msg":"trace[1913253833] linearizableReadLoop","detail":"{readStateIndex:2823; appliedIndex:2822; }","duration":"190.018224ms","start":"2026-06-26T03:32:27.797038Z","end":"2026-06-26T03:32:27.987056Z","steps":["trace[1913253833] 'read index received' (duration: 33.832µs)","trace[1913253833] 'applied index is now lower than readState.Index' (duration: 189.983512ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:32:27.987174Z","caller":"traceutil/trace.go:171","msg":"trace[582162288] transaction","detail":"{read_only:false; response_revision:2721; number_of_response:1; }","duration":"190.093889ms","start":"2026-06-26T03:32:27.797014Z","end":"2026-06-26T03:32:27.987107Z","steps":["trace[582162288] 'process raft request' (duration: 189.909667ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:32:27.98725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.191215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:32:27.98729Z","caller":"traceutil/trace.go:171","msg":"trace[6648372] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2721; }","duration":"190.282972ms","start":"2026-06-26T03:32:27.796995Z","end":"2026-06-26T03:32:27.987278Z","steps":["trace[6648372] 'agreement among raft nodes before linearized reading' (duration: 190.193186ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:32:28.268997Z","caller":"traceutil/trace.go:171","msg":"trace[1026164576] transaction","detail":"{read_only:false; response_revision:2722; number_of_response:1; }","duration":"276.152302ms","start":"2026-06-26T03:32:27.992819Z","end":"2026-06-26T03:32:28.268971Z","steps":["trace[1026164576] 'process raft request' (duration: 197.72427ms)","trace[1026164576] 'compare' (duration: 78.216877ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:33:32.917113Z","caller":"traceutil/trace.go:171","msg":"trace[682075020] transaction","detail":"{read_only:false; response_revision:3058; number_of_response:1; }","duration":"330.632586ms","start":"2026-06-26T03:33:32.586451Z","end":"2026-06-26T03:33:32.917084Z","steps":["trace[682075020] 'process raft request' (duration: 330.450442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:33:32.917344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:33:32.586429Z","time spent":"330.784162ms","remote":"127.0.0.1:57540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:33:32.922744Z","caller":"traceutil/trace.go:171","msg":"trace[1369207691] transaction","detail":"{read_only:false; response_revision:3059; number_of_response:1; }","duration":"191.955317ms","start":"2026-06-26T03:33:32.730767Z","end":"2026-06-26T03:33:32.922722Z","steps":["trace[1369207691] 'process raft request' (duration: 191.775943ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:08.569367Z","caller":"traceutil/trace.go:171","msg":"trace[88152371] transaction","detail":"{read_only:false; response_revision:4500; number_of_response:1; }","duration":"109.670717ms","start":"2026-06-26T03:36:08.459655Z","end":"2026-06-26T03:36:08.569325Z","steps":["trace[88152371] 'process raft request' (duration: 71.975388ms)","trace[88152371] 'compare' (duration: 37.606146ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:13.15831Z","caller":"traceutil/trace.go:171","msg":"trace[644135631] transaction","detail":"{read_only:false; response_revision:4604; number_of_response:1; }","duration":"172.874494ms","start":"2026-06-26T03:36:12.985413Z","end":"2026-06-26T03:36:13.158287Z","steps":["trace[644135631] 'process raft request' (duration: 172.651777ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:13.357257Z","caller":"traceutil/trace.go:171","msg":"trace[1083741061] transaction","detail":"{read_only:false; response_revision:4608; number_of_response:1; }","duration":"130.457134ms","start":"2026-06-26T03:36:13.226771Z","end":"2026-06-26T03:36:13.357229Z","steps":["trace[1083741061] 'process raft request' (duration: 130.249487ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:13.947355Z","caller":"traceutil/trace.go:171","msg":"trace[297028310] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"151.205506ms","start":"2026-06-26T03:36:13.796123Z","end":"2026-06-26T03:36:13.947329Z","steps":["trace[297028310] 'process raft request' (duration: 151.040001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:18.063874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.429519ms","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-06-26T03:36:18.064Z","caller":"traceutil/trace.go:171","msg":"trace[1031529274] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4692; }","duration":"116.575404ms","start":"2026-06-26T03:36:17.947407Z","end":"2026-06-26T03:36:18.063982Z","steps":["trace[1031529274] 'range keys from in-memory index tree' (duration: 116.412869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:18.064167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.269204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:36:18.064383Z","caller":"traceutil/trace.go:171","msg":"trace[754024221] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"275.166025ms","start":"2026-06-26T03:36:17.789199Z","end":"2026-06-26T03:36:18.064365Z","steps":["trace[754024221] 'process raft request' (duration: 275.04805ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:18.064408Z","caller":"traceutil/trace.go:171","msg":"trace[1044802302] linearizableReadLoop","detail":"{readStateIndex:4870; appliedIndex:4868; }","duration":"170.502848ms","start":"2026-06-26T03:36:17.893881Z","end":"2026-06-26T03:36:18.064384Z","steps":["trace[1044802302] 'read index received' (duration: 115.140835ms)","trace[1044802302] 'applied index is now lower than readState.Index' (duration: 55.360033ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:18.064431Z","caller":"traceutil/trace.go:171","msg":"trace[1181759217] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"276.678036ms","start":"2026-06-26T03:36:17.787715Z","end":"2026-06-26T03:36:18.064393Z","steps":["trace[1181759217] 'compare' (duration: 267.171431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:18.064609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.707766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:36:18.064722Z","caller":"traceutil/trace.go:171","msg":"trace[1005660783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4695; }","duration":"170.805619ms","start":"2026-06-26T03:36:17.893874Z","end":"2026-06-26T03:36:18.06468Z","steps":["trace[1005660783] 'agreement among raft nodes before linearized reading' (duration: 170.669884ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:18.729358Z","caller":"traceutil/trace.go:171","msg":"trace[862627168] transaction","detail":"{read_only:false; response_revision:4701; number_of_response:1; }","duration":"115.872642ms","start":"2026-06-26T03:36:18.613463Z","end":"2026-06-26T03:36:18.729336Z","steps":["trace[862627168] 'process raft request' (duration: 115.707966ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:30.889503Z","caller":"traceutil/trace.go:171","msg":"trace[1873507136] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"253.953004ms","start":"2026-06-26T03:36:30.635471Z","end":"2026-06-26T03:36:30.889424Z","steps":["trace[1873507136] 'process raft request' (duration: 253.697964ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:59.801279Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2889} {"level":"info","ts":"2026-06-26T03:37:59.88203Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2889,"took":"79.353586ms","hash":4044688333,"current-db-size-bytes":53673984,"current-db-size":"54 MB","current-db-size-in-use-bytes":30011392,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-26T03:37:59.882098Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4044688333,"revision":2889,"compact-revision":-1} {"level":"info","ts":"2026-06-26T03:42:59.806564Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5610} {"level":"info","ts":"2026-06-26T03:42:59.881312Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5610,"took":"73.613984ms","hash":3030346306,"current-db-size-bytes":53673984,"current-db-size":"54 MB","current-db-size-in-use-bytes":18444288,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-26T03:42:59.881356Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3030346306,"revision":5610,"compact-revision":2889}