{"level":"warn","ts":"2026-08-28T06:01:13.382632Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-28T06:01:13.382834Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.153: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.153:2380","--initial-cluster=instance=https://162.253.55.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.153: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-08-28T06:01:13.382912Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-28T06:01:13.38292Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.153:2380"]} {"level":"info","ts":"2026-08-28T06:01:13.382944Z","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-08-28T06:01:13.384666Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"]} {"level":"info","ts":"2026-08-28T06:01:13.384781Z","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.153:2380"],"listen-peer-urls":["https://162.253.55.153:2380"],"advertise-client-urls":["https://162.253.55.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.153: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-08-28T06:01:13.389035Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.072148ms"} {"level":"info","ts":"2026-08-28T06:01:13.397527Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"522eb07aa35b671b","cluster-id":"49de17121e7ddda"} {"level":"info","ts":"2026-08-28T06:01:13.397618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=()"} {"level":"info","ts":"2026-08-28T06:01:13.397647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became follower at term 0"} {"level":"info","ts":"2026-08-28T06:01:13.397667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 522eb07aa35b671b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-28T06:01:13.39769Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became follower at term 1"} {"level":"info","ts":"2026-08-28T06:01:13.397731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=(5921864600811955995)"} {"level":"warn","ts":"2026-08-28T06:01:13.404367Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-28T06:01:13.411228Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-28T06:01:13.412736Z","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-08-28T06:01:13.415328Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"522eb07aa35b671b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-28T06:01:13.415487Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"522eb07aa35b671b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-28T06:01:13.415684Z","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-08-28T06:01:13.415717Z","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-08-28T06:01:13.415724Z","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-08-28T06:01:13.416245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b switched to configuration voters=(5921864600811955995)"} {"level":"info","ts":"2026-08-28T06:01:13.41634Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49de17121e7ddda","local-member-id":"522eb07aa35b671b","added-peer-id":"522eb07aa35b671b","added-peer-peer-urls":["https://162.253.55.153:2380"]} {"level":"info","ts":"2026-08-28T06:01:13.419045Z","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-08-28T06:01:13.419153Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.153:2380"} {"level":"info","ts":"2026-08-28T06:01:13.419183Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.153:2380"} {"level":"info","ts":"2026-08-28T06:01:13.41932Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"522eb07aa35b671b","initial-advertise-peer-urls":["https://162.253.55.153:2380"],"listen-peer-urls":["https://162.253.55.153:2380"],"advertise-client-urls":["https://162.253.55.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-28T06:01:13.419363Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-28T06:01:14.398518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b is starting a new election at term 1"} {"level":"info","ts":"2026-08-28T06:01:14.398642Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-28T06:01:14.398707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b received MsgPreVoteResp from 522eb07aa35b671b at term 1"} {"level":"info","ts":"2026-08-28T06:01:14.398766Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became candidate at term 2"} {"level":"info","ts":"2026-08-28T06:01:14.398822Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b received MsgVoteResp from 522eb07aa35b671b at term 2"} {"level":"info","ts":"2026-08-28T06:01:14.398867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"522eb07aa35b671b became leader at term 2"} {"level":"info","ts":"2026-08-28T06:01:14.398908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 522eb07aa35b671b elected leader 522eb07aa35b671b at term 2"} {"level":"info","ts":"2026-08-28T06:01:14.399979Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"522eb07aa35b671b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.153:2379]}","request-path":"/0/members/522eb07aa35b671b/attributes","cluster-id":"49de17121e7ddda","publish-timeout":"7s"} {"level":"info","ts":"2026-08-28T06:01:14.399986Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-28T06:01:14.400089Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-28T06:01:14.400015Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T06:01:14.400332Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-28T06:01:14.400369Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-28T06:01:14.401289Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49de17121e7ddda","local-member-id":"522eb07aa35b671b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T06:01:14.401467Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T06:01:14.401514Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-28T06:01:14.402081Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-28T06:01:14.403048Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.153:2379"} {"level":"warn","ts":"2026-08-28T06:01:17.339249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.029686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:01:17.339335Z","caller":"traceutil/trace.go:171","msg":"trace[1220278167] range","detail":"{range_begin:/registry/clusterroles/system:controller:persistent-volume-binder; range_end:; response_count:0; response_revision:160; }","duration":"189.15899ms","start":"2026-08-28T06:01:17.150157Z","end":"2026-08-28T06:01:17.339316Z","steps":["trace[1220278167] 'range keys from in-memory index tree' (duration: 188.978684ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:17.505461Z","caller":"traceutil/trace.go:171","msg":"trace[569578101] transaction","detail":"{read_only:false; response_revision:161; number_of_response:1; }","duration":"162.741709ms","start":"2026-08-28T06:01:17.342705Z","end":"2026-08-28T06:01:17.505447Z","steps":["trace[569578101] 'process raft request' (duration: 162.646446ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:17.829368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.23337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-28T06:01:17.829531Z","caller":"traceutil/trace.go:171","msg":"trace[1058039955] transaction","detail":"{read_only:false; response_revision:162; number_of_response:1; }","duration":"317.887804ms","start":"2026-08-28T06:01:17.511617Z","end":"2026-08-28T06:01:17.829505Z","steps":["trace[1058039955] 'process raft request' (duration: 161.050255ms)","trace[1058039955] 'compare' (duration: 156.156527ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:01:17.829723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:17.511593Z","time spent":"318.06161ms","remote":"127.0.0.1:51802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":650,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-28T06:01:50.511139Z","caller":"traceutil/trace.go:171","msg":"trace[1591055607] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"130.748219ms","start":"2026-08-28T06:01:50.380364Z","end":"2026-08-28T06:01:50.511112Z","steps":["trace[1591055607] 'process raft request' (duration: 111.278736ms)","trace[1591055607] 'compare' (duration: 19.201816ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:01:50.511515Z","caller":"traceutil/trace.go:171","msg":"trace[74914721] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:584; }","duration":"107.198285ms","start":"2026-08-28T06:01:50.404293Z","end":"2026-08-28T06:01:50.511491Z","steps":["trace[74914721] 'read index received' (duration: 87.366814ms)","trace[74914721] 'applied index is now lower than readState.Index' (duration: 19.830431ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:01:50.511634Z","caller":"traceutil/trace.go:171","msg":"trace[1796531799] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"128.77784ms","start":"2026-08-28T06:01:50.382845Z","end":"2026-08-28T06:01:50.511622Z","steps":["trace[1796531799] 'process raft request' (duration: 128.164575ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:50.511819Z","caller":"traceutil/trace.go:171","msg":"trace[170738191] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"119.739237ms","start":"2026-08-28T06:01:50.392059Z","end":"2026-08-28T06:01:50.511798Z","steps":["trace[170738191] 'process raft request' (duration: 119.349307ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:50.511819Z","caller":"traceutil/trace.go:171","msg":"trace[2074114269] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"127.377976ms","start":"2026-08-28T06:01:50.384384Z","end":"2026-08-28T06:01:50.511762Z","steps":["trace[2074114269] 'process raft request' (duration: 126.927395ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:50.513762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.418711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-28T06:01:50.514178Z","caller":"traceutil/trace.go:171","msg":"trace[1431956857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:570; }","duration":"109.564344ms","start":"2026-08-28T06:01:50.404275Z","end":"2026-08-28T06:01:50.513839Z","steps":["trace[1431956857] 'agreement among raft nodes before linearized reading' (duration: 107.464962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:54.82292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.30798ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T06:01:54.823026Z","caller":"traceutil/trace.go:171","msg":"trace[95723999] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:637; }","duration":"271.835055ms","start":"2026-08-28T06:01:54.551155Z","end":"2026-08-28T06:01:54.82299Z","steps":["trace[95723999] 'read index received' (duration: 1.889166ms)","trace[95723999] 'applied index is now lower than readState.Index' (duration: 269.944709ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:01:54.823088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.928767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:01:54.823114Z","caller":"traceutil/trace.go:171","msg":"trace[1175091113] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:618; }","duration":"271.975598ms","start":"2026-08-28T06:01:54.551129Z","end":"2026-08-28T06:01:54.823104Z","steps":["trace[1175091113] 'agreement among raft nodes before linearized reading' (duration: 271.930247ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:54.823128Z","caller":"traceutil/trace.go:171","msg":"trace[995130943] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"285.426926ms","start":"2026-08-28T06:01:54.537627Z","end":"2026-08-28T06:01:54.823054Z","steps":["trace[995130943] 'process raft request' (duration: 46.809438ms)","trace[995130943] 'compare' (duration: 238.136256ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:01:54.894539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.237423ms","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:5"} {"level":"warn","ts":"2026-08-28T06:01:54.894587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.157781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-28T06:01:54.894676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.303706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:01:54.894678Z","caller":"traceutil/trace.go:171","msg":"trace[659487246] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:619; }","duration":"295.255954ms","start":"2026-08-28T06:01:54.599397Z","end":"2026-08-28T06:01:54.894653Z","steps":["trace[659487246] 'agreement among raft nodes before linearized reading' (duration: 295.135871ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:54.894721Z","caller":"traceutil/trace.go:171","msg":"trace[178300004] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:619; }","duration":"295.348966ms","start":"2026-08-28T06:01:54.599345Z","end":"2026-08-28T06:01:54.894694Z","steps":["trace[178300004] 'agreement among raft nodes before linearized reading' (duration: 295.305025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:54.894719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.407464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-28T06:01:54.894806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.736585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:01:54.894815Z","caller":"traceutil/trace.go:171","msg":"trace[1436028366] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:619; }","duration":"315.543987ms","start":"2026-08-28T06:01:54.579246Z","end":"2026-08-28T06:01:54.89479Z","steps":["trace[1436028366] 'agreement among raft nodes before linearized reading' (duration: 315.354972ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:54.894851Z","caller":"traceutil/trace.go:171","msg":"trace[1554223486] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:619; }","duration":"304.804436ms","start":"2026-08-28T06:01:54.590027Z","end":"2026-08-28T06:01:54.894832Z","steps":["trace[1554223486] 'agreement among raft nodes before linearized reading' (duration: 304.748404ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:54.894865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:54.579234Z","time spent":"315.617129ms","remote":"127.0.0.1:38052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-08-28T06:01:54.894885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:54.590011Z","time spent":"304.864138ms","remote":"127.0.0.1:38062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-08-28T06:01:54.894624Z","caller":"traceutil/trace.go:171","msg":"trace[2103195359] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:619; }","duration":"304.359395ms","start":"2026-08-28T06:01:54.590239Z","end":"2026-08-28T06:01:54.894599Z","steps":["trace[2103195359] 'agreement among raft nodes before linearized reading' (duration: 304.182991ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:54.894999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.66244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:01:54.895027Z","caller":"traceutil/trace.go:171","msg":"trace[766521541] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:619; }","duration":"315.702791ms","start":"2026-08-28T06:01:54.579313Z","end":"2026-08-28T06:01:54.895016Z","steps":["trace[766521541] 'agreement among raft nodes before linearized reading' (duration: 315.66267ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:54.895031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:54.590226Z","time spent":"304.788916ms","remote":"127.0.0.1:38062","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-28T06:01:54.895052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:54.579308Z","time spent":"315.736732ms","remote":"127.0.0.1:38052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-08-28T06:01:54.89472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.359333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:01:54.895094Z","caller":"traceutil/trace.go:171","msg":"trace[752485589] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:619; }","duration":"315.794633ms","start":"2026-08-28T06:01:54.579289Z","end":"2026-08-28T06:01:54.895083Z","steps":["trace[752485589] 'agreement among raft nodes before linearized reading' (duration: 315.288941ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:54.895126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:54.579283Z","time spent":"315.831474ms","remote":"127.0.0.1:38052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-08-28T06:01:54.895282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.979965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-28T06:01:54.894488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.3623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:01:54.895409Z","caller":"traceutil/trace.go:171","msg":"trace[304448052] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:619; }","duration":"341.153499ms","start":"2026-08-28T06:01:54.554219Z","end":"2026-08-28T06:01:54.895373Z","steps":["trace[304448052] 'agreement among raft nodes before linearized reading' (duration: 340.924293ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:54.895443Z","caller":"traceutil/trace.go:171","msg":"trace[1248550201] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:619; }","duration":"341.361484ms","start":"2026-08-28T06:01:54.55406Z","end":"2026-08-28T06:01:54.895422Z","steps":["trace[1248550201] 'agreement among raft nodes before linearized reading' (duration: 340.321889ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:54.895459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:54.554213Z","time spent":"341.234101ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-28T06:01:54.895479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:54.554048Z","time spent":"341.418035ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-28T06:01:54.895725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.239008ms","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:5"} {"level":"info","ts":"2026-08-28T06:01:54.89578Z","caller":"traceutil/trace.go:171","msg":"trace[1331953562] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:619; }","duration":"296.32938ms","start":"2026-08-28T06:01:54.599428Z","end":"2026-08-28T06:01:54.895757Z","steps":["trace[1331953562] 'agreement among raft nodes before linearized reading' (duration: 296.167886ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:56.088108Z","caller":"traceutil/trace.go:171","msg":"trace[1845493912] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"200.309405ms","start":"2026-08-28T06:01:55.887736Z","end":"2026-08-28T06:01:56.088046Z","steps":["trace[1845493912] 'process raft request' (duration: 199.775982ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:56.728611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.896313ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T06:01:56.728784Z","caller":"traceutil/trace.go:171","msg":"trace[938388494] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"574.335331ms","start":"2026-08-28T06:01:56.154378Z","end":"2026-08-28T06:01:56.728713Z","steps":["trace[938388494] 'process raft request' (duration: 411.247114ms)","trace[938388494] 'compare' (duration: 162.79536ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:01:56.72889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:56.154357Z","time spent":"574.465613ms","remote":"127.0.0.1:51652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-28T06:01:56.888595Z","caller":"traceutil/trace.go:171","msg":"trace[331587099] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:649; }","duration":"332.23454ms","start":"2026-08-28T06:01:56.556326Z","end":"2026-08-28T06:01:56.888561Z","steps":["trace[331587099] 'read index received' (duration: 9.306554ms)","trace[331587099] 'applied index is now lower than readState.Index' (duration: 322.927006ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:01:56.888729Z","caller":"traceutil/trace.go:171","msg":"trace[2007314630] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"330.737844ms","start":"2026-08-28T06:01:56.557981Z","end":"2026-08-28T06:01:56.888718Z","steps":["trace[2007314630] 'process raft request' (duration: 330.518409ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:01:56.888835Z","caller":"traceutil/trace.go:171","msg":"trace[678424288] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"722.884968ms","start":"2026-08-28T06:01:56.165923Z","end":"2026-08-28T06:01:56.888808Z","steps":["trace[678424288] 'process raft request' (duration: 710.888269ms)","trace[678424288] 'compare' (duration: 11.575639ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:01:56.888941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:56.165892Z","time spent":"722.99573ms","remote":"127.0.0.1:51818","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-28T06:01:56.889032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.683802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-28T06:01:56.889102Z","caller":"traceutil/trace.go:171","msg":"trace[1326852360] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"332.802454ms","start":"2026-08-28T06:01:56.556279Z","end":"2026-08-28T06:01:56.889082Z","steps":["trace[1326852360] 'agreement among raft nodes before linearized reading' (duration: 332.691161ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:01:56.889134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:56.556258Z","time spent":"332.867926ms","remote":"127.0.0.1:51742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-28T06:01:56.888839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:01:56.55796Z","time spent":"330.791226ms","remote":"127.0.0.1:51742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-28T06:02:11.243788Z","caller":"traceutil/trace.go:171","msg":"trace[1231341938] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"197.321114ms","start":"2026-08-28T06:02:11.046442Z","end":"2026-08-28T06:02:11.243763Z","steps":["trace[1231341938] 'read index received' (duration: 196.888114ms)","trace[1231341938] 'applied index is now lower than readState.Index' (duration: 431.92µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:02:11.243869Z","caller":"traceutil/trace.go:171","msg":"trace[815726360] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"223.570703ms","start":"2026-08-28T06:02:11.020274Z","end":"2026-08-28T06:02:11.243845Z","steps":["trace[815726360] 'process raft request' (duration: 223.259876ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:02:11.243964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.52126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:02:11.244002Z","caller":"traceutil/trace.go:171","msg":"trace[572208777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:794; }","duration":"226.601202ms","start":"2026-08-28T06:02:11.017389Z","end":"2026-08-28T06:02:11.24399Z","steps":["trace[572208777] 'agreement among raft nodes before linearized reading' (duration: 226.526191ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:02:11.244626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.571711ms","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-08-28T06:02:11.244667Z","caller":"traceutil/trace.go:171","msg":"trace[780582290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:795; }","duration":"169.659572ms","start":"2026-08-28T06:02:11.074995Z","end":"2026-08-28T06:02:11.244655Z","steps":["trace[780582290] 'agreement among raft nodes before linearized reading' (duration: 169.495009ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:02:11.244686Z","caller":"traceutil/trace.go:171","msg":"trace[66428807] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"194.07303ms","start":"2026-08-28T06:02:11.050593Z","end":"2026-08-28T06:02:11.244666Z","steps":["trace[66428807] 'process raft request' (duration: 193.829314ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:02:41.57848Z","caller":"traceutil/trace.go:171","msg":"trace[1752734925] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"160.293191ms","start":"2026-08-28T06:02:41.418164Z","end":"2026-08-28T06:02:41.578457Z","steps":["trace[1752734925] 'process raft request' (duration: 74.020794ms)","trace[1752734925] 'compare' (duration: 86.05515ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:03:38.741959Z","caller":"traceutil/trace.go:171","msg":"trace[1274536076] transaction","detail":"{read_only:false; response_revision:1920; number_of_response:1; }","duration":"157.410391ms","start":"2026-08-28T06:03:38.58452Z","end":"2026-08-28T06:03:38.74193Z","steps":["trace[1274536076] 'process raft request' (duration: 91.892093ms)","trace[1274536076] 'compare' (duration: 65.362194ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:03:38.806224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.305297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-08-28T06:03:38.806285Z","caller":"traceutil/trace.go:171","msg":"trace[387836681] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1922; }","duration":"150.41061ms","start":"2026-08-28T06:03:38.65586Z","end":"2026-08-28T06:03:38.80627Z","steps":["trace[387836681] 'agreement among raft nodes before linearized reading' (duration: 150.140813ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:39.29752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.541395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T06:03:39.297884Z","caller":"traceutil/trace.go:171","msg":"trace[1369536118] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"479.019354ms","start":"2026-08-28T06:03:38.818817Z","end":"2026-08-28T06:03:39.297836Z","steps":["trace[1369536118] 'process raft request' (duration: 76.995337ms)","trace[1369536118] 'compare' (duration: 401.323329ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:03:39.29787Z","caller":"traceutil/trace.go:171","msg":"trace[1971960684] linearizableReadLoop","detail":"{readStateIndex:1998; appliedIndex:1997; }","duration":"282.273623ms","start":"2026-08-28T06:03:39.015516Z","end":"2026-08-28T06:03:39.297789Z","steps":["trace[1971960684] 'read index received' (duration: 38.041µs)","trace[1971960684] 'applied index is now lower than readState.Index' (duration: 282.229312ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:03:39.298069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:38.818794Z","time spent":"479.166388ms","remote":"127.0.0.1:51652","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T06:03:39.298107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.576781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:03:39.29819Z","caller":"traceutil/trace.go:171","msg":"trace[2143493553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1924; }","duration":"282.705224ms","start":"2026-08-28T06:03:39.015461Z","end":"2026-08-28T06:03:39.298166Z","steps":["trace[2143493553] 'agreement among raft nodes before linearized reading' (duration: 282.54289ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:03:39.331662Z","caller":"traceutil/trace.go:171","msg":"trace[1391682833] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"309.842317ms","start":"2026-08-28T06:03:39.021794Z","end":"2026-08-28T06:03:39.331636Z","steps":["trace[1391682833] 'process raft request' (duration: 309.56388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:03:39.331819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.25073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-08-28T06:03:39.331838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:03:39.021784Z","time spent":"309.947309ms","remote":"127.0.0.1:51742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-28T06:03:39.331901Z","caller":"traceutil/trace.go:171","msg":"trace[1255552578] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1925; }","duration":"290.361552ms","start":"2026-08-28T06:03:39.041516Z","end":"2026-08-28T06:03:39.331878Z","steps":["trace[1255552578] 'agreement among raft nodes before linearized reading' (duration: 290.123496ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:04:13.141647Z","caller":"traceutil/trace.go:171","msg":"trace[224210734] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"145.21797ms","start":"2026-08-28T06:04:12.996395Z","end":"2026-08-28T06:04:13.141613Z","steps":["trace[224210734] 'process raft request' (duration: 107.792838ms)","trace[224210734] 'compare' (duration: 37.213927ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:04:13.59208Z","caller":"traceutil/trace.go:171","msg":"trace[907727185] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"106.421284ms","start":"2026-08-28T06:04:13.485636Z","end":"2026-08-28T06:04:13.592057Z","steps":["trace[907727185] 'process raft request' (duration: 105.982134ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:04:13.771487Z","caller":"traceutil/trace.go:171","msg":"trace[1660011318] linearizableReadLoop","detail":"{readStateIndex:2247; appliedIndex:2246; }","duration":"165.100485ms","start":"2026-08-28T06:04:13.606364Z","end":"2026-08-28T06:04:13.771464Z","steps":["trace[1660011318] 'read index received' (duration: 164.870599ms)","trace[1660011318] 'applied index is now lower than readState.Index' (duration: 228.876µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:04:13.771541Z","caller":"traceutil/trace.go:171","msg":"trace[1340674129] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"179.540707ms","start":"2026-08-28T06:04:13.591974Z","end":"2026-08-28T06:04:13.771515Z","steps":["trace[1340674129] 'process raft request' (duration: 179.323232ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:04:13.771723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.34595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-28T06:04:13.771784Z","caller":"traceutil/trace.go:171","msg":"trace[527272881] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2167; }","duration":"165.475574ms","start":"2026-08-28T06:04:13.60629Z","end":"2026-08-28T06:04:13.771765Z","steps":["trace[527272881] 'agreement among raft nodes before linearized reading' (duration: 165.284899ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:04:14.241915Z","caller":"traceutil/trace.go:171","msg":"trace[1238086227] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"144.041767ms","start":"2026-08-28T06:04:14.09785Z","end":"2026-08-28T06:04:14.241892Z","steps":["trace[1238086227] 'process raft request' (duration: 143.919094ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:04:14.51402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.251295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-28T06:04:14.514107Z","caller":"traceutil/trace.go:171","msg":"trace[171524136] linearizableReadLoop","detail":"{readStateIndex:2251; appliedIndex:2249; }","duration":"330.628768ms","start":"2026-08-28T06:04:14.183463Z","end":"2026-08-28T06:04:14.514092Z","steps":["trace[171524136] 'read index received' (duration: 58.281428ms)","trace[171524136] 'applied index is now lower than readState.Index' (duration: 272.34637ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:04:14.514299Z","caller":"traceutil/trace.go:171","msg":"trace[657046803] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"335.423305ms","start":"2026-08-28T06:04:14.178864Z","end":"2026-08-28T06:04:14.514287Z","steps":["trace[657046803] 'process raft request' (duration: 210.79175ms)","trace[657046803] 'compare' (duration: 124.161863ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:04:14.514383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:04:14.178848Z","time spent":"335.499817ms","remote":"127.0.0.1:51742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-28T06:04:14.514493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.61386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:04:14.514543Z","caller":"traceutil/trace.go:171","msg":"trace[1345847272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:2170; }","duration":"243.694033ms","start":"2026-08-28T06:04:14.270836Z","end":"2026-08-28T06:04:14.51453Z","steps":["trace[1345847272] 'agreement among raft nodes before linearized reading' (duration: 243.60797ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:04:14.514718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.788954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-28T06:04:14.514854Z","caller":"traceutil/trace.go:171","msg":"trace[1683330878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2170; }","duration":"243.972509ms","start":"2026-08-28T06:04:14.270858Z","end":"2026-08-28T06:04:14.51483Z","steps":["trace[1683330878] 'agreement among raft nodes before linearized reading' (duration: 243.672562ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:04:14.514717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.246163ms","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-08-28T06:04:14.515079Z","caller":"traceutil/trace.go:171","msg":"trace[743508583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2170; }","duration":"331.671023ms","start":"2026-08-28T06:04:14.183388Z","end":"2026-08-28T06:04:14.515059Z","steps":["trace[743508583] 'agreement among raft nodes before linearized reading' (duration: 331.13458ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:04:14.515129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-28T06:04:14.183373Z","time spent":"331.740756ms","remote":"127.0.0.1:51742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-28T06:04:14.717011Z","caller":"traceutil/trace.go:171","msg":"trace[807989709] linearizableReadLoop","detail":"{readStateIndex:2253; appliedIndex:2252; }","duration":"118.111145ms","start":"2026-08-28T06:04:14.598882Z","end":"2026-08-28T06:04:14.716993Z","steps":["trace[807989709] 'read index received' (duration: 38.431295ms)","trace[807989709] 'applied index is now lower than readState.Index' (duration: 79.67913ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:04:14.717128Z","caller":"traceutil/trace.go:171","msg":"trace[318344464] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"197.573399ms","start":"2026-08-28T06:04:14.519481Z","end":"2026-08-28T06:04:14.717054Z","steps":["trace[318344464] 'process raft request' (duration: 117.807318ms)","trace[318344464] 'compare' (duration: 79.596657ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:04:14.717167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.268599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-28T06:04:14.717211Z","caller":"traceutil/trace.go:171","msg":"trace[911206815] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2172; }","duration":"118.352411ms","start":"2026-08-28T06:04:14.598848Z","end":"2026-08-28T06:04:14.717201Z","steps":["trace[911206815] 'agreement among raft nodes before linearized reading' (duration: 118.221038ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:06:03.462605Z","caller":"traceutil/trace.go:171","msg":"trace[968098554] transaction","detail":"{read_only:false; response_revision:2862; number_of_response:1; }","duration":"110.574553ms","start":"2026-08-28T06:06:03.352001Z","end":"2026-08-28T06:06:03.462575Z","steps":["trace[968098554] 'process raft request' (duration: 110.398629ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:06:03.61724Z","caller":"traceutil/trace.go:171","msg":"trace[676829563] transaction","detail":"{read_only:false; response_revision:2863; number_of_response:1; }","duration":"233.224009ms","start":"2026-08-28T06:06:03.383991Z","end":"2026-08-28T06:06:03.617215Z","steps":["trace[676829563] 'process raft request' (duration: 222.825444ms)","trace[676829563] 'compare' (duration: 10.305603ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:10:24.147035Z","caller":"traceutil/trace.go:171","msg":"trace[1326603823] linearizableReadLoop","detail":"{readStateIndex:5099; appliedIndex:5098; }","duration":"129.821035ms","start":"2026-08-28T06:10:24.017189Z","end":"2026-08-28T06:10:24.14701Z","steps":["trace[1326603823] 'read index received' (duration: 129.566549ms)","trace[1326603823] 'applied index is now lower than readState.Index' (duration: 253.266µs)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:10:24.147084Z","caller":"traceutil/trace.go:171","msg":"trace[1682888010] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"157.508976ms","start":"2026-08-28T06:10:23.98954Z","end":"2026-08-28T06:10:24.147049Z","steps":["trace[1682888010] 'process raft request' (duration: 157.260039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:10:24.147212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.008171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:10:24.147252Z","caller":"traceutil/trace.go:171","msg":"trace[26889133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4911; }","duration":"130.124124ms","start":"2026-08-28T06:10:24.017118Z","end":"2026-08-28T06:10:24.147242Z","steps":["trace[26889133] 'agreement among raft nodes before linearized reading' (duration: 130.037221ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:10:29.74299Z","caller":"traceutil/trace.go:171","msg":"trace[1854786438] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"272.637174ms","start":"2026-08-28T06:10:29.470326Z","end":"2026-08-28T06:10:29.742963Z","steps":["trace[1854786438] 'process raft request' (duration: 272.394177ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:10:29.742978Z","caller":"traceutil/trace.go:171","msg":"trace[681260793] linearizableReadLoop","detail":"{readStateIndex:5216; appliedIndex:5215; }","duration":"175.082453ms","start":"2026-08-28T06:10:29.567852Z","end":"2026-08-28T06:10:29.742934Z","steps":["trace[681260793] 'read index received' (duration: 174.833766ms)","trace[681260793] 'applied index is now lower than readState.Index' (duration: 247.217µs)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:10:29.743143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.263937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-28T06:10:29.743189Z","caller":"traceutil/trace.go:171","msg":"trace[1092699301] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:5026; }","duration":"175.391951ms","start":"2026-08-28T06:10:29.567787Z","end":"2026-08-28T06:10:29.743179Z","steps":["trace[1092699301] 'agreement among raft nodes before linearized reading' (duration: 175.252918ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:10:29.743345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.704201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-28T06:10:29.743431Z","caller":"traceutil/trace.go:171","msg":"trace[1241953455] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:5026; }","duration":"161.869047ms","start":"2026-08-28T06:10:29.581539Z","end":"2026-08-28T06:10:29.743408Z","steps":["trace[1241953455] 'agreement among raft nodes before linearized reading' (duration: 161.690622ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:10:29.855783Z","caller":"traceutil/trace.go:171","msg":"trace[383555644] linearizableReadLoop","detail":"{readStateIndex:5217; appliedIndex:5216; }","duration":"105.2777ms","start":"2026-08-28T06:10:29.750478Z","end":"2026-08-28T06:10:29.855756Z","steps":["trace[383555644] 'read index received' (duration: 65.099916ms)","trace[383555644] 'applied index is now lower than readState.Index' (duration: 40.176604ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:10:29.855824Z","caller":"traceutil/trace.go:171","msg":"trace[1177750780] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"106.272376ms","start":"2026-08-28T06:10:29.749501Z","end":"2026-08-28T06:10:29.855773Z","steps":["trace[1177750780] 'process raft request' (duration: 66.071222ms)","trace[1177750780] 'compare' (duration: 39.916657ms)"],"step_count":2} {"level":"warn","ts":"2026-08-28T06:10:29.856083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.576458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-28T06:10:29.856176Z","caller":"traceutil/trace.go:171","msg":"trace[332145991] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5027; }","duration":"105.721542ms","start":"2026-08-28T06:10:29.750431Z","end":"2026-08-28T06:10:29.856152Z","steps":["trace[332145991] 'agreement among raft nodes before linearized reading' (duration: 105.431214ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:10:29.879222Z","caller":"traceutil/trace.go:171","msg":"trace[1216986436] transaction","detail":"{read_only:false; response_revision:5028; number_of_response:1; }","duration":"119.322168ms","start":"2026-08-28T06:10:29.759876Z","end":"2026-08-28T06:10:29.879198Z","steps":["trace[1216986436] 'process raft request' (duration: 119.170934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:10:30.311307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.807906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-28T06:10:30.311407Z","caller":"traceutil/trace.go:171","msg":"trace[1399472844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5040; }","duration":"130.97165ms","start":"2026-08-28T06:10:30.180415Z","end":"2026-08-28T06:10:30.311387Z","steps":["trace[1399472844] 'range keys from in-memory index tree' (duration: 130.553159ms)"],"step_count":1} {"level":"warn","ts":"2026-08-28T06:10:43.67047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.122641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-08-28T06:10:43.670584Z","caller":"traceutil/trace.go:171","msg":"trace[447345308] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5209; }","duration":"170.533792ms","start":"2026-08-28T06:10:43.500031Z","end":"2026-08-28T06:10:43.670565Z","steps":["trace[447345308] 'range keys from in-memory index tree' (duration: 169.960777ms)"],"step_count":1} {"level":"info","ts":"2026-08-28T06:10:44.076452Z","caller":"traceutil/trace.go:171","msg":"trace[1373724829] transaction","detail":"{read_only:false; response_revision:5211; number_of_response:1; }","duration":"140.499049ms","start":"2026-08-28T06:10:43.935902Z","end":"2026-08-28T06:10:44.076401Z","steps":["trace[1373724829] 'process raft request' (duration: 104.968691ms)","trace[1373724829] 'compare' (duration: 35.165648ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:11:14.433005Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2920} {"level":"info","ts":"2026-08-28T06:11:14.513771Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2920,"took":"78.874595ms","hash":1022599372,"current-db-size-bytes":53186560,"current-db-size":"53 MB","current-db-size-in-use-bytes":27824128,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-28T06:11:14.513824Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1022599372,"revision":2920,"compact-revision":-1} {"level":"info","ts":"2026-08-28T06:11:32.958485Z","caller":"traceutil/trace.go:171","msg":"trace[1867404422] transaction","detail":"{read_only:false; response_revision:5602; number_of_response:1; }","duration":"134.626831ms","start":"2026-08-28T06:11:32.823826Z","end":"2026-08-28T06:11:32.958452Z","steps":["trace[1867404422] 'process raft request' (duration: 121.618413ms)","trace[1867404422] 'compare' (duration: 12.494504ms)"],"step_count":2} {"level":"info","ts":"2026-08-28T06:16:14.441015Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5405} {"level":"info","ts":"2026-08-28T06:16:14.517879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5405,"took":"75.763051ms","hash":3609703836,"current-db-size-bytes":53186560,"current-db-size":"53 MB","current-db-size-in-use-bytes":18841600,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-28T06:16:14.517944Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3609703836,"revision":5405,"compact-revision":2920} {"level":"info","ts":"2026-08-28T06:21:14.448437Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7451} {"level":"info","ts":"2026-08-28T06:21:14.517846Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7451,"took":"67.630198ms","hash":664144315,"current-db-size-bytes":53186560,"current-db-size":"53 MB","current-db-size-in-use-bytes":15503360,"current-db-size-in-use":"16 MB"} {"level":"info","ts":"2026-08-28T06:21:14.517937Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":664144315,"revision":7451,"compact-revision":5405}