{"level":"warn","ts":"2026-10-03T05:43:45.981831Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T05:43:45.981966Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.73:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.73:2380","--initial-cluster=instance=https://162.253.55.73:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.73:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.73: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-10-03T05:43:45.982159Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T05:43:45.982177Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.73:2380"]} {"level":"info","ts":"2026-10-03T05:43:45.982208Z","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-10-03T05:43:45.983504Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"]} {"level":"info","ts":"2026-10-03T05:43:45.983606Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.73:2380"],"listen-peer-urls":["https://162.253.55.73:2380"],"advertise-client-urls":["https://162.253.55.73:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.73: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-10-03T05:43:46.015084Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"31.233937ms"} {"level":"info","ts":"2026-10-03T05:43:46.069123Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4c43c9f84c6588d4","cluster-id":"49c90045dbd991f3"} {"level":"info","ts":"2026-10-03T05:43:46.069246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=()"} {"level":"info","ts":"2026-10-03T05:43:46.069274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became follower at term 0"} {"level":"info","ts":"2026-10-03T05:43:46.069293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4c43c9f84c6588d4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-03T05:43:46.069301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became follower at term 1"} {"level":"info","ts":"2026-10-03T05:43:46.069368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=(5495458038592932052)"} {"level":"warn","ts":"2026-10-03T05:43:46.117834Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-03T05:43:46.125226Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-03T05:43:46.127323Z","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-10-03T05:43:46.131491Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4c43c9f84c6588d4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-03T05:43:46.131738Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4c43c9f84c6588d4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-03T05:43:46.131904Z","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-10-03T05:43:46.131971Z","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-10-03T05:43:46.131983Z","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-10-03T05:43:46.144304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 switched to configuration voters=(5495458038592932052)"} {"level":"info","ts":"2026-10-03T05:43:46.144473Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49c90045dbd991f3","local-member-id":"4c43c9f84c6588d4","added-peer-id":"4c43c9f84c6588d4","added-peer-peer-urls":["https://162.253.55.73:2380"]} {"level":"info","ts":"2026-10-03T05:43:46.146091Z","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-10-03T05:43:46.146301Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.73:2380"} {"level":"info","ts":"2026-10-03T05:43:46.146347Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.73:2380"} {"level":"info","ts":"2026-10-03T05:43:46.146619Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4c43c9f84c6588d4","initial-advertise-peer-urls":["https://162.253.55.73:2380"],"listen-peer-urls":["https://162.253.55.73:2380"],"advertise-client-urls":["https://162.253.55.73:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.73:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-03T05:43:46.14667Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-03T05:43:46.869934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 is starting a new election at term 1"} {"level":"info","ts":"2026-10-03T05:43:46.870017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-03T05:43:46.870059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 received MsgPreVoteResp from 4c43c9f84c6588d4 at term 1"} {"level":"info","ts":"2026-10-03T05:43:46.870079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became candidate at term 2"} {"level":"info","ts":"2026-10-03T05:43:46.87009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 received MsgVoteResp from 4c43c9f84c6588d4 at term 2"} {"level":"info","ts":"2026-10-03T05:43:46.870105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4c43c9f84c6588d4 became leader at term 2"} {"level":"info","ts":"2026-10-03T05:43:46.870118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4c43c9f84c6588d4 elected leader 4c43c9f84c6588d4 at term 2"} {"level":"info","ts":"2026-10-03T05:43:46.872317Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4c43c9f84c6588d4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.73:2379]}","request-path":"/0/members/4c43c9f84c6588d4/attributes","cluster-id":"49c90045dbd991f3","publish-timeout":"7s"} {"level":"info","ts":"2026-10-03T05:43:46.872366Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:43:46.872559Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T05:43:46.872597Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T05:43:46.873021Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-03T05:43:46.873138Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-03T05:43:46.873472Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49c90045dbd991f3","local-member-id":"4c43c9f84c6588d4","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:43:46.873565Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:43:46.873593Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:43:46.875871Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.73:2379"} {"level":"info","ts":"2026-10-03T05:43:46.876462Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-10-03T05:43:50.132607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.128567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-03T05:43:50.132775Z","caller":"traceutil/trace.go:171","msg":"trace[671549095] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"325.640098ms","start":"2026-10-03T05:43:49.807105Z","end":"2026-10-03T05:43:50.132745Z","steps":["trace[671549095] 'process raft request' (duration: 118.479357ms)","trace[671549095] 'compare' (duration: 205.93174ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:43:50.132917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:43:49.807089Z","time spent":"325.792452ms","remote":"127.0.0.1:42868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":867,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:43:50.363605Z","caller":"traceutil/trace.go:171","msg":"trace[1263497212] transaction","detail":"{read_only:false; response_revision:114; number_of_response:1; }","duration":"225.164295ms","start":"2026-10-03T05:43:50.138408Z","end":"2026-10-03T05:43:50.363572Z","steps":["trace[1263497212] 'process raft request' (duration: 225.00397ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:43:50.562795Z","caller":"traceutil/trace.go:171","msg":"trace[1045905710] transaction","detail":"{read_only:false; response_revision:115; number_of_response:1; }","duration":"192.359448ms","start":"2026-10-03T05:43:50.370399Z","end":"2026-10-03T05:43:50.562759Z","steps":["trace[1045905710] 'process raft request' (duration: 93.042101ms)","trace[1045905710] 'compare' (duration: 98.967176ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:44:13.082288Z","caller":"traceutil/trace.go:171","msg":"trace[1991442927] linearizableReadLoop","detail":"{readStateIndex:460; appliedIndex:459; }","duration":"116.514226ms","start":"2026-10-03T05:44:12.965736Z","end":"2026-10-03T05:44:13.08225Z","steps":["trace[1991442927] 'read index received' (duration: 37.49275ms)","trace[1991442927] 'applied index is now lower than readState.Index' (duration: 79.019836ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:44:13.082391Z","caller":"traceutil/trace.go:171","msg":"trace[1067940252] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"116.69285ms","start":"2026-10-03T05:44:12.96567Z","end":"2026-10-03T05:44:13.082362Z","steps":["trace[1067940252] 'process raft request' (duration: 37.622742ms)","trace[1067940252] 'compare' (duration: 78.796781ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:44:13.082528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.762663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-10-03T05:44:13.082918Z","caller":"traceutil/trace.go:171","msg":"trace[808325888] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:448; }","duration":"117.176793ms","start":"2026-10-03T05:44:12.965712Z","end":"2026-10-03T05:44:13.082889Z","steps":["trace[808325888] 'agreement among raft nodes before linearized reading' (duration: 116.659899ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:13.083397Z","caller":"traceutil/trace.go:171","msg":"trace[1045062291] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"117.387909ms","start":"2026-10-03T05:44:12.965969Z","end":"2026-10-03T05:44:13.083357Z","steps":["trace[1045062291] 'process raft request' (duration: 116.726162ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:13.083536Z","caller":"traceutil/trace.go:171","msg":"trace[2070486887] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"115.125409ms","start":"2026-10-03T05:44:12.968366Z","end":"2026-10-03T05:44:13.083491Z","steps":["trace[2070486887] 'process raft request' (duration: 114.672187ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:13.256346Z","caller":"traceutil/trace.go:171","msg":"trace[1859215181] linearizableReadLoop","detail":"{readStateIndex:471; appliedIndex:469; }","duration":"123.575052ms","start":"2026-10-03T05:44:13.132747Z","end":"2026-10-03T05:44:13.256322Z","steps":["trace[1859215181] 'read index received' (duration: 11.685686ms)","trace[1859215181] 'applied index is now lower than readState.Index' (duration: 111.887876ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:44:13.256638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.872999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"info","ts":"2026-10-03T05:44:13.256701Z","caller":"traceutil/trace.go:171","msg":"trace[2015250881] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"124.048774ms","start":"2026-10-03T05:44:13.132628Z","end":"2026-10-03T05:44:13.256677Z","steps":["trace[2015250881] 'process raft request' (duration: 74.747145ms)","trace[2015250881] 'compare' (duration: 48.749925ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:44:13.256766Z","caller":"traceutil/trace.go:171","msg":"trace[1547302269] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"123.043377ms","start":"2026-10-03T05:44:13.133712Z","end":"2026-10-03T05:44:13.256756Z","steps":["trace[1547302269] 'process raft request' (duration: 122.541054ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:13.256729Z","caller":"traceutil/trace.go:171","msg":"trace[287338614] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:459; }","duration":"123.974072ms","start":"2026-10-03T05:44:13.13271Z","end":"2026-10-03T05:44:13.256684Z","steps":["trace[287338614] 'agreement among raft nodes before linearized reading' (duration: 123.731566ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:27.758084Z","caller":"traceutil/trace.go:171","msg":"trace[117203190] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"337.19062ms","start":"2026-10-03T05:44:27.420862Z","end":"2026-10-03T05:44:27.758053Z","steps":["trace[117203190] 'process raft request' (duration: 336.936454ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:27.758105Z","caller":"traceutil/trace.go:171","msg":"trace[703132870] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"330.497575ms","start":"2026-10-03T05:44:27.427578Z","end":"2026-10-03T05:44:27.758075Z","steps":["trace[703132870] 'process raft request' (duration: 330.384953ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.758242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.420836Z","time spent":"337.332574ms","remote":"127.0.0.1:42550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:44:27.75907Z","caller":"traceutil/trace.go:171","msg":"trace[1083389164] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"330.25469ms","start":"2026-10-03T05:44:27.428106Z","end":"2026-10-03T05:44:27.75836Z","steps":["trace[1083389164] 'process raft request' (duration: 329.925542ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.75934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.427561Z","time spent":"330.618099ms","remote":"127.0.0.1:42550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T05:44:27.759814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.428099Z","time spent":"331.027398ms","remote":"127.0.0.1:42550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:44:27.760135Z","caller":"traceutil/trace.go:171","msg":"trace[492788417] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"327.995208ms","start":"2026-10-03T05:44:27.432041Z","end":"2026-10-03T05:44:27.760036Z","steps":["trace[492788417] 'process raft request' (duration: 326.161215ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.760231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.432032Z","time spent":"328.150891ms","remote":"127.0.0.1:43032","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:44:27.762558Z","caller":"traceutil/trace.go:171","msg":"trace[469088023] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"316.608234ms","start":"2026-10-03T05:44:27.445914Z","end":"2026-10-03T05:44:27.762522Z","steps":["trace[469088023] 'process raft request' (duration: 314.192558ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.76266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.445894Z","time spent":"316.715607ms","remote":"127.0.0.1:42550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:44:27.809776Z","caller":"traceutil/trace.go:171","msg":"trace[1531166094] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"359.335953ms","start":"2026-10-03T05:44:27.450413Z","end":"2026-10-03T05:44:27.809749Z","steps":["trace[1531166094] 'process raft request' (duration: 359.105558ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.809956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.450406Z","time spent":"359.466646ms","remote":"127.0.0.1:42550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:44:27.810123Z","caller":"traceutil/trace.go:171","msg":"trace[1371091618] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"358.081913ms","start":"2026-10-03T05:44:27.452018Z","end":"2026-10-03T05:44:27.8101Z","steps":["trace[1371091618] 'process raft request' (duration: 357.674464ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.810215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.45201Z","time spent":"358.156776ms","remote":"127.0.0.1:42550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:44:27.81072Z","caller":"traceutil/trace.go:171","msg":"trace[1426005161] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"355.153166ms","start":"2026-10-03T05:44:27.455548Z","end":"2026-10-03T05:44:27.810702Z","steps":["trace[1426005161] 'process raft request' (duration: 354.798648ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.810789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.455539Z","time spent":"355.219247ms","remote":"127.0.0.1:42550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:44:27.810885Z","caller":"traceutil/trace.go:171","msg":"trace[1441203490] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"345.945793ms","start":"2026-10-03T05:44:27.464929Z","end":"2026-10-03T05:44:27.810875Z","steps":["trace[1441203490] 'process raft request' (duration: 345.683087ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.810933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.464892Z","time spent":"346.019945ms","remote":"127.0.0.1:42550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:44:27.810816Z","caller":"traceutil/trace.go:171","msg":"trace[547374157] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:562; }","duration":"323.890333ms","start":"2026-10-03T05:44:27.486864Z","end":"2026-10-03T05:44:27.810754Z","steps":["trace[547374157] 'read index received' (duration: 270.867026ms)","trace[547374157] 'applied index is now lower than readState.Index' (duration: 53.022267ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:44:27.811044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.175839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-10-03T05:44:27.811099Z","caller":"traceutil/trace.go:171","msg":"trace[105734751] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:555; }","duration":"324.263422ms","start":"2026-10-03T05:44:27.48682Z","end":"2026-10-03T05:44:27.811083Z","steps":["trace[105734751] 'agreement among raft nodes before linearized reading' (duration: 324.138509ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:27.811129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:27.486805Z","time spent":"324.317223ms","remote":"127.0.0.1:43032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":1032,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1beta1.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-10-03T05:44:27.81101Z","caller":"traceutil/trace.go:171","msg":"trace[863030996] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"257.580438ms","start":"2026-10-03T05:44:27.553314Z","end":"2026-10-03T05:44:27.810895Z","steps":["trace[863030996] 'process raft request' (duration: 257.376974ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:27.872981Z","caller":"traceutil/trace.go:171","msg":"trace[978609915] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"103.491684ms","start":"2026-10-03T05:44:27.769472Z","end":"2026-10-03T05:44:27.872964Z","steps":["trace[978609915] 'process raft request' (duration: 103.058594ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:27.87313Z","caller":"traceutil/trace.go:171","msg":"trace[104287740] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"102.491091ms","start":"2026-10-03T05:44:27.770631Z","end":"2026-10-03T05:44:27.873122Z","steps":["trace[104287740] 'process raft request' (duration: 101.975039ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:33.863976Z","caller":"traceutil/trace.go:171","msg":"trace[994554839] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"108.335276ms","start":"2026-10-03T05:44:33.755612Z","end":"2026-10-03T05:44:33.863947Z","steps":["trace[994554839] 'process raft request' (duration: 108.185783ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:34.82677Z","caller":"traceutil/trace.go:171","msg":"trace[2119527862] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"462.336816ms","start":"2026-10-03T05:44:34.364402Z","end":"2026-10-03T05:44:34.826738Z","steps":["trace[2119527862] 'read index received' (duration: 461.519248ms)","trace[2119527862] 'applied index is now lower than readState.Index' (duration: 816.018µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:44:34.82684Z","caller":"traceutil/trace.go:171","msg":"trace[355236176] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"552.173889ms","start":"2026-10-03T05:44:34.274632Z","end":"2026-10-03T05:44:34.826806Z","steps":["trace[355236176] 'process raft request' (duration: 551.517745ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:34.826947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.52252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:44:34.826987Z","caller":"traceutil/trace.go:171","msg":"trace[1495068686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:643; }","duration":"462.638923ms","start":"2026-10-03T05:44:34.364333Z","end":"2026-10-03T05:44:34.826972Z","steps":["trace[1495068686] 'agreement among raft nodes before linearized reading' (duration: 462.553281ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:34.827021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:34.364315Z","time spent":"462.698424ms","remote":"127.0.0.1:42514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-03T05:44:34.827018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:34.274604Z","time spent":"552.319853ms","remote":"127.0.0.1:42610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T05:44:34.827133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.880334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6g59t\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-10-03T05:44:34.82722Z","caller":"traceutil/trace.go:171","msg":"trace[1373658424] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6g59t; range_end:; response_count:1; response_revision:643; }","duration":"402.025158ms","start":"2026-10-03T05:44:34.425172Z","end":"2026-10-03T05:44:34.827197Z","steps":["trace[1373658424] 'agreement among raft nodes before linearized reading' (duration: 401.743412ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:34.827271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:34.425154Z","time spent":"402.107929ms","remote":"127.0.0.1:42708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-6g59t\" "} {"level":"warn","ts":"2026-10-03T05:44:35.754324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.753993ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:44:35.754437Z","caller":"traceutil/trace.go:171","msg":"trace[1412190794] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"174.208618ms","start":"2026-10-03T05:44:35.580213Z","end":"2026-10-03T05:44:35.754421Z","steps":["trace[1412190794] 'compare' (duration: 164.530439ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:36.683104Z","caller":"traceutil/trace.go:171","msg":"trace[1011143991] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"104.482269ms","start":"2026-10-03T05:44:36.57859Z","end":"2026-10-03T05:44:36.683073Z","steps":["trace[1011143991] 'process raft request' (duration: 95.146288ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:51.289366Z","caller":"traceutil/trace.go:171","msg":"trace[1420773573] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"311.470541ms","start":"2026-10-03T05:44:50.977865Z","end":"2026-10-03T05:44:51.289336Z","steps":["trace[1420773573] 'process raft request' (duration: 311.231926ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:51.289549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:50.977847Z","time spent":"311.609063ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:44:51.363727Z","caller":"traceutil/trace.go:171","msg":"trace[1349937054] linearizableReadLoop","detail":"{readStateIndex:830; appliedIndex:828; }","duration":"213.758342ms","start":"2026-10-03T05:44:51.149945Z","end":"2026-10-03T05:44:51.363704Z","steps":["trace[1349937054] 'read index received' (duration: 139.142713ms)","trace[1349937054] 'applied index is now lower than readState.Index' (duration: 74.614529ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:44:51.363873Z","caller":"traceutil/trace.go:171","msg":"trace[1015332709] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"385.894876ms","start":"2026-10-03T05:44:50.977907Z","end":"2026-10-03T05:44:51.363802Z","steps":["trace[1015332709] 'process raft request' (duration: 339.713456ms)","trace[1015332709] 'compare' (duration: 45.892504ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:44:51.364068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.109139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.73\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-03T05:44:51.364166Z","caller":"traceutil/trace.go:171","msg":"trace[383863166] range","detail":"{range_begin:/registry/masterleases/162.253.55.73; range_end:; response_count:1; response_revision:808; }","duration":"214.270772ms","start":"2026-10-03T05:44:51.149879Z","end":"2026-10-03T05:44:51.36415Z","steps":["trace[383863166] 'agreement among raft nodes before linearized reading' (duration: 213.948056ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:44:51.364822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:44:50.977884Z","time spent":"386.205742ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:45:21.434251Z","caller":"traceutil/trace.go:171","msg":"trace[889897648] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"100.260668ms","start":"2026-10-03T05:45:21.333916Z","end":"2026-10-03T05:45:21.434176Z","steps":["trace[889897648] 'process raft request' (duration: 72.253906ms)","trace[889897648] 'compare' (duration: 27.847449ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:45:54.780489Z","caller":"traceutil/trace.go:171","msg":"trace[2026254017] transaction","detail":"{read_only:false; response_revision:1590; number_of_response:1; }","duration":"101.176978ms","start":"2026-10-03T05:45:54.679284Z","end":"2026-10-03T05:45:54.780461Z","steps":["trace[2026254017] 'process raft request' (duration: 51.40346ms)","trace[2026254017] 'compare' (duration: 49.612626ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:45:54.792821Z","caller":"traceutil/trace.go:171","msg":"trace[2039691332] transaction","detail":"{read_only:false; response_revision:1591; number_of_response:1; }","duration":"113.235087ms","start":"2026-10-03T05:45:54.679524Z","end":"2026-10-03T05:45:54.792759Z","steps":["trace[2039691332] 'process raft request' (duration: 113.061395ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:45:57.016186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.322512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:45:57.016385Z","caller":"traceutil/trace.go:171","msg":"trace[640356468] transaction","detail":"{read_only:false; response_revision:1698; number_of_response:1; }","duration":"160.751638ms","start":"2026-10-03T05:45:56.8556Z","end":"2026-10-03T05:45:57.016352Z","steps":["trace[640356468] 'process raft request' (duration: 51.140962ms)","trace[640356468] 'compare' (duration: 109.125179ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:45:57.806648Z","caller":"traceutil/trace.go:171","msg":"trace[40357347] transaction","detail":"{read_only:false; response_revision:1706; number_of_response:1; }","duration":"131.671227ms","start":"2026-10-03T05:45:57.674943Z","end":"2026-10-03T05:45:57.806614Z","steps":["trace[40357347] 'process raft request' (duration: 37.427879ms)","trace[40357347] 'compare' (duration: 93.864453ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:45:58.055269Z","caller":"traceutil/trace.go:171","msg":"trace[1112083286] transaction","detail":"{read_only:false; response_revision:1711; number_of_response:1; }","duration":"156.610801ms","start":"2026-10-03T05:45:57.898634Z","end":"2026-10-03T05:45:58.055245Z","steps":["trace[1112083286] 'process raft request' (duration: 105.95652ms)","trace[1112083286] 'compare' (duration: 50.370117ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:45:58.055506Z","caller":"traceutil/trace.go:171","msg":"trace[1598951708] transaction","detail":"{read_only:false; response_revision:1712; number_of_response:1; }","duration":"156.411628ms","start":"2026-10-03T05:45:57.899088Z","end":"2026-10-03T05:45:58.0555Z","steps":["trace[1598951708] 'process raft request' (duration: 156.119924ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:46:11.121711Z","caller":"traceutil/trace.go:171","msg":"trace[2003780614] linearizableReadLoop","detail":"{readStateIndex:1951; appliedIndex:1950; }","duration":"204.305039ms","start":"2026-10-03T05:46:10.917384Z","end":"2026-10-03T05:46:11.121689Z","steps":["trace[2003780614] 'read index received' (duration: 204.106026ms)","trace[2003780614] 'applied index is now lower than readState.Index' (duration: 197.643µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:46:11.121911Z","caller":"traceutil/trace.go:171","msg":"trace[1327841400] transaction","detail":"{read_only:false; response_revision:1883; number_of_response:1; }","duration":"215.62937ms","start":"2026-10-03T05:46:10.906264Z","end":"2026-10-03T05:46:11.121893Z","steps":["trace[1327841400] 'process raft request' (duration: 215.242195ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:11.122173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.680151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eb7b0cc0-39b4-40d5-b671-f4d0b4858d31\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-10-03T05:46:11.122235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.834216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-03T05:46:11.122292Z","caller":"traceutil/trace.go:171","msg":"trace[572039031] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eb7b0cc0-39b4-40d5-b671-f4d0b4858d31; range_end:; response_count:1; response_revision:1883; }","duration":"143.830823ms","start":"2026-10-03T05:46:10.978414Z","end":"2026-10-03T05:46:11.122245Z","steps":["trace[572039031] 'agreement among raft nodes before linearized reading' (duration: 143.57973ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:46:11.122297Z","caller":"traceutil/trace.go:171","msg":"trace[822495230] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1883; }","duration":"204.953877ms","start":"2026-10-03T05:46:10.917326Z","end":"2026-10-03T05:46:11.12228Z","steps":["trace[822495230] 'agreement among raft nodes before linearized reading' (duration: 204.741505ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:46:11.269665Z","caller":"traceutil/trace.go:171","msg":"trace[549219690] transaction","detail":"{read_only:false; response_revision:1885; number_of_response:1; }","duration":"141.856425ms","start":"2026-10-03T05:46:11.127779Z","end":"2026-10-03T05:46:11.269635Z","steps":["trace[549219690] 'process raft request' (duration: 130.542814ms)","trace[549219690] 'compare' (duration: 11.100198ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:46:11.269861Z","caller":"traceutil/trace.go:171","msg":"trace[2039441188] linearizableReadLoop","detail":"{readStateIndex:1954; appliedIndex:1952; }","duration":"131.268644ms","start":"2026-10-03T05:46:11.138557Z","end":"2026-10-03T05:46:11.269826Z","steps":["trace[2039441188] 'read index received' (duration: 17.674555ms)","trace[2039441188] 'applied index is now lower than readState.Index' (duration: 113.591509ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:46:11.270002Z","caller":"traceutil/trace.go:171","msg":"trace[1977422853] transaction","detail":"{read_only:false; response_revision:1886; number_of_response:1; }","duration":"138.986687ms","start":"2026-10-03T05:46:11.131Z","end":"2026-10-03T05:46:11.269986Z","steps":["trace[1977422853] 'process raft request' (duration: 138.569812ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:11.270195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.368923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.73\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-10-03T05:46:11.270239Z","caller":"traceutil/trace.go:171","msg":"trace[576190172] range","detail":"{range_begin:/registry/masterleases/162.253.55.73; range_end:; response_count:1; response_revision:1886; }","duration":"115.453775ms","start":"2026-10-03T05:46:11.154774Z","end":"2026-10-03T05:46:11.270228Z","steps":["trace[576190172] 'agreement among raft nodes before linearized reading' (duration: 115.289302ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:11.270382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.687101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-eb7b0cc0-39b4-40d5-b671-f4d0b4858d31\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-10-03T05:46:11.270469Z","caller":"traceutil/trace.go:171","msg":"trace[553316947] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-eb7b0cc0-39b4-40d5-b671-f4d0b4858d31; range_end:; response_count:1; response_revision:1886; }","duration":"131.946674ms","start":"2026-10-03T05:46:11.138505Z","end":"2026-10-03T05:46:11.270452Z","steps":["trace[553316947] 'agreement among raft nodes before linearized reading' (duration: 131.616399ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:46:19.037577Z","caller":"traceutil/trace.go:171","msg":"trace[1709795985] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"138.752749ms","start":"2026-10-03T05:46:18.898794Z","end":"2026-10-03T05:46:19.037546Z","steps":["trace[1709795985] 'process raft request' (duration: 138.582107ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:24.891905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.072404ms","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-10-03T05:46:24.891976Z","caller":"traceutil/trace.go:171","msg":"trace[1726792166] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2002; }","duration":"173.800863ms","start":"2026-10-03T05:46:24.718157Z","end":"2026-10-03T05:46:24.891958Z","steps":["trace[1726792166] 'range keys from in-memory index tree' (duration: 172.887022ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:45.759998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.210055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:46:45.760329Z","caller":"traceutil/trace.go:171","msg":"trace[1637817537] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"325.170072ms","start":"2026-10-03T05:46:45.435129Z","end":"2026-10-03T05:46:45.7603Z","steps":["trace[1637817537] 'process raft request' (duration: 167.493991ms)","trace[1637817537] 'compare' (duration: 157.022333ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:46:45.760544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:45.435114Z","time spent":"325.282013ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:46:45.760806Z","caller":"traceutil/trace.go:171","msg":"trace[1347038153] linearizableReadLoop","detail":"{readStateIndex:2208; appliedIndex:2206; }","duration":"112.11689ms","start":"2026-10-03T05:46:45.64867Z","end":"2026-10-03T05:46:45.760787Z","steps":["trace[1347038153] 'read index received' (duration: 94.774696ms)","trace[1347038153] 'applied index is now lower than readState.Index' (duration: 17.340814ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:46:45.761175Z","caller":"traceutil/trace.go:171","msg":"trace[2134613922] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"302.407051ms","start":"2026-10-03T05:46:45.458746Z","end":"2026-10-03T05:46:45.761153Z","steps":["trace[2134613922] 'process raft request' (duration: 301.369719ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:45.7612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.517765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-03T05:46:45.761255Z","caller":"traceutil/trace.go:171","msg":"trace[1677871307] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2133; }","duration":"112.612116ms","start":"2026-10-03T05:46:45.648625Z","end":"2026-10-03T05:46:45.761237Z","steps":["trace[1677871307] 'agreement among raft nodes before linearized reading' (duration: 112.276602ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:45.761263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:45.458729Z","time spent":"302.496012ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:48:24.042426Z","caller":"traceutil/trace.go:171","msg":"trace[729990963] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"162.805895ms","start":"2026-10-03T05:48:23.87959Z","end":"2026-10-03T05:48:24.042396Z","steps":["trace[729990963] 'process raft request' (duration: 162.432773ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.202915Z","caller":"traceutil/trace.go:171","msg":"trace[1862092566] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"137.791791ms","start":"2026-10-03T05:52:54.065094Z","end":"2026-10-03T05:52:54.202886Z","steps":["trace[1862092566] 'process raft request' (duration: 90.760506ms)","trace[1862092566] 'compare' (duration: 46.775861ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:52:54.20315Z","caller":"traceutil/trace.go:171","msg":"trace[1028857443] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"136.221696ms","start":"2026-10-03T05:52:54.066906Z","end":"2026-10-03T05:52:54.203128Z","steps":["trace[1028857443] 'process raft request' (duration: 135.915821ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.412463Z","caller":"traceutil/trace.go:171","msg":"trace[2054314842] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"201.548729ms","start":"2026-10-03T05:52:54.210886Z","end":"2026-10-03T05:52:54.412434Z","steps":["trace[2054314842] 'process raft request' (duration: 201.278774ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.412655Z","caller":"traceutil/trace.go:171","msg":"trace[775436729] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"201.575809ms","start":"2026-10-03T05:52:54.210979Z","end":"2026-10-03T05:52:54.412555Z","steps":["trace[775436729] 'process raft request' (duration: 201.403956ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.412873Z","caller":"traceutil/trace.go:171","msg":"trace[416302525] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"201.427597ms","start":"2026-10-03T05:52:54.211432Z","end":"2026-10-03T05:52:54.41286Z","steps":["trace[416302525] 'process raft request' (duration: 201.066501ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.413067Z","caller":"traceutil/trace.go:171","msg":"trace[1198565182] transaction","detail":"{read_only:false; response_revision:4787; number_of_response:1; }","duration":"200.486052ms","start":"2026-10-03T05:52:54.212554Z","end":"2026-10-03T05:52:54.41304Z","steps":["trace[1198565182] 'process raft request' (duration: 199.971943ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.413148Z","caller":"traceutil/trace.go:171","msg":"trace[133450007] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"202.155968ms","start":"2026-10-03T05:52:54.21098Z","end":"2026-10-03T05:52:54.413136Z","steps":["trace[133450007] 'process raft request' (duration: 201.435446ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.413234Z","caller":"traceutil/trace.go:171","msg":"trace[1167214034] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"202.22168ms","start":"2026-10-03T05:52:54.211004Z","end":"2026-10-03T05:52:54.413225Z","steps":["trace[1167214034] 'process raft request' (duration: 201.466627ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.413325Z","caller":"traceutil/trace.go:171","msg":"trace[1609168905] transaction","detail":"{read_only:false; response_revision:4782; number_of_response:1; }","duration":"202.381992ms","start":"2026-10-03T05:52:54.210929Z","end":"2026-10-03T05:52:54.413311Z","steps":["trace[1609168905] 'process raft request' (duration: 201.388236ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.413381Z","caller":"traceutil/trace.go:171","msg":"trace[1139067218] transaction","detail":"{read_only:false; response_revision:4788; number_of_response:1; }","duration":"192.675944ms","start":"2026-10-03T05:52:54.220694Z","end":"2026-10-03T05:52:54.41337Z","steps":["trace[1139067218] 'process raft request' (duration: 191.872941ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.546078Z","caller":"traceutil/trace.go:171","msg":"trace[1987296604] linearizableReadLoop","detail":"{readStateIndex:4969; appliedIndex:4968; }","duration":"128.076403ms","start":"2026-10-03T05:52:54.417975Z","end":"2026-10-03T05:52:54.546052Z","steps":["trace[1987296604] 'read index received' (duration: 127.949971ms)","trace[1987296604] 'applied index is now lower than readState.Index' (duration: 122.552µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:52:54.546369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.368008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-03T05:52:54.54643Z","caller":"traceutil/trace.go:171","msg":"trace[999732100] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4789; }","duration":"128.46169ms","start":"2026-10-03T05:52:54.417934Z","end":"2026-10-03T05:52:54.546396Z","steps":["trace[999732100] 'agreement among raft nodes before linearized reading' (duration: 128.207906ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.546518Z","caller":"traceutil/trace.go:171","msg":"trace[308847156] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"151.540485ms","start":"2026-10-03T05:52:54.394938Z","end":"2026-10-03T05:52:54.546478Z","steps":["trace[308847156] 'process raft request' (duration: 150.926345ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.560597Z","caller":"traceutil/trace.go:171","msg":"trace[1962011657] transaction","detail":"{read_only:false; response_revision:4790; number_of_response:1; }","duration":"139.952136ms","start":"2026-10-03T05:52:54.420609Z","end":"2026-10-03T05:52:54.560561Z","steps":["trace[1962011657] 'process raft request' (duration: 139.717303ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.560755Z","caller":"traceutil/trace.go:171","msg":"trace[1043077124] transaction","detail":"{read_only:false; response_revision:4792; number_of_response:1; }","duration":"120.373208ms","start":"2026-10-03T05:52:54.440349Z","end":"2026-10-03T05:52:54.560723Z","steps":["trace[1043077124] 'process raft request' (duration: 120.147384ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:54.560802Z","caller":"traceutil/trace.go:171","msg":"trace[206215831] transaction","detail":"{read_only:false; response_revision:4791; number_of_response:1; }","duration":"139.026632ms","start":"2026-10-03T05:52:54.421757Z","end":"2026-10-03T05:52:54.560784Z","steps":["trace[206215831] 'process raft request' (duration: 138.694897ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:56.656341Z","caller":"traceutil/trace.go:171","msg":"trace[1557267592] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"176.082199ms","start":"2026-10-03T05:52:56.480214Z","end":"2026-10-03T05:52:56.656296Z","steps":["trace[1557267592] 'process raft request' (duration: 92.177146ms)","trace[1557267592] 'compare' (duration: 83.693439ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:52:56.657413Z","caller":"traceutil/trace.go:171","msg":"trace[2015245830] linearizableReadLoop","detail":"{readStateIndex:5063; appliedIndex:5060; }","duration":"133.403036ms","start":"2026-10-03T05:52:56.523986Z","end":"2026-10-03T05:52:56.657389Z","steps":["trace[2015245830] 'read index received' (duration: 48.380105ms)","trace[2015245830] 'applied index is now lower than readState.Index' (duration: 85.021841ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:52:56.658176Z","caller":"traceutil/trace.go:171","msg":"trace[1794559001] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"177.953459ms","start":"2026-10-03T05:52:56.480177Z","end":"2026-10-03T05:52:56.658131Z","steps":["trace[1794559001] 'process raft request' (duration: 177.041434ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:56.658409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.400312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-10-03T05:52:56.658412Z","caller":"traceutil/trace.go:171","msg":"trace[1839859234] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"177.839357ms","start":"2026-10-03T05:52:56.48055Z","end":"2026-10-03T05:52:56.658389Z","steps":["trace[1839859234] 'process raft request' (duration: 176.77316ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:56.658458Z","caller":"traceutil/trace.go:171","msg":"trace[1090516087] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4880; }","duration":"134.481353ms","start":"2026-10-03T05:52:56.523962Z","end":"2026-10-03T05:52:56.658444Z","steps":["trace[1090516087] 'agreement among raft nodes before linearized reading' (duration: 133.520758ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:57.035875Z","caller":"traceutil/trace.go:171","msg":"trace[1792316142] linearizableReadLoop","detail":"{readStateIndex:5071; appliedIndex:5070; }","duration":"120.643699ms","start":"2026-10-03T05:52:56.915218Z","end":"2026-10-03T05:52:57.035862Z","steps":["trace[1792316142] 'read index received' (duration: 120.513137ms)","trace[1792316142] 'applied index is now lower than readState.Index' (duration: 130.042µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:52:57.035949Z","caller":"traceutil/trace.go:171","msg":"trace[1629555599] transaction","detail":"{read_only:false; response_revision:4888; number_of_response:1; }","duration":"122.281945ms","start":"2026-10-03T05:52:56.913658Z","end":"2026-10-03T05:52:57.03594Z","steps":["trace[1629555599] 'process raft request' (duration: 122.109053ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:57.036101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.867263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:52:57.036123Z","caller":"traceutil/trace.go:171","msg":"trace[1957823446] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:4888; }","duration":"120.911653ms","start":"2026-10-03T05:52:56.915205Z","end":"2026-10-03T05:52:57.036117Z","steps":["trace[1957823446] 'agreement among raft nodes before linearized reading' (duration: 120.852472ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:57.069176Z","caller":"traceutil/trace.go:171","msg":"trace[2137643353] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"106.669671ms","start":"2026-10-03T05:52:56.962489Z","end":"2026-10-03T05:52:57.069159Z","steps":["trace[2137643353] 'process raft request' (duration: 106.301305ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:57.069195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.601814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ca9bb798-eb65-4818-a4c1-a9af95916b9c\" ","response":"range_response_count:1 size:3759"} {"level":"info","ts":"2026-10-03T05:52:57.069435Z","caller":"traceutil/trace.go:171","msg":"trace[147081136] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ca9bb798-eb65-4818-a4c1-a9af95916b9c; range_end:; response_count:1; response_revision:4889; }","duration":"126.885339ms","start":"2026-10-03T05:52:56.942541Z","end":"2026-10-03T05:52:57.069427Z","steps":["trace[147081136] 'agreement among raft nodes before linearized reading' (duration: 126.537424ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:57.175183Z","caller":"traceutil/trace.go:171","msg":"trace[839640290] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"103.879045ms","start":"2026-10-03T05:52:57.071278Z","end":"2026-10-03T05:52:57.175157Z","steps":["trace[839640290] 'process raft request' (duration: 103.717342ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:57.365494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.756894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-10-03T05:52:57.365583Z","caller":"traceutil/trace.go:171","msg":"trace[1765280225] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4892; }","duration":"153.901687ms","start":"2026-10-03T05:52:57.211659Z","end":"2026-10-03T05:52:57.36556Z","steps":["trace[1765280225] 'range keys from in-memory index tree' (duration: 153.578961ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:57.523844Z","caller":"traceutil/trace.go:171","msg":"trace[95209392] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"103.295036ms","start":"2026-10-03T05:52:57.420524Z","end":"2026-10-03T05:52:57.523819Z","steps":["trace[95209392] 'process raft request' (duration: 103.123033ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.184065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.217288ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:52:58.184234Z","caller":"traceutil/trace.go:171","msg":"trace[1142863144] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"313.182417ms","start":"2026-10-03T05:52:57.871035Z","end":"2026-10-03T05:52:58.184218Z","steps":["trace[1142863144] 'process raft request' (duration: 313.115016ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:58.184232Z","caller":"traceutil/trace.go:171","msg":"trace[94753378] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"645.107312ms","start":"2026-10-03T05:52:57.539092Z","end":"2026-10-03T05:52:58.184199Z","steps":["trace[94753378] 'process raft request' (duration: 299.695651ms)","trace[94753378] 'compare' (duration: 344.778151ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:52:58.184311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:52:57.871015Z","time spent":"313.257739ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T05:52:58.184367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:52:57.539068Z","time spent":"645.225534ms","remote":"127.0.0.1:42586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-03T05:52:58.184387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.437932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-03T05:52:58.184232Z","caller":"traceutil/trace.go:171","msg":"trace[48011510] linearizableReadLoop","detail":"{readStateIndex:5077; appliedIndex:5076; }","duration":"620.283269ms","start":"2026-10-03T05:52:57.563931Z","end":"2026-10-03T05:52:58.184215Z","steps":["trace[48011510] 'read index received' (duration: 274.775277ms)","trace[48011510] 'applied index is now lower than readState.Index' (duration: 345.505892ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:52:58.184412Z","caller":"traceutil/trace.go:171","msg":"trace[2131000080] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4895; }","duration":"620.536853ms","start":"2026-10-03T05:52:57.563869Z","end":"2026-10-03T05:52:58.184406Z","steps":["trace[2131000080] 'agreement among raft nodes before linearized reading' (duration: 620.394091ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.184438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:52:57.56385Z","time spent":"620.583125ms","remote":"127.0.0.1:42776","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-10-03T05:52:58.184524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.024536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-03T05:52:58.18455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.579814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:52:58.184558Z","caller":"traceutil/trace.go:171","msg":"trace[359772033] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:4895; }","duration":"498.096147ms","start":"2026-10-03T05:52:57.686452Z","end":"2026-10-03T05:52:58.184548Z","steps":["trace[359772033] 'agreement among raft nodes before linearized reading' (duration: 498.007416ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.184585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:52:57.686438Z","time spent":"498.139968ms","remote":"127.0.0.1:42872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":72,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-10-03T05:52:58.184774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.794496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ca9bb798-eb65-4818-a4c1-a9af95916b9c\" ","response":"range_response_count:1 size:3759"} {"level":"info","ts":"2026-10-03T05:52:58.184794Z","caller":"traceutil/trace.go:171","msg":"trace[765674267] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ca9bb798-eb65-4818-a4c1-a9af95916b9c; range_end:; response_count:1; response_revision:4895; }","duration":"110.839516ms","start":"2026-10-03T05:52:58.07395Z","end":"2026-10-03T05:52:58.18479Z","steps":["trace[765674267] 'agreement among raft nodes before linearized reading' (duration: 110.792316ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.184792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.401501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-03T05:52:58.18486Z","caller":"traceutil/trace.go:171","msg":"trace[1478859174] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4895; }","duration":"342.507133ms","start":"2026-10-03T05:52:57.842341Z","end":"2026-10-03T05:52:58.184848Z","steps":["trace[1478859174] 'agreement among raft nodes before linearized reading' (duration: 342.342431ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.184896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:52:57.842322Z","time spent":"342.563374ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-10-03T05:52:58.184819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.305748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7b11aae7-81a1-4734-8f0e-3b50bda20e44\" ","response":"range_response_count:1 size:3893"} {"level":"info","ts":"2026-10-03T05:52:58.184997Z","caller":"traceutil/trace.go:171","msg":"trace[1079954100] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7b11aae7-81a1-4734-8f0e-3b50bda20e44; range_end:; response_count:1; response_revision:4895; }","duration":"406.508352ms","start":"2026-10-03T05:52:57.778483Z","end":"2026-10-03T05:52:58.184991Z","steps":["trace[1079954100] 'agreement among raft nodes before linearized reading' (duration: 406.245187ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.184896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.198791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-03T05:52:58.185024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.659861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ca9bb798-eb65-4818-a4c1-a9af95916b9c\" ","response":"range_response_count:1 size:3759"} {"level":"info","ts":"2026-10-03T05:52:58.18504Z","caller":"traceutil/trace.go:171","msg":"trace[604373264] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4895; }","duration":"426.397234ms","start":"2026-10-03T05:52:57.758632Z","end":"2026-10-03T05:52:58.18503Z","steps":["trace[604373264] 'agreement among raft nodes before linearized reading' (duration: 426.205051ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.185054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.111431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-10-03T05:52:58.185049Z","caller":"traceutil/trace.go:171","msg":"trace[1726848672] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ca9bb798-eb65-4818-a4c1-a9af95916b9c; range_end:; response_count:1; response_revision:4895; }","duration":"150.719592ms","start":"2026-10-03T05:52:58.034321Z","end":"2026-10-03T05:52:58.185041Z","steps":["trace[1726848672] 'agreement among raft nodes before linearized reading' (duration: 150.644691ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:52:58.185071Z","caller":"traceutil/trace.go:171","msg":"trace[78680236] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4895; }","duration":"325.162482ms","start":"2026-10-03T05:52:57.859903Z","end":"2026-10-03T05:52:58.185065Z","steps":["trace[78680236] 'agreement among raft nodes before linearized reading' (duration: 325.121871ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.185074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:52:57.758612Z","time spent":"426.453755ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-03T05:52:58.185083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:52:57.859862Z","time spent":"325.218352ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-10-03T05:52:58.184565Z","caller":"traceutil/trace.go:171","msg":"trace[474871525] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:4895; }","duration":"112.678017ms","start":"2026-10-03T05:52:58.071881Z","end":"2026-10-03T05:52:58.184559Z","steps":["trace[474871525] 'agreement among raft nodes before linearized reading' (duration: 112.649786ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:52:58.185015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:52:57.778472Z","time spent":"406.538382ms","remote":"127.0.0.1:42708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3915,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7b11aae7-81a1-4734-8f0e-3b50bda20e44\" "} {"level":"info","ts":"2026-10-03T05:53:00.55356Z","caller":"traceutil/trace.go:171","msg":"trace[1650163208] linearizableReadLoop","detail":"{readStateIndex:5100; appliedIndex:5099; }","duration":"107.180904ms","start":"2026-10-03T05:53:00.446363Z","end":"2026-10-03T05:53:00.553544Z","steps":["trace[1650163208] 'read index received' (duration: 107.010241ms)","trace[1650163208] 'applied index is now lower than readState.Index' (duration: 170.173µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:53:00.553709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.337156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-03T05:53:00.553727Z","caller":"traceutil/trace.go:171","msg":"trace[1060075611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4917; }","duration":"107.396368ms","start":"2026-10-03T05:53:00.446326Z","end":"2026-10-03T05:53:00.553722Z","steps":["trace[1060075611] 'agreement among raft nodes before linearized reading' (duration: 107.279466ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:00.553906Z","caller":"traceutil/trace.go:171","msg":"trace[1157933109] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"114.620375ms","start":"2026-10-03T05:53:00.43928Z","end":"2026-10-03T05:53:00.5539Z","steps":["trace[1157933109] 'process raft request' (duration: 114.143087ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:00.691928Z","caller":"traceutil/trace.go:171","msg":"trace[1774015514] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"133.936167ms","start":"2026-10-03T05:53:00.557932Z","end":"2026-10-03T05:53:00.691868Z","steps":["trace[1774015514] 'process raft request' (duration: 120.998638ms)","trace[1774015514] 'compare' (duration: 12.697635ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:53:15.167972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.02575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-03T05:53:15.168084Z","caller":"traceutil/trace.go:171","msg":"trace[1405018845] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:5176; }","duration":"294.184402ms","start":"2026-10-03T05:53:14.873872Z","end":"2026-10-03T05:53:15.168057Z","steps":["trace[1405018845] 'count revisions from in-memory index tree' (duration: 293.867427ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.168878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.454562ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:53:15.168974Z","caller":"traceutil/trace.go:171","msg":"trace[861882671] linearizableReadLoop","detail":"{readStateIndex:5368; appliedIndex:5367; }","duration":"174.237055ms","start":"2026-10-03T05:53:14.99472Z","end":"2026-10-03T05:53:15.168957Z","steps":["trace[861882671] 'read index received' (duration: 47.951µs)","trace[861882671] 'applied index is now lower than readState.Index' (duration: 174.187554ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:53:15.169055Z","caller":"traceutil/trace.go:171","msg":"trace[1699984526] transaction","detail":"{read_only:false; response_revision:5177; number_of_response:1; }","duration":"223.614034ms","start":"2026-10-03T05:53:14.945419Z","end":"2026-10-03T05:53:15.169033Z","steps":["trace[1699984526] 'process raft request' (duration: 39.900678ms)","trace[1699984526] 'compare' (duration: 182.599988ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:53:15.169199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.476448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-03T05:53:15.169258Z","caller":"traceutil/trace.go:171","msg":"trace[359375695] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5177; }","duration":"174.576089ms","start":"2026-10-03T05:53:14.994668Z","end":"2026-10-03T05:53:15.169244Z","steps":["trace[359375695] 'agreement among raft nodes before linearized reading' (duration: 174.395106ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.16971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.985343ms","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-10-03T05:53:15.169771Z","caller":"traceutil/trace.go:171","msg":"trace[59228634] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5177; }","duration":"101.086845ms","start":"2026-10-03T05:53:15.068669Z","end":"2026-10-03T05:53:15.169756Z","steps":["trace[59228634] 'agreement among raft nodes before linearized reading' (duration: 100.942453ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:15.56159Z","caller":"traceutil/trace.go:171","msg":"trace[1549373142] linearizableReadLoop","detail":"{readStateIndex:5369; appliedIndex:5368; }","duration":"387.032495ms","start":"2026-10-03T05:53:15.174528Z","end":"2026-10-03T05:53:15.561561Z","steps":["trace[1549373142] 'read index received' (duration: 379.391433ms)","trace[1549373142] 'applied index is now lower than readState.Index' (duration: 7.640472ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:53:15.561633Z","caller":"traceutil/trace.go:171","msg":"trace[1239716719] transaction","detail":"{read_only:false; response_revision:5178; number_of_response:1; }","duration":"387.539864ms","start":"2026-10-03T05:53:15.174066Z","end":"2026-10-03T05:53:15.561605Z","steps":["trace[1239716719] 'process raft request' (duration: 380.036954ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.561742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.204068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:10328"} {"level":"warn","ts":"2026-10-03T05:53:15.561767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.174051Z","time spent":"387.637905ms","remote":"127.0.0.1:42776","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T05:53:15.561824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.582808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-03T05:53:15.561837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.72083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-10-03T05:53:15.561908Z","caller":"traceutil/trace.go:171","msg":"trace[1330192670] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5178; }","duration":"366.826912ms","start":"2026-10-03T05:53:15.19506Z","end":"2026-10-03T05:53:15.561887Z","steps":["trace[1330192670] 'agreement among raft nodes before linearized reading' (duration: 366.620949ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.561925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.485923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-03T05:53:15.561902Z","caller":"traceutil/trace.go:171","msg":"trace[193540553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5178; }","duration":"197.677329ms","start":"2026-10-03T05:53:15.364197Z","end":"2026-10-03T05:53:15.561875Z","steps":["trace[193540553] 'agreement among raft nodes before linearized reading' (duration: 197.603998ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.561953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.195043Z","time spent":"366.902183ms","remote":"127.0.0.1:42708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10413,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-10-03T05:53:15.561976Z","caller":"traceutil/trace.go:171","msg":"trace[105782874] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5178; }","duration":"235.544224ms","start":"2026-10-03T05:53:15.326417Z","end":"2026-10-03T05:53:15.561961Z","steps":["trace[105782874] 'agreement among raft nodes before linearized reading' (duration: 235.27879ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.562414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.002315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-03T05:53:15.562468Z","caller":"traceutil/trace.go:171","msg":"trace[1440687015] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5178; }","duration":"352.056736ms","start":"2026-10-03T05:53:15.210397Z","end":"2026-10-03T05:53:15.562454Z","steps":["trace[1440687015] 'agreement among raft nodes before linearized reading' (duration: 351.913664ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.562518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.210331Z","time spent":"352.178908ms","remote":"127.0.0.1:42680","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-10-03T05:53:15.562714Z","caller":"traceutil/trace.go:171","msg":"trace[845630806] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5178; }","duration":"387.254769ms","start":"2026-10-03T05:53:15.174506Z","end":"2026-10-03T05:53:15.561761Z","steps":["trace[845630806] 'agreement among raft nodes before linearized reading' (duration: 387.149637ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.562782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.174478Z","time spent":"388.287445ms","remote":"127.0.0.1:42706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":10350,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-10-03T05:53:15.961305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.84844ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:53:15.961827Z","caller":"traceutil/trace.go:171","msg":"trace[623232790] transaction","detail":"{read_only:false; response_revision:5180; number_of_response:1; }","duration":"336.720471ms","start":"2026-10-03T05:53:15.625086Z","end":"2026-10-03T05:53:15.961806Z","steps":["trace[623232790] 'process raft request' (duration: 93.294771ms)","trace[623232790] 'compare' (duration: 242.723969ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:53:15.961904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.62506Z","time spent":"336.806792ms","remote":"127.0.0.1:42780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:53:15.962144Z","caller":"traceutil/trace.go:171","msg":"trace[1581602512] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"336.7077ms","start":"2026-10-03T05:53:15.625425Z","end":"2026-10-03T05:53:15.962133Z","steps":["trace[1581602512] 'process raft request' (duration: 336.523767ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.962198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.625401Z","time spent":"336.766711ms","remote":"127.0.0.1:42780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:53:15.962183Z","caller":"traceutil/trace.go:171","msg":"trace[1271775138] linearizableReadLoop","detail":"{readStateIndex:5374; appliedIndex:5370; }","duration":"327.526443ms","start":"2026-10-03T05:53:15.634633Z","end":"2026-10-03T05:53:15.962159Z","steps":["trace[1271775138] 'read index received' (duration: 83.761878ms)","trace[1271775138] 'applied index is now lower than readState.Index' (duration: 243.763395ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:53:15.962293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.639975ms","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-10-03T05:53:15.962323Z","caller":"traceutil/trace.go:171","msg":"trace[1158934799] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:5183; }","duration":"327.714667ms","start":"2026-10-03T05:53:15.634599Z","end":"2026-10-03T05:53:15.962313Z","steps":["trace[1158934799] 'agreement among raft nodes before linearized reading' (duration: 327.644326ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.962358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.634586Z","time spent":"327.764197ms","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":27,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-10-03T05:53:15.962367Z","caller":"traceutil/trace.go:171","msg":"trace[1479254968] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"336.799662ms","start":"2026-10-03T05:53:15.625528Z","end":"2026-10-03T05:53:15.962327Z","steps":["trace[1479254968] 'process raft request' (duration: 336.547688ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:15.962382Z","caller":"traceutil/trace.go:171","msg":"trace[276882218] transaction","detail":"{read_only:false; response_revision:5181; number_of_response:1; }","duration":"337.105806ms","start":"2026-10-03T05:53:15.625245Z","end":"2026-10-03T05:53:15.962351Z","steps":["trace[276882218] 'process raft request' (duration: 336.465366ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:15.96246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.625504Z","time spent":"336.911603ms","remote":"127.0.0.1:42694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T05:53:15.962564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:53:15.625218Z","time spent":"337.227529ms","remote":"127.0.0.1:42694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T05:53:16.508117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.945666ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-10-03T05:53:16.523961Z","caller":"traceutil/trace.go:171","msg":"trace[1289290712] linearizableReadLoop","detail":"{readStateIndex:5378; appliedIndex:5377; }","duration":"155.774408ms","start":"2026-10-03T05:53:16.368164Z","end":"2026-10-03T05:53:16.523938Z","steps":["trace[1289290712] 'read index received' (duration: 155.586095ms)","trace[1289290712] 'applied index is now lower than readState.Index' (duration: 187.163µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:53:16.524212Z","caller":"traceutil/trace.go:171","msg":"trace[1496810918] transaction","detail":"{read_only:false; response_revision:5186; number_of_response:1; }","duration":"169.337364ms","start":"2026-10-03T05:53:16.354722Z","end":"2026-10-03T05:53:16.524059Z","steps":["trace[1496810918] 'process raft request' (duration: 169.040449ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:16.524338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.345123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-10-03T05:53:16.524406Z","caller":"traceutil/trace.go:171","msg":"trace[385777142] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5186; }","duration":"147.435814ms","start":"2026-10-03T05:53:16.376949Z","end":"2026-10-03T05:53:16.524384Z","steps":["trace[385777142] 'agreement among raft nodes before linearized reading' (duration: 147.259062ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:53:16.524638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.190571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-03T05:53:16.524665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.48785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-03T05:53:16.52468Z","caller":"traceutil/trace.go:171","msg":"trace[1514325703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5186; }","duration":"137.293643ms","start":"2026-10-03T05:53:16.387374Z","end":"2026-10-03T05:53:16.524668Z","steps":["trace[1514325703] 'agreement among raft nodes before linearized reading' (duration: 137.174741ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:16.524721Z","caller":"traceutil/trace.go:171","msg":"trace[56817107] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5186; }","duration":"156.57522ms","start":"2026-10-03T05:53:16.368129Z","end":"2026-10-03T05:53:16.524704Z","steps":["trace[56817107] 'agreement among raft nodes before linearized reading' (duration: 156.424458ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:16.71923Z","caller":"traceutil/trace.go:171","msg":"trace[550647195] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"188.052193ms","start":"2026-10-03T05:53:16.531132Z","end":"2026-10-03T05:53:16.719185Z","steps":["trace[550647195] 'process raft request' (duration: 187.789258ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:16.719438Z","caller":"traceutil/trace.go:171","msg":"trace[525508594] transaction","detail":"{read_only:false; response_revision:5190; number_of_response:1; }","duration":"180.313499ms","start":"2026-10-03T05:53:16.539113Z","end":"2026-10-03T05:53:16.719427Z","steps":["trace[525508594] 'process raft request' (duration: 179.992394ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:16.719543Z","caller":"traceutil/trace.go:171","msg":"trace[426421405] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"188.147734ms","start":"2026-10-03T05:53:16.53119Z","end":"2026-10-03T05:53:16.719338Z","steps":["trace[426421405] 'process raft request' (duration: 187.86719ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:53:46.917636Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2893} {"level":"info","ts":"2026-10-03T05:53:46.987944Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2893,"took":"69.268303ms","hash":3912487625,"current-db-size-bytes":52604928,"current-db-size":"53 MB","current-db-size-in-use-bytes":28340224,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-03T05:53:46.987989Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3912487625,"revision":2893,"compact-revision":-1} {"level":"info","ts":"2026-10-03T05:58:46.924888Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5469} {"level":"info","ts":"2026-10-03T05:58:47.003186Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5469,"took":"76.822552ms","hash":2937165131,"current-db-size-bytes":52604928,"current-db-size":"53 MB","current-db-size-in-use-bytes":18595840,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-03T05:58:47.003263Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2937165131,"revision":5469,"compact-revision":2893}