{"level":"warn","ts":"2026-09-07T03:30:08.113292Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T03:30:08.115118Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.208: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.208:2380","--initial-cluster=instance=https://162.253.55.208:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.208:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.208:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-07T03:30:08.115202Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T03:30:08.115219Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.208:2380"]} {"level":"info","ts":"2026-09-07T03:30:08.115251Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-07T03:30:08.11705Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"]} {"level":"info","ts":"2026-09-07T03:30:08.117221Z","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.208:2380"],"listen-peer-urls":["https://162.253.55.208:2380"],"advertise-client-urls":["https://162.253.55.208:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.208:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-07T03:30:08.122087Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.551472ms"} {"level":"info","ts":"2026-09-07T03:30:08.131086Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5019b1666ea94ec4","cluster-id":"5aff54f2fc6d3e3d"} {"level":"info","ts":"2026-09-07T03:30:08.131158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T03:30:08.131179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became follower at term 0"} {"level":"info","ts":"2026-09-07T03:30:08.13119Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5019b1666ea94ec4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T03:30:08.131229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became follower at term 1"} {"level":"info","ts":"2026-09-07T03:30:08.131312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=(5771839450953371332)"} {"level":"warn","ts":"2026-09-07T03:30:08.144676Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T03:30:08.150544Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T03:30:08.151889Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-07T03:30:08.154404Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5019b1666ea94ec4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T03:30:08.154566Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5019b1666ea94ec4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T03:30:08.15575Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T03:30:08.155983Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T03:30:08.156006Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-07T03:30:08.156967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 switched to configuration voters=(5771839450953371332)"} {"level":"info","ts":"2026-09-07T03:30:08.157104Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5aff54f2fc6d3e3d","local-member-id":"5019b1666ea94ec4","added-peer-id":"5019b1666ea94ec4","added-peer-peer-urls":["https://162.253.55.208:2380"]} {"level":"info","ts":"2026-09-07T03:30:08.159156Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-07T03:30:08.159242Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.208:2380"} {"level":"info","ts":"2026-09-07T03:30:08.159277Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.208:2380"} {"level":"info","ts":"2026-09-07T03:30:08.159566Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5019b1666ea94ec4","initial-advertise-peer-urls":["https://162.253.55.208:2380"],"listen-peer-urls":["https://162.253.55.208:2380"],"advertise-client-urls":["https://162.253.55.208:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.208:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T03:30:08.15965Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T03:30:08.432567Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T03:30:08.432626Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T03:30:08.432644Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 received MsgPreVoteResp from 5019b1666ea94ec4 at term 1"} {"level":"info","ts":"2026-09-07T03:30:08.432657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became candidate at term 2"} {"level":"info","ts":"2026-09-07T03:30:08.432664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 received MsgVoteResp from 5019b1666ea94ec4 at term 2"} {"level":"info","ts":"2026-09-07T03:30:08.432675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5019b1666ea94ec4 became leader at term 2"} {"level":"info","ts":"2026-09-07T03:30:08.432684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5019b1666ea94ec4 elected leader 5019b1666ea94ec4 at term 2"} {"level":"info","ts":"2026-09-07T03:30:08.433714Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5019b1666ea94ec4","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.208:2379]}","request-path":"/0/members/5019b1666ea94ec4/attributes","cluster-id":"5aff54f2fc6d3e3d","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T03:30:08.433826Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T03:30:08.434014Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T03:30:08.434173Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:30:08.434286Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T03:30:08.434301Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T03:30:08.434816Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5aff54f2fc6d3e3d","local-member-id":"5019b1666ea94ec4","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:30:08.43488Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:30:08.434893Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:30:08.43863Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T03:30:08.438645Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.208:2379"} {"level":"info","ts":"2026-09-07T03:30:14.371067Z","caller":"traceutil/trace.go:171","msg":"trace[1239954741] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"154.984666ms","start":"2026-09-07T03:30:14.216057Z","end":"2026-09-07T03:30:14.371041Z","steps":["trace[1239954741] 'process raft request' (duration: 152.023269ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:30:14.729729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.480309ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:30:14.72985Z","caller":"traceutil/trace.go:171","msg":"trace[213580714] linearizableReadLoop","detail":"{readStateIndex:312; appliedIndex:311; }","duration":"202.203784ms","start":"2026-09-07T03:30:14.527631Z","end":"2026-09-07T03:30:14.729835Z","steps":["trace[213580714] 'read index received' (duration: 69.17426ms)","trace[213580714] 'applied index is now lower than readState.Index' (duration: 133.028434ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:30:14.729923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.291887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-07T03:30:14.729972Z","caller":"traceutil/trace.go:171","msg":"trace[1395538126] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:302; }","duration":"202.366019ms","start":"2026-09-07T03:30:14.527574Z","end":"2026-09-07T03:30:14.72994Z","steps":["trace[1395538126] 'agreement among raft nodes before linearized reading' (duration: 202.300647ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:14.730075Z","caller":"traceutil/trace.go:171","msg":"trace[1990476436] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"214.390689ms","start":"2026-09-07T03:30:14.515633Z","end":"2026-09-07T03:30:14.730024Z","steps":["trace[1990476436] 'process raft request' (duration: 81.16106ms)","trace[1990476436] 'compare' (duration: 132.136698ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:30:15.000065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.01845ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:30:15.000405Z","caller":"traceutil/trace.go:171","msg":"trace[972746654] linearizableReadLoop","detail":"{readStateIndex:313; appliedIndex:312; }","duration":"263.769043ms","start":"2026-09-07T03:30:14.736623Z","end":"2026-09-07T03:30:15.000392Z","steps":["trace[972746654] 'read index received' (duration: 163.378351ms)","trace[972746654] 'applied index is now lower than readState.Index' (duration: 100.389532ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:30:15.000478Z","caller":"traceutil/trace.go:171","msg":"trace[1836292382] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"266.093081ms","start":"2026-09-07T03:30:14.734355Z","end":"2026-09-07T03:30:15.000448Z","steps":["trace[1836292382] 'process raft request' (duration: 165.532044ms)","trace[1836292382] 'compare' (duration: 99.31862ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:30:15.000486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.864356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-09-07T03:30:15.000669Z","caller":"traceutil/trace.go:171","msg":"trace[1764450274] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:303; }","duration":"264.063802ms","start":"2026-09-07T03:30:14.736597Z","end":"2026-09-07T03:30:15.000661Z","steps":["trace[1764450274] 'agreement among raft nodes before linearized reading' (duration: 263.855356ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:15.000998Z","caller":"traceutil/trace.go:171","msg":"trace[351638974] transaction","detail":"{read_only:false; number_of_response:0; response_revision:303; }","duration":"212.97087ms","start":"2026-09-07T03:30:14.788012Z","end":"2026-09-07T03:30:15.000983Z","steps":["trace[351638974] 'process raft request' (duration: 212.889207ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:30:15.00102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.454933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-09-07T03:30:15.00106Z","caller":"traceutil/trace.go:171","msg":"trace[382377445] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:303; }","duration":"213.538575ms","start":"2026-09-07T03:30:14.78751Z","end":"2026-09-07T03:30:15.001048Z","steps":["trace[382377445] 'agreement among raft nodes before linearized reading' (duration: 213.431022ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:15.001146Z","caller":"traceutil/trace.go:171","msg":"trace[1375396212] transaction","detail":"{read_only:false; number_of_response:0; response_revision:303; }","duration":"212.772183ms","start":"2026-09-07T03:30:14.788367Z","end":"2026-09-07T03:30:15.00114Z","steps":["trace[1375396212] 'process raft request' (duration: 212.551277ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:15.001246Z","caller":"traceutil/trace.go:171","msg":"trace[2124143999] transaction","detail":"{read_only:false; number_of_response:0; response_revision:303; }","duration":"213.446643ms","start":"2026-09-07T03:30:14.787736Z","end":"2026-09-07T03:30:15.001182Z","steps":["trace[2124143999] 'process raft request' (duration: 213.143755ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:15.001406Z","caller":"traceutil/trace.go:171","msg":"trace[1959826188] transaction","detail":"{read_only:false; number_of_response:0; response_revision:303; }","duration":"213.468084ms","start":"2026-09-07T03:30:14.787453Z","end":"2026-09-07T03:30:15.000921Z","steps":["trace[1959826188] 'process raft request' (duration: 213.371431ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:30:46.72937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.580139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:9149"} {"level":"info","ts":"2026-09-07T03:30:46.729454Z","caller":"traceutil/trace.go:171","msg":"trace[2102750181] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:606; }","duration":"124.699023ms","start":"2026-09-07T03:30:46.604738Z","end":"2026-09-07T03:30:46.729437Z","steps":["trace[2102750181] 'range keys from in-memory index tree' (duration: 124.046904ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:48.419337Z","caller":"traceutil/trace.go:171","msg":"trace[1490004292] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"122.828568ms","start":"2026-09-07T03:30:48.296434Z","end":"2026-09-07T03:30:48.419263Z","steps":["trace[1490004292] 'read index received' (duration: 122.475208ms)","trace[1490004292] 'applied index is now lower than readState.Index' (duration: 352.46µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:30:48.419715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.2384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:30:48.419808Z","caller":"traceutil/trace.go:171","msg":"trace[495268331] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:612; }","duration":"123.386185ms","start":"2026-09-07T03:30:48.296398Z","end":"2026-09-07T03:30:48.419784Z","steps":["trace[495268331] 'agreement among raft nodes before linearized reading' (duration: 123.150128ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:30:48.419811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.121737ms","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-09-07T03:30:48.419862Z","caller":"traceutil/trace.go:171","msg":"trace[936196186] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:612; }","duration":"123.22008ms","start":"2026-09-07T03:30:48.296628Z","end":"2026-09-07T03:30:48.419848Z","steps":["trace[936196186] 'agreement among raft nodes before linearized reading' (duration: 123.109876ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:48.420221Z","caller":"traceutil/trace.go:171","msg":"trace[321130141] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"143.270412ms","start":"2026-09-07T03:30:48.276924Z","end":"2026-09-07T03:30:48.420194Z","steps":["trace[321130141] 'process raft request' (duration: 142.079447ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:53.091721Z","caller":"traceutil/trace.go:171","msg":"trace[342394432] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"118.256517ms","start":"2026-09-07T03:30:52.97344Z","end":"2026-09-07T03:30:53.091697Z","steps":["trace[342394432] 'read index received' (duration: 118.106282ms)","trace[342394432] 'applied index is now lower than readState.Index' (duration: 146.735µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:30:53.091794Z","caller":"traceutil/trace.go:171","msg":"trace[1715447876] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"176.21068ms","start":"2026-09-07T03:30:52.915556Z","end":"2026-09-07T03:30:53.091767Z","steps":["trace[1715447876] 'process raft request' (duration: 175.990513ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:30:53.091845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.39496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:30:53.091903Z","caller":"traceutil/trace.go:171","msg":"trace[720671329] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"118.499573ms","start":"2026-09-07T03:30:52.973383Z","end":"2026-09-07T03:30:53.091883Z","steps":["trace[720671329] 'agreement among raft nodes before linearized reading' (duration: 118.412031ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:30:53.521007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.805886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-09-07T03:30:53.521004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.439448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-09-07T03:30:53.521123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.974832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-07T03:30:53.52116Z","caller":"traceutil/trace.go:171","msg":"trace[2078401301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:648; }","duration":"194.631924ms","start":"2026-09-07T03:30:53.326503Z","end":"2026-09-07T03:30:53.521135Z","steps":["trace[2078401301] 'range keys from in-memory index tree' (duration: 194.123459ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:30:53.520894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.898766ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:30:53.52127Z","caller":"traceutil/trace.go:171","msg":"trace[914798762] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:648; }","duration":"163.3788ms","start":"2026-09-07T03:30:53.357871Z","end":"2026-09-07T03:30:53.521249Z","steps":["trace[914798762] 'range keys from in-memory index tree' (duration: 162.879515ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:53.521346Z","caller":"traceutil/trace.go:171","msg":"trace[1037912455] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"270.93026ms","start":"2026-09-07T03:30:53.250143Z","end":"2026-09-07T03:30:53.521073Z","steps":["trace[1037912455] 'range keys from in-memory index tree' (duration: 270.663793ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:53.52187Z","caller":"traceutil/trace.go:171","msg":"trace[1842772824] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:648; }","duration":"269.100906ms","start":"2026-09-07T03:30:53.252115Z","end":"2026-09-07T03:30:53.521216Z","steps":["trace[1842772824] 'range keys from in-memory index tree' (duration: 268.517889ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:53.680363Z","caller":"traceutil/trace.go:171","msg":"trace[55099980] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"154.647201ms","start":"2026-09-07T03:30:53.525698Z","end":"2026-09-07T03:30:53.680346Z","steps":["trace[55099980] 'process raft request' (duration: 154.518408ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:53.734044Z","caller":"traceutil/trace.go:171","msg":"trace[1521025340] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"208.249266ms","start":"2026-09-07T03:30:53.525772Z","end":"2026-09-07T03:30:53.734021Z","steps":["trace[1521025340] 'process raft request' (duration: 207.855604ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:30:53.734183Z","caller":"traceutil/trace.go:171","msg":"trace[1250841410] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"208.257156ms","start":"2026-09-07T03:30:53.525902Z","end":"2026-09-07T03:30:53.734159Z","steps":["trace[1250841410] 'process raft request' (duration: 208.080441ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:57.449418Z","caller":"traceutil/trace.go:171","msg":"trace[1724009215] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"111.847259ms","start":"2026-09-07T03:31:57.337544Z","end":"2026-09-07T03:31:57.449391Z","steps":["trace[1724009215] 'process raft request' (duration: 111.694915ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:32:05.497898Z","caller":"traceutil/trace.go:171","msg":"trace[472844103] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"168.803412ms","start":"2026-09-07T03:32:05.329073Z","end":"2026-09-07T03:32:05.497876Z","steps":["trace[472844103] 'process raft request' (duration: 168.648188ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:32:31.6077Z","caller":"traceutil/trace.go:171","msg":"trace[526276798] transaction","detail":"{read_only:false; response_revision:1895; number_of_response:1; }","duration":"178.190726ms","start":"2026-09-07T03:32:31.429488Z","end":"2026-09-07T03:32:31.607679Z","steps":["trace[526276798] 'process raft request' (duration: 178.063653ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:32:34.649475Z","caller":"traceutil/trace.go:171","msg":"trace[208611105] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"190.809751ms","start":"2026-09-07T03:32:34.458629Z","end":"2026-09-07T03:32:34.649439Z","steps":["trace[208611105] 'process raft request' (duration: 190.642037ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:32:34.655115Z","caller":"traceutil/trace.go:171","msg":"trace[337754514] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"192.269912ms","start":"2026-09-07T03:32:34.462626Z","end":"2026-09-07T03:32:34.654896Z","steps":["trace[337754514] 'process raft request' (duration: 192.084516ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:32:59.305159Z","caller":"traceutil/trace.go:171","msg":"trace[1999029631] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"173.414764ms","start":"2026-09-07T03:32:59.131714Z","end":"2026-09-07T03:32:59.305129Z","steps":["trace[1999029631] 'process raft request' (duration: 173.26488ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:33:06.669065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.928277ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:33:06.6692Z","caller":"traceutil/trace.go:171","msg":"trace[974698092] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2220; }","duration":"244.074939ms","start":"2026-09-07T03:33:06.425103Z","end":"2026-09-07T03:33:06.669178Z","steps":["trace[974698092] 'read index received' (duration: 44.864293ms)","trace[974698092] 'applied index is now lower than readState.Index' (duration: 199.208546ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:33:06.66931Z","caller":"traceutil/trace.go:171","msg":"trace[407461245] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"283.697871ms","start":"2026-09-07T03:33:06.38558Z","end":"2026-09-07T03:33:06.669278Z","steps":["trace[407461245] 'process raft request' (duration: 84.449574ms)","trace[407461245] 'compare' (duration: 198.67126ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:33:06.669554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.444629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-07T03:33:06.66961Z","caller":"traceutil/trace.go:171","msg":"trace[1125405419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2135; }","duration":"244.528352ms","start":"2026-09-07T03:33:06.425067Z","end":"2026-09-07T03:33:06.669595Z","steps":["trace[1125405419] 'agreement among raft nodes before linearized reading' (duration: 244.196342ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:33:06.949228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.8501ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:33:06.950203Z","caller":"traceutil/trace.go:171","msg":"trace[1743349797] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"422.127619ms","start":"2026-09-07T03:33:06.527468Z","end":"2026-09-07T03:33:06.949596Z","steps":["trace[1743349797] 'process raft request' (duration: 297.815034ms)","trace[1743349797] 'compare' (duration: 123.709927ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:33:06.950417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:33:06.52745Z","time spent":"422.819768ms","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:33:06.949632Z","caller":"traceutil/trace.go:171","msg":"trace[1056960029] linearizableReadLoop","detail":"{readStateIndex:2222; appliedIndex:2221; }","duration":"280.377615ms","start":"2026-09-07T03:33:06.669232Z","end":"2026-09-07T03:33:06.94961Z","steps":["trace[1056960029] 'read index received' (duration: 156.028599ms)","trace[1056960029] 'applied index is now lower than readState.Index' (duration: 124.347276ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:33:06.950722Z","caller":"traceutil/trace.go:171","msg":"trace[2103576471] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"276.262918ms","start":"2026-09-07T03:33:06.674384Z","end":"2026-09-07T03:33:06.950647Z","steps":["trace[2103576471] 'process raft request' (duration: 275.110956ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:33:06.951358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.851885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-07T03:33:06.95144Z","caller":"traceutil/trace.go:171","msg":"trace[470889010] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2138; }","duration":"106.991999ms","start":"2026-09-07T03:33:06.844427Z","end":"2026-09-07T03:33:06.951419Z","steps":["trace[470889010] 'agreement among raft nodes before linearized reading' (duration: 106.606248ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:33:06.951694Z","caller":"traceutil/trace.go:171","msg":"trace[1895675396] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"161.453135ms","start":"2026-09-07T03:33:06.790223Z","end":"2026-09-07T03:33:06.951676Z","steps":["trace[1895675396] 'process raft request' (duration: 159.399297ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:33:06.951733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.73712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-09-07T03:33:06.951811Z","caller":"traceutil/trace.go:171","msg":"trace[280287349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2138; }","duration":"525.816821ms","start":"2026-09-07T03:33:06.425962Z","end":"2026-09-07T03:33:06.951779Z","steps":["trace[280287349] 'agreement among raft nodes before linearized reading' (duration: 525.468131ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:33:06.951869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:33:06.425955Z","time spent":"525.893654ms","remote":"127.0.0.1:40138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-09-07T03:33:07.164749Z","caller":"traceutil/trace.go:171","msg":"trace[459413995] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"204.526318ms","start":"2026-09-07T03:33:06.960176Z","end":"2026-09-07T03:33:07.164703Z","steps":["trace[459413995] 'process raft request' (duration: 204.207919ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:33:07.164668Z","caller":"traceutil/trace.go:171","msg":"trace[1197532678] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"206.518474ms","start":"2026-09-07T03:33:06.958123Z","end":"2026-09-07T03:33:07.164641Z","steps":["trace[1197532678] 'process raft request' (duration: 195.498979ms)","trace[1197532678] 'compare' (duration: 10.637584ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:33:54.193378Z","caller":"traceutil/trace.go:171","msg":"trace[1945461223] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"132.227107ms","start":"2026-09-07T03:33:54.061121Z","end":"2026-09-07T03:33:54.193348Z","steps":["trace[1945461223] 'process raft request' (duration: 132.050592ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:34:27.182784Z","caller":"traceutil/trace.go:171","msg":"trace[1124984614] transaction","detail":"{read_only:false; response_revision:2679; number_of_response:1; }","duration":"224.489476ms","start":"2026-09-07T03:34:26.958272Z","end":"2026-09-07T03:34:27.182762Z","steps":["trace[1124984614] 'process raft request' (duration: 224.333642ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:37:48.770876Z","caller":"traceutil/trace.go:171","msg":"trace[2140207390] transaction","detail":"{read_only:false; response_revision:3826; number_of_response:1; }","duration":"151.405758ms","start":"2026-09-07T03:37:48.619435Z","end":"2026-09-07T03:37:48.770841Z","steps":["trace[2140207390] 'process raft request' (duration: 151.094558ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:38:58.054224Z","caller":"traceutil/trace.go:171","msg":"trace[2073846443] linearizableReadLoop","detail":"{readStateIndex:4902; appliedIndex:4901; }","duration":"131.839643ms","start":"2026-09-07T03:38:57.922368Z","end":"2026-09-07T03:38:58.054208Z","steps":["trace[2073846443] 'read index received' (duration: 131.719729ms)","trace[2073846443] 'applied index is now lower than readState.Index' (duration: 119.274µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:38:58.054298Z","caller":"traceutil/trace.go:171","msg":"trace[977949400] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"164.717829ms","start":"2026-09-07T03:38:57.889519Z","end":"2026-09-07T03:38:58.054237Z","steps":["trace[977949400] 'process raft request' (duration: 164.591295ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:38:58.054399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.013188ms","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-09-07T03:38:58.054418Z","caller":"traceutil/trace.go:171","msg":"trace[1227214231] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4718; }","duration":"132.06648ms","start":"2026-09-07T03:38:57.922346Z","end":"2026-09-07T03:38:58.054412Z","steps":["trace[1227214231] 'agreement among raft nodes before linearized reading' (duration: 131.952627ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.333292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.313937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:39:06.33342Z","caller":"traceutil/trace.go:171","msg":"trace[1387529687] linearizableReadLoop","detail":"{readStateIndex:5087; appliedIndex:5086; }","duration":"346.422859ms","start":"2026-09-07T03:39:05.986976Z","end":"2026-09-07T03:39:06.333399Z","steps":["trace[1387529687] 'read index received' (duration: 119.001729ms)","trace[1387529687] 'applied index is now lower than readState.Index' (duration: 227.41971ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:39:06.33348Z","caller":"traceutil/trace.go:171","msg":"trace[916633705] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"349.811163ms","start":"2026-09-07T03:39:05.983637Z","end":"2026-09-07T03:39:06.333448Z","steps":["trace[916633705] 'process raft request' (duration: 122.261409ms)","trace[916633705] 'compare' (duration: 227.183323ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:39:06.33361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:39:05.983628Z","time spent":"349.919106ms","remote":"127.0.0.1:39944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T03:39:06.334396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.399029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-09-07T03:39:06.334473Z","caller":"traceutil/trace.go:171","msg":"trace[852036695] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4897; }","duration":"347.515322ms","start":"2026-09-07T03:39:05.98694Z","end":"2026-09-07T03:39:06.334455Z","steps":["trace[852036695] 'agreement among raft nodes before linearized reading' (duration: 346.519862ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.334515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:39:05.986923Z","time spent":"347.583104ms","remote":"127.0.0.1:41020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3265,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-09-07T03:39:06.340232Z","caller":"traceutil/trace.go:171","msg":"trace[1332337068] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"106.467552ms","start":"2026-09-07T03:39:06.23374Z","end":"2026-09-07T03:39:06.340208Z","steps":["trace[1332337068] 'process raft request' (duration: 106.248635ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.340424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.931142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-09-07T03:39:06.340604Z","caller":"traceutil/trace.go:171","msg":"trace[405143298] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4898; }","duration":"223.135479ms","start":"2026-09-07T03:39:06.117438Z","end":"2026-09-07T03:39:06.340573Z","steps":["trace[405143298] 'agreement among raft nodes before linearized reading' (duration: 222.801738ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.340848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.032994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-07T03:39:06.34094Z","caller":"traceutil/trace.go:171","msg":"trace[732564654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4898; }","duration":"233.140988ms","start":"2026-09-07T03:39:06.107758Z","end":"2026-09-07T03:39:06.340899Z","steps":["trace[732564654] 'agreement among raft nodes before linearized reading' (duration: 232.825348ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.34137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.551142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-09-07T03:39:06.341437Z","caller":"traceutil/trace.go:171","msg":"trace[743313067] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4898; }","duration":"261.659327ms","start":"2026-09-07T03:39:06.07976Z","end":"2026-09-07T03:39:06.34142Z","steps":["trace[743313067] 'agreement among raft nodes before linearized reading' (duration: 261.507282ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.34263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.64966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-07T03:39:06.344622Z","caller":"traceutil/trace.go:171","msg":"trace[2100701377] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4898; }","duration":"330.656832ms","start":"2026-09-07T03:39:06.013939Z","end":"2026-09-07T03:39:06.344596Z","steps":["trace[2100701377] 'agreement among raft nodes before linearized reading' (duration: 326.189194ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.344714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:39:06.013927Z","time spent":"330.759345ms","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207440,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-09-07T03:39:06.728284Z","caller":"traceutil/trace.go:171","msg":"trace[2140184751] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"183.495457ms","start":"2026-09-07T03:39:06.544769Z","end":"2026-09-07T03:39:06.728265Z","steps":["trace[2140184751] 'process raft request' (duration: 135.019433ms)","trace[2140184751] 'compare' (duration: 47.975178ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:39:06.727887Z","caller":"traceutil/trace.go:171","msg":"trace[1314809943] linearizableReadLoop","detail":"{readStateIndex:5098; appliedIndex:5097; }","duration":"182.68303ms","start":"2026-09-07T03:39:06.54518Z","end":"2026-09-07T03:39:06.727863Z","steps":["trace[1314809943] 'read index received' (duration: 134.631989ms)","trace[1314809943] 'applied index is now lower than readState.Index' (duration: 48.050131ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:39:06.728765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.560718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9426"} {"level":"info","ts":"2026-09-07T03:39:06.728833Z","caller":"traceutil/trace.go:171","msg":"trace[1496797660] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4908; }","duration":"183.65246ms","start":"2026-09-07T03:39:06.54516Z","end":"2026-09-07T03:39:06.728812Z","steps":["trace[1496797660] 'agreement among raft nodes before linearized reading' (duration: 183.438984ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:39:06.781322Z","caller":"traceutil/trace.go:171","msg":"trace[1455689393] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"216.788762ms","start":"2026-09-07T03:39:06.564489Z","end":"2026-09-07T03:39:06.781278Z","steps":["trace[1455689393] 'process raft request' (duration: 216.607576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.781509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.214001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18d2ecc80ab855af\" ","response":"range_response_count:1 size:740"} {"level":"info","ts":"2026-09-07T03:39:06.781585Z","caller":"traceutil/trace.go:171","msg":"trace[409651559] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18d2ecc80ab855af; range_end:; response_count:1; response_revision:4909; }","duration":"236.313773ms","start":"2026-09-07T03:39:06.545248Z","end":"2026-09-07T03:39:06.781562Z","steps":["trace[409651559] 'agreement among raft nodes before linearized reading' (duration: 236.044125ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:06.781835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.034324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"warn","ts":"2026-09-07T03:39:06.782065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.368468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-09-07T03:39:06.782154Z","caller":"traceutil/trace.go:171","msg":"trace[117219174] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4909; }","duration":"226.723219ms","start":"2026-09-07T03:39:06.555415Z","end":"2026-09-07T03:39:06.782139Z","steps":["trace[117219174] 'agreement among raft nodes before linearized reading' (duration: 226.240324ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:39:06.782015Z","caller":"traceutil/trace.go:171","msg":"trace[1848166543] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4909; }","duration":"234.145867ms","start":"2026-09-07T03:39:06.547752Z","end":"2026-09-07T03:39:06.781898Z","steps":["trace[1848166543] 'agreement among raft nodes before linearized reading' (duration: 233.890469ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:39:06.887523Z","caller":"traceutil/trace.go:171","msg":"trace[1297607427] linearizableReadLoop","detail":"{readStateIndex:5100; appliedIndex:5099; }","duration":"100.699004ms","start":"2026-09-07T03:39:06.786793Z","end":"2026-09-07T03:39:06.887492Z","steps":["trace[1297607427] 'read index received' (duration: 86.977371ms)","trace[1297607427] 'applied index is now lower than readState.Index' (duration: 13.720353ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:39:06.887549Z","caller":"traceutil/trace.go:171","msg":"trace[274167485] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"103.690716ms","start":"2026-09-07T03:39:06.783831Z","end":"2026-09-07T03:39:06.887522Z","steps":["trace[274167485] 'process raft request' (duration: 90.032105ms)","trace[274167485] 'compare' (duration: 13.475725ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:39:06.887731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.90966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:39:06.887781Z","caller":"traceutil/trace.go:171","msg":"trace[330057966] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4910; }","duration":"101.013284ms","start":"2026-09-07T03:39:06.786749Z","end":"2026-09-07T03:39:06.887763Z","steps":["trace[330057966] 'agreement among raft nodes before linearized reading' (duration: 100.913361ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:39:09.643664Z","caller":"traceutil/trace.go:171","msg":"trace[495574238] transaction","detail":"{read_only:false; response_revision:4960; number_of_response:1; }","duration":"192.887201ms","start":"2026-09-07T03:39:09.450753Z","end":"2026-09-07T03:39:09.64364Z","steps":["trace[495574238] 'process raft request' (duration: 192.701745ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:39:15.079165Z","caller":"traceutil/trace.go:171","msg":"trace[1045832139] transaction","detail":"{read_only:false; response_revision:5057; number_of_response:1; }","duration":"108.955992ms","start":"2026-09-07T03:39:14.970184Z","end":"2026-09-07T03:39:15.07914Z","steps":["trace[1045832139] 'process raft request' (duration: 108.57164ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:18.970802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.158588ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:39:18.971179Z","caller":"traceutil/trace.go:171","msg":"trace[1933495491] linearizableReadLoop","detail":"{readStateIndex:5280; appliedIndex:5277; }","duration":"462.669102ms","start":"2026-09-07T03:39:18.508486Z","end":"2026-09-07T03:39:18.971155Z","steps":["trace[1933495491] 'read index received' (duration: 105.961568ms)","trace[1933495491] 'applied index is now lower than readState.Index' (duration: 356.706124ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:39:18.971452Z","caller":"traceutil/trace.go:171","msg":"trace[1418811608] transaction","detail":"{read_only:false; response_revision:5083; number_of_response:1; }","duration":"463.119615ms","start":"2026-09-07T03:39:18.508275Z","end":"2026-09-07T03:39:18.971395Z","steps":["trace[1418811608] 'process raft request' (duration: 462.644541ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:39:18.971545Z","caller":"traceutil/trace.go:171","msg":"trace[597200675] transaction","detail":"{read_only:false; response_revision:5085; number_of_response:1; }","duration":"462.904259ms","start":"2026-09-07T03:39:18.508629Z","end":"2026-09-07T03:39:18.971533Z","steps":["trace[597200675] 'process raft request' (duration: 462.468996ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:18.971634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:39:18.508619Z","time spent":"462.966721ms","remote":"127.0.0.1:40046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T03:39:18.971663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:39:18.508265Z","time spent":"463.277301ms","remote":"127.0.0.1:40152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1428,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:39:18.971916Z","caller":"traceutil/trace.go:171","msg":"trace[424306536] transaction","detail":"{read_only:false; response_revision:5082; number_of_response:1; }","duration":"464.244841ms","start":"2026-09-07T03:39:18.507657Z","end":"2026-09-07T03:39:18.971902Z","steps":["trace[424306536] 'process raft request' (duration: 106.882035ms)","trace[424306536] 'compare' (duration: 355.678164ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:39:18.97202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:39:18.507635Z","time spent":"464.304623ms","remote":"127.0.0.1:40046","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T03:39:18.972041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.544859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-879fdd02-cc83-4c82-8a66-eec010c1b49f\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-09-07T03:39:18.972098Z","caller":"traceutil/trace.go:171","msg":"trace[1347055261] range","detail":"{range_begin:/registry/persistentvolumes/pvc-879fdd02-cc83-4c82-8a66-eec010c1b49f; range_end:; response_count:1; response_revision:5085; }","duration":"463.614922ms","start":"2026-09-07T03:39:18.508461Z","end":"2026-09-07T03:39:18.972076Z","steps":["trace[1347055261] 'agreement among raft nodes before linearized reading' (duration: 463.422636ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:39:18.9715Z","caller":"traceutil/trace.go:171","msg":"trace[602325601] transaction","detail":"{read_only:false; response_revision:5084; number_of_response:1; }","duration":"463.122096ms","start":"2026-09-07T03:39:18.508355Z","end":"2026-09-07T03:39:18.971477Z","steps":["trace[602325601] 'process raft request' (duration: 462.686183ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:18.972144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:39:18.508455Z","time spent":"463.678944ms","remote":"127.0.0.1:40016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1344,"request content":"key:\"/registry/persistentvolumes/pvc-879fdd02-cc83-4c82-8a66-eec010c1b49f\" "} {"level":"warn","ts":"2026-09-07T03:39:18.972196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:39:18.508347Z","time spent":"463.794667ms","remote":"127.0.0.1:40152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1505,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:39:18.976732Z","caller":"traceutil/trace.go:171","msg":"trace[2019552270] transaction","detail":"{read_only:false; response_revision:5086; number_of_response:1; }","duration":"148.219366ms","start":"2026-09-07T03:39:18.828489Z","end":"2026-09-07T03:39:18.976708Z","steps":["trace[2019552270] 'process raft request' (duration: 148.079501ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:39:18.977263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.085416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-07T03:39:18.977298Z","caller":"traceutil/trace.go:171","msg":"trace[1222734763] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5086; }","duration":"195.139437ms","start":"2026-09-07T03:39:18.782151Z","end":"2026-09-07T03:39:18.97729Z","steps":["trace[1222734763] 'agreement among raft nodes before linearized reading' (duration: 194.827238ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:40:09.061983Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2900} {"level":"info","ts":"2026-09-07T03:40:09.184147Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2900,"took":"121.116899ms","hash":467539663,"current-db-size-bytes":53411840,"current-db-size":"53 MB","current-db-size-in-use-bytes":28729344,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-07T03:40:09.184248Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":467539663,"revision":2900,"compact-revision":-1} {"level":"info","ts":"2026-09-07T03:43:06.651363Z","caller":"traceutil/trace.go:171","msg":"trace[2139044080] transaction","detail":"{read_only:false; response_revision:6728; number_of_response:1; }","duration":"100.604541ms","start":"2026-09-07T03:43:06.550735Z","end":"2026-09-07T03:43:06.65134Z","steps":["trace[2139044080] 'process raft request' (duration: 41.411484ms)","trace[2139044080] 'compare' (duration: 58.781925ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:45:09.06919Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5505} {"level":"info","ts":"2026-09-07T03:45:09.304994Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5505,"took":"234.194619ms","hash":3721418814,"current-db-size-bytes":53411840,"current-db-size":"53 MB","current-db-size-in-use-bytes":18526208,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-09-07T03:45:09.305072Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3721418814,"revision":5505,"compact-revision":2900}