{"level":"warn","ts":"2026-10-03T05:46:08.470283Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T05:46:08.471356Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.212: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.212:2380","--initial-cluster=instance=https://162.253.55.212:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.212:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.212:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-03T05:46:08.471444Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-03T05:46:08.471458Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.212:2380"]} {"level":"info","ts":"2026-10-03T05:46:08.471479Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-03T05:46:08.472684Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"]} {"level":"info","ts":"2026-10-03T05:46:08.472769Z","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.212:2380"],"listen-peer-urls":["https://162.253.55.212:2380"],"advertise-client-urls":["https://162.253.55.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.212:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-03T05:46:08.481949Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.943703ms"} {"level":"info","ts":"2026-10-03T05:46:08.492919Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d078b1e39c21939c","cluster-id":"cdc9ba8de57e3589"} {"level":"info","ts":"2026-10-03T05:46:08.492996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=()"} {"level":"info","ts":"2026-10-03T05:46:08.49302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became follower at term 0"} {"level":"info","ts":"2026-10-03T05:46:08.493049Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d078b1e39c21939c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-03T05:46:08.493057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became follower at term 1"} {"level":"info","ts":"2026-10-03T05:46:08.493103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=(15021952148229428124)"} {"level":"warn","ts":"2026-10-03T05:46:08.505713Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-03T05:46:08.507036Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-03T05:46:08.508297Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-03T05:46:08.510532Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d078b1e39c21939c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-03T05:46:08.510898Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d078b1e39c21939c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-03T05:46:08.510747Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T05:46:08.511029Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T05:46:08.51104Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-03T05:46:08.512489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c switched to configuration voters=(15021952148229428124)"} {"level":"info","ts":"2026-10-03T05:46:08.512755Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdc9ba8de57e3589","local-member-id":"d078b1e39c21939c","added-peer-id":"d078b1e39c21939c","added-peer-peer-urls":["https://162.253.55.212:2380"]} {"level":"info","ts":"2026-10-03T05:46:08.514866Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-03T05:46:08.51501Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.212:2380"} {"level":"info","ts":"2026-10-03T05:46:08.515093Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.212:2380"} {"level":"info","ts":"2026-10-03T05:46:08.515166Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d078b1e39c21939c","initial-advertise-peer-urls":["https://162.253.55.212:2380"],"listen-peer-urls":["https://162.253.55.212:2380"],"advertise-client-urls":["https://162.253.55.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-03T05:46:08.515258Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-03T05:46:09.393734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c is starting a new election at term 1"} {"level":"info","ts":"2026-10-03T05:46:09.39383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became pre-candidate at term 1"} {"level":"info","ts":"2026-10-03T05:46:09.393864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c received MsgPreVoteResp from d078b1e39c21939c at term 1"} {"level":"info","ts":"2026-10-03T05:46:09.393889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became candidate at term 2"} {"level":"info","ts":"2026-10-03T05:46:09.3939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c received MsgVoteResp from d078b1e39c21939c at term 2"} {"level":"info","ts":"2026-10-03T05:46:09.393924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d078b1e39c21939c became leader at term 2"} {"level":"info","ts":"2026-10-03T05:46:09.393944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d078b1e39c21939c elected leader d078b1e39c21939c at term 2"} {"level":"info","ts":"2026-10-03T05:46:09.39511Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d078b1e39c21939c","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.212:2379]}","request-path":"/0/members/d078b1e39c21939c/attributes","cluster-id":"cdc9ba8de57e3589","publish-timeout":"7s"} {"level":"info","ts":"2026-10-03T05:46:09.395137Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T05:46:09.395483Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T05:46:09.395638Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:46:09.39608Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-03T05:46:09.39627Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-03T05:46:09.396571Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdc9ba8de57e3589","local-member-id":"d078b1e39c21939c","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:46:09.396663Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:46:09.396693Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:46:09.398407Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.212:2379"} {"level":"info","ts":"2026-10-03T05:46:09.398924Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-03T05:46:12.003892Z","caller":"traceutil/trace.go:171","msg":"trace[693494195] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"103.686918ms","start":"2026-10-03T05:46:11.900169Z","end":"2026-10-03T05:46:12.003856Z","steps":["trace[693494195] 'read index received' (duration: 103.389879ms)","trace[693494195] 'applied index is now lower than readState.Index' (duration: 295.419µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:46:12.004036Z","caller":"traceutil/trace.go:171","msg":"trace[816569233] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"105.968156ms","start":"2026-10-03T05:46:11.898016Z","end":"2026-10-03T05:46:12.003984Z","steps":["trace[816569233] 'process raft request' (duration: 105.630126ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:12.004268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.019349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-03T05:46:12.00437Z","caller":"traceutil/trace.go:171","msg":"trace[1191076449] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:72; }","duration":"104.203674ms","start":"2026-10-03T05:46:11.900148Z","end":"2026-10-03T05:46:12.004352Z","steps":["trace[1191076449] 'agreement among raft nodes before linearized reading' (duration: 103.938176ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:12.384913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.112372ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-10-03T05:46:12.385071Z","caller":"traceutil/trace.go:171","msg":"trace[313231388] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"375.231484ms","start":"2026-10-03T05:46:12.009815Z","end":"2026-10-03T05:46:12.385047Z","steps":["trace[313231388] 'read index received' (duration: 179.197076ms)","trace[313231388] 'applied index is now lower than readState.Index' (duration: 196.032748ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:46:12.38517Z","caller":"traceutil/trace.go:171","msg":"trace[172303294] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"376.213384ms","start":"2026-10-03T05:46:12.008911Z","end":"2026-10-03T05:46:12.385125Z","steps":["trace[172303294] 'process raft request' (duration: 180.164234ms)","trace[172303294] 'compare' (duration: 194.822264ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:46:12.385384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.512452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-03T05:46:12.385423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:12.00889Z","time spent":"376.403969ms","remote":"127.0.0.1:57114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:46:12.38551Z","caller":"traceutil/trace.go:171","msg":"trace[83358220] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:0; response_revision:73; }","duration":"375.706799ms","start":"2026-10-03T05:46:12.009786Z","end":"2026-10-03T05:46:12.385493Z","steps":["trace[83358220] 'agreement among raft nodes before linearized reading' (duration: 375.324527ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:12.385618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:12.009774Z","time spent":"375.826612ms","remote":"127.0.0.1:57092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/admin\" "} {"level":"info","ts":"2026-10-03T05:46:15.385494Z","caller":"traceutil/trace.go:171","msg":"trace[1371787234] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"110.113252ms","start":"2026-10-03T05:46:15.275336Z","end":"2026-10-03T05:46:15.385449Z","steps":["trace[1371787234] 'process raft request' (duration: 89.806664ms)","trace[1371787234] 'compare' (duration: 20.01936ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:46:47.574761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.664918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:46:47.574827Z","caller":"traceutil/trace.go:171","msg":"trace[1575692727] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:525; }","duration":"132.782571ms","start":"2026-10-03T05:46:47.442029Z","end":"2026-10-03T05:46:47.574812Z","steps":["trace[1575692727] 'range keys from in-memory index tree' (duration: 132.585146ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:49.158909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.393809ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:46:49.159071Z","caller":"traceutil/trace.go:171","msg":"trace[950887016] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"394.941055ms","start":"2026-10-03T05:46:48.764113Z","end":"2026-10-03T05:46:49.159054Z","steps":["trace[950887016] 'process raft request' (duration: 42.345101ms)","trace[950887016] 'compare' (duration: 352.263918ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:46:49.159119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:48.764092Z","time spent":"395.006546ms","remote":"127.0.0.1:56806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-03T05:46:49.230679Z","caller":"traceutil/trace.go:171","msg":"trace[349711020] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"378.231057ms","start":"2026-10-03T05:46:48.852404Z","end":"2026-10-03T05:46:49.230635Z","steps":["trace[349711020] 'process raft request' (duration: 373.070315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:49.230866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.790374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-03T05:46:49.230964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:48.852375Z","time spent":"378.37849ms","remote":"127.0.0.1:56806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:46:49.230984Z","caller":"traceutil/trace.go:171","msg":"trace[185360238] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:596; }","duration":"320.942688ms","start":"2026-10-03T05:46:48.910023Z","end":"2026-10-03T05:46:49.230965Z","steps":["trace[185360238] 'agreement among raft nodes before linearized reading' (duration: 320.679732ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:49.231105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:48.910007Z","time spent":"321.083121ms","remote":"127.0.0.1:57970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-10-03T05:46:49.231812Z","caller":"traceutil/trace.go:171","msg":"trace[1038953960] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"321.664562ms","start":"2026-10-03T05:46:48.910052Z","end":"2026-10-03T05:46:49.231716Z","steps":["trace[1038953960] 'read index received' (duration: 314.859165ms)","trace[1038953960] 'applied index is now lower than readState.Index' (duration: 5.209033ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:46:49.232002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.840186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:46:49.232038Z","caller":"traceutil/trace.go:171","msg":"trace[1419078090] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:596; }","duration":"321.944218ms","start":"2026-10-03T05:46:48.910081Z","end":"2026-10-03T05:46:49.232026Z","steps":["trace[1419078090] 'agreement among raft nodes before linearized reading' (duration: 321.859566ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:49.232072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:48.910042Z","time spent":"322.01968ms","remote":"127.0.0.1:57970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-10-03T05:46:49.232447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.327234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:46:49.232485Z","caller":"traceutil/trace.go:171","msg":"trace[1622640778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"112.387446ms","start":"2026-10-03T05:46:49.120086Z","end":"2026-10-03T05:46:49.232473Z","steps":["trace[1622640778] 'agreement among raft nodes before linearized reading' (duration: 112.337475ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:49.232623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.495514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:46:49.232657Z","caller":"traceutil/trace.go:171","msg":"trace[968659925] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:596; }","duration":"137.563906ms","start":"2026-10-03T05:46:49.095084Z","end":"2026-10-03T05:46:49.232648Z","steps":["trace[968659925] 'agreement among raft nodes before linearized reading' (duration: 137.513105ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:49.2328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.732099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:46:49.232831Z","caller":"traceutil/trace.go:171","msg":"trace[638890328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:596; }","duration":"137.788541ms","start":"2026-10-03T05:46:49.095034Z","end":"2026-10-03T05:46:49.232823Z","steps":["trace[638890328] 'agreement among raft nodes before linearized reading' (duration: 137.74227ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:49.232939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.286806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:46:49.232971Z","caller":"traceutil/trace.go:171","msg":"trace[397765269] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:596; }","duration":"322.343887ms","start":"2026-10-03T05:46:48.910619Z","end":"2026-10-03T05:46:49.232963Z","steps":["trace[397765269] 'agreement among raft nodes before linearized reading' (duration: 322.299756ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:46:49.232998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:46:48.910611Z","time spent":"322.378508ms","remote":"127.0.0.1:57970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-10-03T05:46:54.063383Z","caller":"traceutil/trace.go:171","msg":"trace[1339677217] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"236.507144ms","start":"2026-10-03T05:46:53.826814Z","end":"2026-10-03T05:46:54.063321Z","steps":["trace[1339677217] 'process raft request' (duration: 234.197384ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:46:54.774643Z","caller":"traceutil/trace.go:171","msg":"trace[538471952] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"234.234781ms","start":"2026-10-03T05:46:54.540381Z","end":"2026-10-03T05:46:54.774615Z","steps":["trace[538471952] 'process raft request' (duration: 233.976475ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:46:54.797928Z","caller":"traceutil/trace.go:171","msg":"trace[1495068412] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"199.23214ms","start":"2026-10-03T05:46:54.598662Z","end":"2026-10-03T05:46:54.797894Z","steps":["trace[1495068412] 'process raft request' (duration: 196.37131ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:47:08.821638Z","caller":"traceutil/trace.go:171","msg":"trace[396054157] linearizableReadLoop","detail":"{readStateIndex:822; appliedIndex:821; }","duration":"133.526871ms","start":"2026-10-03T05:47:08.688087Z","end":"2026-10-03T05:47:08.821614Z","steps":["trace[396054157] 'read index received' (duration: 133.332697ms)","trace[396054157] 'applied index is now lower than readState.Index' (duration: 193.294µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:47:08.821757Z","caller":"traceutil/trace.go:171","msg":"trace[275022593] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"134.46777ms","start":"2026-10-03T05:47:08.687259Z","end":"2026-10-03T05:47:08.821727Z","steps":["trace[275022593] 'process raft request' (duration: 134.218285ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:47:08.822072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.957629ms","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-10-03T05:47:08.822163Z","caller":"traceutil/trace.go:171","msg":"trace[912316034] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:787; }","duration":"134.112562ms","start":"2026-10-03T05:47:08.688039Z","end":"2026-10-03T05:47:08.822152Z","steps":["trace[912316034] 'agreement among raft nodes before linearized reading' (duration: 133.681814ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:47:12.28228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.887605ms","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-10-03T05:47:12.282384Z","caller":"traceutil/trace.go:171","msg":"trace[1108160442] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"353.061387ms","start":"2026-10-03T05:47:11.9293Z","end":"2026-10-03T05:47:12.282361Z","steps":["trace[1108160442] 'range keys from in-memory index tree' (duration: 352.601689ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:47:12.282429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:47:11.929277Z","time spent":"353.142449ms","remote":"127.0.0.1:57018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-03T05:48:08.140221Z","caller":"traceutil/trace.go:171","msg":"trace[1391464963] transaction","detail":"{read_only:false; response_revision:1477; number_of_response:1; }","duration":"123.289224ms","start":"2026-10-03T05:48:08.016911Z","end":"2026-10-03T05:48:08.1402Z","steps":["trace[1391464963] 'process raft request' (duration: 122.948119ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:48:34.844379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.738038ms","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-10-03T05:48:34.844621Z","caller":"traceutil/trace.go:171","msg":"trace[500113363] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1895; }","duration":"185.992602ms","start":"2026-10-03T05:48:34.658604Z","end":"2026-10-03T05:48:34.844597Z","steps":["trace[500113363] 'range keys from in-memory index tree' (duration: 185.695337ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:48:34.844793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.209823ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:48:34.845111Z","caller":"traceutil/trace.go:171","msg":"trace[2096097796] transaction","detail":"{read_only:false; response_revision:1896; number_of_response:1; }","duration":"474.179057ms","start":"2026-10-03T05:48:34.370905Z","end":"2026-10-03T05:48:34.845084Z","steps":["trace[2096097796] 'process raft request' (duration: 178.545357ms)","trace[2096097796] 'compare' (duration: 295.021301ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:48:34.845207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:48:34.370867Z","time spent":"474.288578ms","remote":"127.0.0.1:57018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:48:34.906405Z","caller":"traceutil/trace.go:171","msg":"trace[1635659964] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"181.285555ms","start":"2026-10-03T05:48:34.725059Z","end":"2026-10-03T05:48:34.906345Z","steps":["trace[1635659964] 'process raft request' (duration: 181.042421ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:48:35.291747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.103203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1ed08450-3c3d-4b18-ae03-fec69b1be619\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-10-03T05:48:35.292002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.02594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:48:35.292129Z","caller":"traceutil/trace.go:171","msg":"trace[1450601504] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1898; }","duration":"170.206173ms","start":"2026-10-03T05:48:35.121897Z","end":"2026-10-03T05:48:35.292103Z","steps":["trace[1450601504] 'range keys from in-memory index tree' (duration: 169.885118ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:48:35.291875Z","caller":"traceutil/trace.go:171","msg":"trace[640435585] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1ed08450-3c3d-4b18-ae03-fec69b1be619; range_end:; response_count:1; response_revision:1898; }","duration":"206.295735ms","start":"2026-10-03T05:48:35.085553Z","end":"2026-10-03T05:48:35.291849Z","steps":["trace[640435585] 'range keys from in-memory index tree' (duration: 205.882799ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:48:35.292294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.054199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-10-03T05:48:35.292419Z","caller":"traceutil/trace.go:171","msg":"trace[475201313] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1898; }","duration":"342.200492ms","start":"2026-10-03T05:48:34.9502Z","end":"2026-10-03T05:48:35.2924Z","steps":["trace[475201313] 'range keys from in-memory index tree' (duration: 341.764296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:48:35.29253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:48:34.950189Z","time spent":"342.308994ms","remote":"127.0.0.1:57018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":554,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-10-03T05:48:47.58722Z","caller":"traceutil/trace.go:171","msg":"trace[668844041] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"101.323566ms","start":"2026-10-03T05:48:47.485823Z","end":"2026-10-03T05:48:47.587146Z","steps":["trace[668844041] 'process raft request' (duration: 101.009511ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:48:47.992697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.283188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:48:47.992978Z","caller":"traceutil/trace.go:171","msg":"trace[1360814870] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"401.282926ms","start":"2026-10-03T05:48:47.59166Z","end":"2026-10-03T05:48:47.992943Z","steps":["trace[1360814870] 'process raft request' (duration: 262.599992ms)","trace[1360814870] 'compare' (duration: 138.104826ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:48:47.993008Z","caller":"traceutil/trace.go:171","msg":"trace[785262949] transaction","detail":"{read_only:false; response_revision:2002; number_of_response:1; }","duration":"187.978227ms","start":"2026-10-03T05:48:47.80501Z","end":"2026-10-03T05:48:47.992988Z","steps":["trace[785262949] 'process raft request' (duration: 187.866426ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:48:47.993032Z","caller":"traceutil/trace.go:171","msg":"trace[248737565] linearizableReadLoop","detail":"{readStateIndex:2084; appliedIndex:2083; }","duration":"394.225339ms","start":"2026-10-03T05:48:47.598787Z","end":"2026-10-03T05:48:47.993012Z","steps":["trace[248737565] 'read index received' (duration: 255.461644ms)","trace[248737565] 'applied index is now lower than readState.Index' (duration: 138.761875ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:48:47.993148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:48:47.591634Z","time spent":"401.415698ms","remote":"127.0.0.1:57018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T05:48:47.993239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.418041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:48:47.993383Z","caller":"traceutil/trace.go:171","msg":"trace[586139783] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2002; }","duration":"394.602753ms","start":"2026-10-03T05:48:47.598749Z","end":"2026-10-03T05:48:47.993352Z","steps":["trace[586139783] 'agreement among raft nodes before linearized reading' (duration: 394.35325ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:48:47.993439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:48:47.598729Z","time spent":"394.699605ms","remote":"127.0.0.1:57194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-10-03T05:48:48.070003Z","caller":"traceutil/trace.go:171","msg":"trace[2037969604] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"147.896889ms","start":"2026-10-03T05:48:47.922076Z","end":"2026-10-03T05:48:48.069973Z","steps":["trace[2037969604] 'process raft request' (duration: 147.568125ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:48:48.070482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.606843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-10-03T05:48:48.070537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.287229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-03T05:48:48.070602Z","caller":"traceutil/trace.go:171","msg":"trace[1231011922] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2003; }","duration":"211.763075ms","start":"2026-10-03T05:48:47.858775Z","end":"2026-10-03T05:48:48.070538Z","steps":["trace[1231011922] 'agreement among raft nodes before linearized reading' (duration: 211.519192ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:48:48.070652Z","caller":"traceutil/trace.go:171","msg":"trace[1398359867] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2003; }","duration":"167.485092ms","start":"2026-10-03T05:48:47.903143Z","end":"2026-10-03T05:48:48.070628Z","steps":["trace[1398359867] 'agreement among raft nodes before linearized reading' (duration: 167.165157ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:48:51.731828Z","caller":"traceutil/trace.go:171","msg":"trace[180562948] linearizableReadLoop","detail":"{readStateIndex:2116; appliedIndex:2115; }","duration":"197.549392ms","start":"2026-10-03T05:48:51.534251Z","end":"2026-10-03T05:48:51.7318Z","steps":["trace[180562948] 'read index received' (duration: 197.38679ms)","trace[180562948] 'applied index is now lower than readState.Index' (duration: 161.202µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:48:51.732024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.705434ms","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-10-03T05:48:51.732116Z","caller":"traceutil/trace.go:171","msg":"trace[403726942] 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:2032; }","duration":"197.896037ms","start":"2026-10-03T05:48:51.534163Z","end":"2026-10-03T05:48:51.732059Z","steps":["trace[403726942] 'agreement among raft nodes before linearized reading' (duration: 197.742215ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:48:51.73228Z","caller":"traceutil/trace.go:171","msg":"trace[1159964271] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"292.261278ms","start":"2026-10-03T05:48:51.439987Z","end":"2026-10-03T05:48:51.732248Z","steps":["trace[1159964271] 'process raft request' (duration: 291.508017ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:48:51.761728Z","caller":"traceutil/trace.go:171","msg":"trace[964233753] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"159.754342ms","start":"2026-10-03T05:48:51.601937Z","end":"2026-10-03T05:48:51.761692Z","steps":["trace[964233753] 'process raft request' (duration: 159.562909ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:14.247318Z","caller":"traceutil/trace.go:171","msg":"trace[1604395020] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"150.047454ms","start":"2026-10-03T05:49:14.097202Z","end":"2026-10-03T05:49:14.24725Z","steps":["trace[1604395020] 'process raft request' (duration: 147.348778ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:14.886086Z","caller":"traceutil/trace.go:171","msg":"trace[211628979] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"211.660498ms","start":"2026-10-03T05:49:14.674393Z","end":"2026-10-03T05:49:14.886053Z","steps":["trace[211628979] 'process raft request' (duration: 211.452065ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:15.117477Z","caller":"traceutil/trace.go:171","msg":"trace[1145368247] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"113.234061ms","start":"2026-10-03T05:49:15.004214Z","end":"2026-10-03T05:49:15.117448Z","steps":["trace[1145368247] 'process raft request' (duration: 112.969318ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:49:15.493966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.53281ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:49:15.494076Z","caller":"traceutil/trace.go:171","msg":"trace[254401365] linearizableReadLoop","detail":"{readStateIndex:2252; appliedIndex:2251; }","duration":"206.639417ms","start":"2026-10-03T05:49:15.28742Z","end":"2026-10-03T05:49:15.494059Z","steps":["trace[254401365] 'read index received' (duration: 62.27µs)","trace[254401365] 'applied index is now lower than readState.Index' (duration: 206.575367ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:49:15.494339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.924942ms","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-10-03T05:49:15.494368Z","caller":"traceutil/trace.go:171","msg":"trace[1243414826] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2163; }","duration":"206.995122ms","start":"2026-10-03T05:49:15.287362Z","end":"2026-10-03T05:49:15.494358Z","steps":["trace[1243414826] 'agreement among raft nodes before linearized reading' (duration: 206.740819ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:15.494458Z","caller":"traceutil/trace.go:171","msg":"trace[1391841356] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"316.599286ms","start":"2026-10-03T05:49:15.177808Z","end":"2026-10-03T05:49:15.494407Z","steps":["trace[1391841356] 'process raft request' (duration: 27.533558ms)","trace[1391841356] 'compare' (duration: 287.495047ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:49:15.494544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:49:15.177778Z","time spent":"316.716147ms","remote":"127.0.0.1:57018","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:49:16.008977Z","caller":"traceutil/trace.go:171","msg":"trace[1222880725] linearizableReadLoop","detail":"{readStateIndex:2254; appliedIndex:2253; }","duration":"120.991965ms","start":"2026-10-03T05:49:15.887958Z","end":"2026-10-03T05:49:16.00895Z","steps":["trace[1222880725] 'read index received' (duration: 120.445667ms)","trace[1222880725] 'applied index is now lower than readState.Index' (duration: 544.768µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:49:16.009198Z","caller":"traceutil/trace.go:171","msg":"trace[614930753] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"132.270686ms","start":"2026-10-03T05:49:15.876895Z","end":"2026-10-03T05:49:16.009165Z","steps":["trace[614930753] 'process raft request' (duration: 131.678148ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:49:16.009355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.38335ms","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-10-03T05:49:16.009722Z","caller":"traceutil/trace.go:171","msg":"trace[1172774275] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2165; }","duration":"121.722785ms","start":"2026-10-03T05:49:15.887887Z","end":"2026-10-03T05:49:16.00961Z","steps":["trace[1172774275] 'agreement among raft nodes before linearized reading' (duration: 121.276989ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:50:46.582212Z","caller":"traceutil/trace.go:171","msg":"trace[2057763353] transaction","detail":"{read_only:false; response_revision:2747; number_of_response:1; }","duration":"219.692037ms","start":"2026-10-03T05:50:46.362471Z","end":"2026-10-03T05:50:46.582163Z","steps":["trace[2057763353] 'process raft request' (duration: 219.4422ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:51:18.312136Z","caller":"traceutil/trace.go:171","msg":"trace[136614653] transaction","detail":"{read_only:false; response_revision:2924; number_of_response:1; }","duration":"114.991442ms","start":"2026-10-03T05:51:18.19711Z","end":"2026-10-03T05:51:18.312102Z","steps":["trace[136614653] 'process raft request' (duration: 114.834438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:51:23.812576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.145875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:51:23.812715Z","caller":"traceutil/trace.go:171","msg":"trace[488202312] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:2956; }","duration":"152.364271ms","start":"2026-10-03T05:51:23.660322Z","end":"2026-10-03T05:51:23.812686Z","steps":["trace[488202312] 'count revisions from in-memory index tree' (duration: 151.919749ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:51:23.813063Z","caller":"traceutil/trace.go:171","msg":"trace[1320676260] transaction","detail":"{read_only:false; response_revision:2957; number_of_response:1; }","duration":"148.462499ms","start":"2026-10-03T05:51:23.664563Z","end":"2026-10-03T05:51:23.813025Z","steps":["trace[1320676260] 'process raft request' (duration: 137.540807ms)","trace[1320676260] 'compare' (duration: 10.471411ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:55:36.933982Z","caller":"traceutil/trace.go:171","msg":"trace[1479637562] transaction","detail":"{read_only:false; response_revision:4452; number_of_response:1; }","duration":"168.001845ms","start":"2026-10-03T05:55:36.765943Z","end":"2026-10-03T05:55:36.933945Z","steps":["trace[1479637562] 'process raft request' (duration: 133.072723ms)","trace[1479637562] 'compare' (duration: 34.409883ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:55:50.903837Z","caller":"traceutil/trace.go:171","msg":"trace[685436742] linearizableReadLoop","detail":"{readStateIndex:5142; appliedIndex:5141; }","duration":"100.234563ms","start":"2026-10-03T05:55:50.803576Z","end":"2026-10-03T05:55:50.903811Z","steps":["trace[685436742] 'read index received' (duration: 100.094021ms)","trace[685436742] 'applied index is now lower than readState.Index' (duration: 139.312µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:55:50.904065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.467026ms","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-10-03T05:55:50.9041Z","caller":"traceutil/trace.go:171","msg":"trace[497402752] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4946; }","duration":"100.538097ms","start":"2026-10-03T05:55:50.803549Z","end":"2026-10-03T05:55:50.904087Z","steps":["trace[497402752] 'agreement among raft nodes before linearized reading' (duration: 100.359115ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:55:50.904508Z","caller":"traceutil/trace.go:171","msg":"trace[1989644955] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"110.531864ms","start":"2026-10-03T05:55:50.793965Z","end":"2026-10-03T05:55:50.904496Z","steps":["trace[1989644955] 'process raft request' (duration: 109.400656ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:55:54.460171Z","caller":"traceutil/trace.go:171","msg":"trace[1175473000] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"130.056357ms","start":"2026-10-03T05:55:54.33009Z","end":"2026-10-03T05:55:54.460146Z","steps":["trace[1175473000] 'process raft request' (duration: 90.725788ms)","trace[1175473000] 'compare' (duration: 39.220397ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:56:00.606178Z","caller":"traceutil/trace.go:171","msg":"trace[76708766] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"217.837555ms","start":"2026-10-03T05:56:00.388323Z","end":"2026-10-03T05:56:00.606161Z","steps":["trace[76708766] 'process raft request' (duration: 217.733833ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:56:00.606205Z","caller":"traceutil/trace.go:171","msg":"trace[423649551] linearizableReadLoop","detail":"{readStateIndex:5313; appliedIndex:5313; }","duration":"193.963627ms","start":"2026-10-03T05:56:00.412219Z","end":"2026-10-03T05:56:00.606183Z","steps":["trace[423649551] 'read index received' (duration: 193.955837ms)","trace[423649551] 'applied index is now lower than readState.Index' (duration: 6.43µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:56:00.606384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.14801ms","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-10-03T05:56:00.606423Z","caller":"traceutil/trace.go:171","msg":"trace[481028799] 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:5110; }","duration":"194.223692ms","start":"2026-10-03T05:56:00.412189Z","end":"2026-10-03T05:56:00.606413Z","steps":["trace[481028799] 'agreement among raft nodes before linearized reading' (duration: 194.08363ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:56:00.633374Z","caller":"traceutil/trace.go:171","msg":"trace[1266268934] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"167.242861ms","start":"2026-10-03T05:56:00.466116Z","end":"2026-10-03T05:56:00.633358Z","steps":["trace[1266268934] 'process raft request' (duration: 167.131409ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:56:00.633673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.300613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-03T05:56:00.633699Z","caller":"traceutil/trace.go:171","msg":"trace[1214143426] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5111; }","duration":"215.347534ms","start":"2026-10-03T05:56:00.418346Z","end":"2026-10-03T05:56:00.633693Z","steps":["trace[1214143426] 'agreement among raft nodes before linearized reading' (duration: 215.287013ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:56:01.131514Z","caller":"traceutil/trace.go:171","msg":"trace[1077981886] transaction","detail":"{read_only:false; response_revision:5121; number_of_response:1; }","duration":"157.820271ms","start":"2026-10-03T05:56:00.973658Z","end":"2026-10-03T05:56:01.131478Z","steps":["trace[1077981886] 'process raft request' (duration: 128.375421ms)","trace[1077981886] 'compare' (duration: 29.327108ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:56:05.570509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.706792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6d690408-a839-4fb6-892b-d41dd57691dd\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-03T05:56:05.570612Z","caller":"traceutil/trace.go:171","msg":"trace[724288406] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6d690408-a839-4fb6-892b-d41dd57691dd; range_end:; response_count:1; response_revision:5237; }","duration":"131.859915ms","start":"2026-10-03T05:56:05.438732Z","end":"2026-10-03T05:56:05.570592Z","steps":["trace[724288406] 'range keys from in-memory index tree' (duration: 131.487758ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:56:05.727144Z","caller":"traceutil/trace.go:171","msg":"trace[1347846428] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"162.557736ms","start":"2026-10-03T05:56:05.564562Z","end":"2026-10-03T05:56:05.727119Z","steps":["trace[1347846428] 'process raft request' (duration: 162.443694ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:56:05.733138Z","caller":"traceutil/trace.go:171","msg":"trace[97279003] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"155.03729ms","start":"2026-10-03T05:56:05.578067Z","end":"2026-10-03T05:56:05.733104Z","steps":["trace[97279003] 'process raft request' (duration: 154.063525ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:56:09.428947Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2880} {"level":"info","ts":"2026-10-03T05:56:09.520091Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2880,"took":"89.802552ms","hash":4054276002,"current-db-size-bytes":51326976,"current-db-size":"51 MB","current-db-size-in-use-bytes":27176960,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-03T05:56:09.520153Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4054276002,"revision":2880,"compact-revision":-1} {"level":"info","ts":"2026-10-03T05:57:13.157647Z","caller":"traceutil/trace.go:171","msg":"trace[1470996443] transaction","detail":"{read_only:false; response_revision:5814; number_of_response:1; }","duration":"105.406175ms","start":"2026-10-03T05:57:13.05221Z","end":"2026-10-03T05:57:13.157616Z","steps":["trace[1470996443] 'process raft request' (duration: 105.149201ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T06:00:02.485535Z","caller":"traceutil/trace.go:171","msg":"trace[1143798981] transaction","detail":"{read_only:false; response_revision:6990; number_of_response:1; }","duration":"102.589752ms","start":"2026-10-03T06:00:02.382918Z","end":"2026-10-03T06:00:02.485508Z","steps":["trace[1143798981] 'process raft request' (duration: 102.392126ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T06:00:20.294343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.034422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T06:00:20.294474Z","caller":"traceutil/trace.go:171","msg":"trace[345150574] transaction","detail":"{read_only:false; response_revision:7137; number_of_response:1; }","duration":"116.275178ms","start":"2026-10-03T06:00:20.178189Z","end":"2026-10-03T06:00:20.294464Z","steps":["trace[345150574] 'process raft request' (duration: 116.213376ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T06:00:20.294508Z","caller":"traceutil/trace.go:171","msg":"trace[1567813198] transaction","detail":"{read_only:false; response_revision:7136; number_of_response:1; }","duration":"216.770173ms","start":"2026-10-03T06:00:20.077724Z","end":"2026-10-03T06:00:20.294494Z","steps":["trace[1567813198] 'process raft request' (duration: 85.526604ms)","trace[1567813198] 'compare' (duration: 130.842807ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T06:01:09.434962Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5303} {"level":"info","ts":"2026-10-03T06:01:09.539525Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5303,"took":"102.071088ms","hash":946438230,"current-db-size-bytes":51326976,"current-db-size":"51 MB","current-db-size-in-use-bytes":19197952,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-03T06:01:09.539646Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":946438230,"revision":5303,"compact-revision":2880}