{"level":"warn","ts":"2026-10-03T05:40:17.869061Z","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:40:17.869147Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.54: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.54:2380","--initial-cluster=instance=https://162.253.55.54:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.54:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.54: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:40:17.869209Z","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:40:17.869241Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.54:2380"]} {"level":"info","ts":"2026-10-03T05:40:17.869258Z","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:40:17.8699Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"]} {"level":"info","ts":"2026-10-03T05:40:17.869975Z","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.54:2380"],"listen-peer-urls":["https://162.253.55.54:2380"],"advertise-client-urls":["https://162.253.55.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.54: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:40:17.875126Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.934882ms"} {"level":"info","ts":"2026-10-03T05:40:17.884846Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"353030364a385dbf","cluster-id":"1e619908a4cffd8f"} {"level":"info","ts":"2026-10-03T05:40:17.88491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=()"} {"level":"info","ts":"2026-10-03T05:40:17.884928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became follower at term 0"} {"level":"info","ts":"2026-10-03T05:40:17.884939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 353030364a385dbf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-03T05:40:17.884946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became follower at term 1"} {"level":"info","ts":"2026-10-03T05:40:17.884977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=(3832616292623867327)"} {"level":"warn","ts":"2026-10-03T05:40:17.89169Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-03T05:40:17.893355Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-03T05:40:17.894636Z","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:40:17.896482Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"353030364a385dbf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-03T05:40:17.89739Z","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:40:17.89746Z","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:40:17.897468Z","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:40:17.898765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf switched to configuration voters=(3832616292623867327)"} {"level":"info","ts":"2026-10-03T05:40:17.898671Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"353030364a385dbf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-03T05:40:17.898925Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"1e619908a4cffd8f","local-member-id":"353030364a385dbf","added-peer-id":"353030364a385dbf","added-peer-peer-urls":["https://162.253.55.54:2380"]} {"level":"info","ts":"2026-10-03T05:40:17.901435Z","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:40:17.901625Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"353030364a385dbf","initial-advertise-peer-urls":["https://162.253.55.54:2380"],"listen-peer-urls":["https://162.253.55.54:2380"],"advertise-client-urls":["https://162.253.55.54:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.54:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-03T05:40:17.901698Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-03T05:40:17.90222Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.54:2380"} {"level":"info","ts":"2026-10-03T05:40:17.902243Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.54:2380"} {"level":"info","ts":"2026-10-03T05:40:18.085429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf is starting a new election at term 1"} {"level":"info","ts":"2026-10-03T05:40:18.085508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became pre-candidate at term 1"} {"level":"info","ts":"2026-10-03T05:40:18.085549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf received MsgPreVoteResp from 353030364a385dbf at term 1"} {"level":"info","ts":"2026-10-03T05:40:18.085572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became candidate at term 2"} {"level":"info","ts":"2026-10-03T05:40:18.085588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf received MsgVoteResp from 353030364a385dbf at term 2"} {"level":"info","ts":"2026-10-03T05:40:18.085615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"353030364a385dbf became leader at term 2"} {"level":"info","ts":"2026-10-03T05:40:18.085634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 353030364a385dbf elected leader 353030364a385dbf at term 2"} {"level":"info","ts":"2026-10-03T05:40:18.086927Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"353030364a385dbf","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.54:2379]}","request-path":"/0/members/353030364a385dbf/attributes","cluster-id":"1e619908a4cffd8f","publish-timeout":"7s"} {"level":"info","ts":"2026-10-03T05:40:18.08713Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T05:40:18.087286Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:40:18.087241Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-03T05:40:18.088785Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-03T05:40:18.088864Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-03T05:40:18.08979Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"1e619908a4cffd8f","local-member-id":"353030364a385dbf","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:40:18.089887Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:40:18.08993Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-03T05:40:18.091002Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.54:2379"} {"level":"info","ts":"2026-10-03T05:40:18.091109Z","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:40:31.908446Z","caller":"traceutil/trace.go:171","msg":"trace[231736078] linearizableReadLoop","detail":"{readStateIndex:411; appliedIndex:410; }","duration":"166.393196ms","start":"2026-10-03T05:40:31.742031Z","end":"2026-10-03T05:40:31.908424Z","steps":["trace[231736078] 'read index received' (duration: 166.216753ms)","trace[231736078] 'applied index is now lower than readState.Index' (duration: 175.573µs)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:40:31.908558Z","caller":"traceutil/trace.go:171","msg":"trace[198123804] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"214.494843ms","start":"2026-10-03T05:40:31.694035Z","end":"2026-10-03T05:40:31.90853Z","steps":["trace[198123804] 'process raft request' (duration: 214.270519ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:40:31.908767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.678871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.54\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-10-03T05:40:31.908794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.812056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:40:31.908869Z","caller":"traceutil/trace.go:171","msg":"trace[658481030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:401; }","duration":"139.939638ms","start":"2026-10-03T05:40:31.768912Z","end":"2026-10-03T05:40:31.908852Z","steps":["trace[658481030] 'agreement among raft nodes before linearized reading' (duration: 139.809856ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:40:31.90885Z","caller":"traceutil/trace.go:171","msg":"trace[2089447811] range","detail":"{range_begin:/registry/masterleases/162.253.55.54; range_end:; response_count:1; response_revision:401; }","duration":"166.833594ms","start":"2026-10-03T05:40:31.741999Z","end":"2026-10-03T05:40:31.908833Z","steps":["trace[2089447811] 'agreement among raft nodes before linearized reading' (duration: 166.626631ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:40:31.909094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.363739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-03T05:40:31.90913Z","caller":"traceutil/trace.go:171","msg":"trace[1183638584] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:401; }","duration":"133.441141ms","start":"2026-10-03T05:40:31.77568Z","end":"2026-10-03T05:40:31.909121Z","steps":["trace[1183638584] 'agreement among raft nodes before linearized reading' (duration: 133.37948ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:40:32.075595Z","caller":"traceutil/trace.go:171","msg":"trace[376101240] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"160.566309ms","start":"2026-10-03T05:40:31.915015Z","end":"2026-10-03T05:40:32.075581Z","steps":["trace[376101240] 'process raft request' (duration: 160.474577ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:41:02.807065Z","caller":"traceutil/trace.go:171","msg":"trace[1302878087] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"147.428999ms","start":"2026-10-03T05:41:02.659581Z","end":"2026-10-03T05:41:02.80701Z","steps":["trace[1302878087] 'process raft request' (duration: 142.071871ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:41:03.044301Z","caller":"traceutil/trace.go:171","msg":"trace[1612480948] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"203.677235ms","start":"2026-10-03T05:41:02.840586Z","end":"2026-10-03T05:41:03.044263Z","steps":["trace[1612480948] 'process raft request' (duration: 203.422381ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:41:03.054319Z","caller":"traceutil/trace.go:171","msg":"trace[1628682329] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"163.439632ms","start":"2026-10-03T05:41:02.890846Z","end":"2026-10-03T05:41:03.054285Z","steps":["trace[1628682329] 'process raft request' (duration: 163.29488ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:41:18.971591Z","caller":"traceutil/trace.go:171","msg":"trace[444710862] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"265.409315ms","start":"2026-10-03T05:41:18.706145Z","end":"2026-10-03T05:41:18.971554Z","steps":["trace[444710862] 'process raft request' (duration: 265.165971ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:41:18.971808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.25408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:41:18.971886Z","caller":"traceutil/trace.go:171","msg":"trace[426440501] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"201.348402ms","start":"2026-10-03T05:41:18.7705Z","end":"2026-10-03T05:41:18.971849Z","steps":["trace[426440501] 'agreement among raft nodes before linearized reading' (duration: 201.210239ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:41:18.971654Z","caller":"traceutil/trace.go:171","msg":"trace[713658768] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:823; }","duration":"201.089937ms","start":"2026-10-03T05:41:18.770533Z","end":"2026-10-03T05:41:18.971623Z","steps":["trace[713658768] 'read index received' (duration: 201.082757ms)","trace[713658768] 'applied index is now lower than readState.Index' (duration: 5.59µs)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:41:18.972588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.491742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-03T05:41:18.972796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.109682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-zfrst\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-10-03T05:41:18.972899Z","caller":"traceutil/trace.go:171","msg":"trace[162944904] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-zfrst; range_end:; response_count:1; response_revision:798; }","duration":"104.231384ms","start":"2026-10-03T05:41:18.868612Z","end":"2026-10-03T05:41:18.972843Z","steps":["trace[162944904] 'agreement among raft nodes before linearized reading' (duration: 104.062361ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:41:18.972655Z","caller":"traceutil/trace.go:171","msg":"trace[1887717923] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"162.609954ms","start":"2026-10-03T05:41:18.81003Z","end":"2026-10-03T05:41:18.97264Z","steps":["trace[1887717923] 'agreement among raft nodes before linearized reading' (duration: 162.403611ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:41:53.307437Z","caller":"traceutil/trace.go:171","msg":"trace[1374541168] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"118.514674ms","start":"2026-10-03T05:41:53.188901Z","end":"2026-10-03T05:41:53.307416Z","steps":["trace[1374541168] 'process raft request' (duration: 118.391692ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:41:53.308577Z","caller":"traceutil/trace.go:171","msg":"trace[1133258231] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"118.564834ms","start":"2026-10-03T05:41:53.189998Z","end":"2026-10-03T05:41:53.308563Z","steps":["trace[1133258231] 'process raft request' (duration: 118.29722ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:42:42.491177Z","caller":"traceutil/trace.go:171","msg":"trace[286952002] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"202.628176ms","start":"2026-10-03T05:42:42.288524Z","end":"2026-10-03T05:42:42.491152Z","steps":["trace[286952002] 'process raft request' (duration: 202.480214ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:42:42.502107Z","caller":"traceutil/trace.go:171","msg":"trace[36488256] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"111.488275ms","start":"2026-10-03T05:42:42.390593Z","end":"2026-10-03T05:42:42.502081Z","steps":["trace[36488256] 'process raft request' (duration: 111.303072ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:42:42.502266Z","caller":"traceutil/trace.go:171","msg":"trace[1661404993] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1978; }","duration":"102.61773ms","start":"2026-10-03T05:42:42.399628Z","end":"2026-10-03T05:42:42.502217Z","steps":["trace[1661404993] 'read index received' (duration: 91.353005ms)","trace[1661404993] 'applied index is now lower than readState.Index' (duration: 11.234974ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:42:42.502465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.806303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-03T05:42:42.502529Z","caller":"traceutil/trace.go:171","msg":"trace[1286456979] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1908; }","duration":"102.937675ms","start":"2026-10-03T05:42:42.399577Z","end":"2026-10-03T05:42:42.502514Z","steps":["trace[1286456979] 'agreement among raft nodes before linearized reading' (duration: 102.785563ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:42:42.802284Z","caller":"traceutil/trace.go:171","msg":"trace[703130940] transaction","detail":"{read_only:false; response_revision:1909; number_of_response:1; }","duration":"101.184036ms","start":"2026-10-03T05:42:42.701061Z","end":"2026-10-03T05:42:42.802245Z","steps":["trace[703130940] 'process raft request' (duration: 100.949283ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:42:55.865453Z","caller":"traceutil/trace.go:171","msg":"trace[1351910588] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"178.534221ms","start":"2026-10-03T05:42:55.686873Z","end":"2026-10-03T05:42:55.865408Z","steps":["trace[1351910588] 'process raft request' (duration: 171.910943ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:42:55.867907Z","caller":"traceutil/trace.go:171","msg":"trace[924271445] linearizableReadLoop","detail":"{readStateIndex:2093; appliedIndex:2091; }","duration":"133.733948ms","start":"2026-10-03T05:42:55.734137Z","end":"2026-10-03T05:42:55.867871Z","steps":["trace[924271445] 'read index received' (duration: 124.65241ms)","trace[924271445] 'applied index is now lower than readState.Index' (duration: 9.079918ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:42:55.867971Z","caller":"traceutil/trace.go:171","msg":"trace[907964178] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"180.858239ms","start":"2026-10-03T05:42:55.687087Z","end":"2026-10-03T05:42:55.867945Z","steps":["trace[907964178] 'process raft request' (duration: 180.670296ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:42:55.868121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.975742ms","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:42:55.868171Z","caller":"traceutil/trace.go:171","msg":"trace[566770340] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2018; }","duration":"134.062943ms","start":"2026-10-03T05:42:55.734094Z","end":"2026-10-03T05:42:55.868157Z","steps":["trace[566770340] 'agreement among raft nodes before linearized reading' (duration: 133.90913ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:42:55.86816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.026586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:42:55.868261Z","caller":"traceutil/trace.go:171","msg":"trace[1933899336] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2018; }","duration":"100.164629ms","start":"2026-10-03T05:42:55.768075Z","end":"2026-10-03T05:42:55.86824Z","steps":["trace[1933899336] 'agreement among raft nodes before linearized reading' (duration: 99.983406ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:42:58.896933Z","caller":"traceutil/trace.go:171","msg":"trace[881910538] transaction","detail":"{read_only:false; response_revision:2043; number_of_response:1; }","duration":"147.361041ms","start":"2026-10-03T05:42:58.749541Z","end":"2026-10-03T05:42:58.896902Z","steps":["trace[881910538] 'process raft request' (duration: 147.092286ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:43:23.222075Z","caller":"traceutil/trace.go:171","msg":"trace[1537668165] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"195.769791ms","start":"2026-10-03T05:43:23.026282Z","end":"2026-10-03T05:43:23.222052Z","steps":["trace[1537668165] 'process raft request' (duration: 195.633439ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:43:23.533107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.510357ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:43:23.53333Z","caller":"traceutil/trace.go:171","msg":"trace[926123393] linearizableReadLoop","detail":"{readStateIndex:2260; appliedIndex:2258; }","duration":"462.491083ms","start":"2026-10-03T05:43:23.07081Z","end":"2026-10-03T05:43:23.533301Z","steps":["trace[926123393] 'read index received' (duration: 151.108171ms)","trace[926123393] 'applied index is now lower than readState.Index' (duration: 311.380021ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:43:23.533382Z","caller":"traceutil/trace.go:171","msg":"trace[186882387] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"146.283003ms","start":"2026-10-03T05:43:23.387081Z","end":"2026-10-03T05:43:23.533364Z","steps":["trace[186882387] 'process raft request' (duration: 146.215881ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:43:23.533451Z","caller":"traceutil/trace.go:171","msg":"trace[543548353] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"498.977379ms","start":"2026-10-03T05:43:23.034452Z","end":"2026-10-03T05:43:23.533429Z","steps":["trace[543548353] 'process raft request' (duration: 305.628457ms)","trace[543548353] 'compare' (duration: 192.383385ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:43:23.533564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:43:23.034431Z","time spent":"499.063151ms","remote":"127.0.0.1:44462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-03T05:43:23.533664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.007953ms","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-10-03T05:43:23.533652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.816718ms","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-10-03T05:43:23.53363Z","caller":"traceutil/trace.go:171","msg":"trace[1619105209] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"170.666261ms","start":"2026-10-03T05:43:23.362908Z","end":"2026-10-03T05:43:23.533575Z","steps":["trace[1619105209] 'process raft request' (duration: 170.295425ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:43:23.533706Z","caller":"traceutil/trace.go:171","msg":"trace[1423535795] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2181; }","duration":"427.101075ms","start":"2026-10-03T05:43:23.106591Z","end":"2026-10-03T05:43:23.533692Z","steps":["trace[1423535795] 'agreement among raft nodes before linearized reading' (duration: 426.858521ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:43:23.533727Z","caller":"traceutil/trace.go:171","msg":"trace[1403543380] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2181; }","duration":"462.937239ms","start":"2026-10-03T05:43:23.070771Z","end":"2026-10-03T05:43:23.533708Z","steps":["trace[1403543380] 'agreement among raft nodes before linearized reading' (duration: 462.649564ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:43:23.533745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:43:23.106572Z","time spent":"427.159785ms","remote":"127.0.0.1:52534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-10-03T05:43:23.533772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:43:23.070752Z","time spent":"463.007111ms","remote":"127.0.0.1:44462","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-10-03T05:43:23.533839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.822155ms","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-10-03T05:43:23.533915Z","caller":"traceutil/trace.go:171","msg":"trace[1266826708] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2181; }","duration":"178.954736ms","start":"2026-10-03T05:43:23.354941Z","end":"2026-10-03T05:43:23.533895Z","steps":["trace[1266826708] 'agreement among raft nodes before linearized reading' (duration: 178.638741ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:43:23.667935Z","caller":"traceutil/trace.go:171","msg":"trace[2074722729] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"129.635821ms","start":"2026-10-03T05:43:23.538244Z","end":"2026-10-03T05:43:23.66788Z","steps":["trace[2074722729] 'process raft request' (duration: 117.707675ms)","trace[2074722729] 'compare' (duration: 11.792604ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:44:54.442328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.031945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-03T05:44:54.442427Z","caller":"traceutil/trace.go:171","msg":"trace[901693570] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:2778; }","duration":"156.174877ms","start":"2026-10-03T05:44:54.28622Z","end":"2026-10-03T05:44:54.442395Z","steps":["trace[901693570] 'count revisions from in-memory index tree' (duration: 155.941423ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:44:54.666124Z","caller":"traceutil/trace.go:171","msg":"trace[236107398] transaction","detail":"{read_only:false; response_revision:2779; number_of_response:1; }","duration":"104.724632ms","start":"2026-10-03T05:44:54.561373Z","end":"2026-10-03T05:44:54.666098Z","steps":["trace[236107398] 'process raft request' (duration: 104.056888ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:45:00.178595Z","caller":"traceutil/trace.go:171","msg":"trace[1413905699] transaction","detail":"{read_only:false; response_revision:2806; number_of_response:1; }","duration":"263.582813ms","start":"2026-10-03T05:44:59.914961Z","end":"2026-10-03T05:45:00.178544Z","steps":["trace[1413905699] 'process raft request' (duration: 254.047966ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:45:00.178975Z","caller":"traceutil/trace.go:171","msg":"trace[965396429] linearizableReadLoop","detail":"{readStateIndex:2909; appliedIndex:2908; }","duration":"159.224985ms","start":"2026-10-03T05:45:00.019727Z","end":"2026-10-03T05:45:00.178952Z","steps":["trace[965396429] 'read index received' (duration: 149.207746ms)","trace[965396429] 'applied index is now lower than readState.Index' (duration: 10.015459ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:45:00.179276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.514431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-10-03T05:45:00.179398Z","caller":"traceutil/trace.go:171","msg":"trace[319539163] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2806; }","duration":"159.683784ms","start":"2026-10-03T05:45:00.019684Z","end":"2026-10-03T05:45:00.179368Z","steps":["trace[319539163] 'agreement among raft nodes before linearized reading' (duration: 159.366098ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:45:00.179321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.653014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-03T05:45:00.17945Z","caller":"traceutil/trace.go:171","msg":"trace[393246683] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2806; }","duration":"146.818266ms","start":"2026-10-03T05:45:00.032617Z","end":"2026-10-03T05:45:00.179436Z","steps":["trace[393246683] 'agreement among raft nodes before linearized reading' (duration: 146.459839ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:29.312916Z","caller":"traceutil/trace.go:171","msg":"trace[1937835708] transaction","detail":"{read_only:false; response_revision:4913; number_of_response:1; }","duration":"237.948093ms","start":"2026-10-03T05:49:29.074939Z","end":"2026-10-03T05:49:29.312887Z","steps":["trace[1937835708] 'process raft request' (duration: 237.757829ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:49:29.496507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.023746ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-03T05:49:29.497295Z","caller":"traceutil/trace.go:171","msg":"trace[787256842] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"337.397579ms","start":"2026-10-03T05:49:29.159816Z","end":"2026-10-03T05:49:29.497213Z","steps":["trace[787256842] 'process raft request' (duration: 223.537178ms)","trace[787256842] 'compare' (duration: 112.812793ms)"],"step_count":2} {"level":"warn","ts":"2026-10-03T05:49:29.497562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-03T05:49:29.159765Z","time spent":"337.605312ms","remote":"127.0.0.1:44462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-03T05:49:29.4976Z","caller":"traceutil/trace.go:171","msg":"trace[1757800398] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"197.957557ms","start":"2026-10-03T05:49:29.299609Z","end":"2026-10-03T05:49:29.497567Z","steps":["trace[1757800398] 'process raft request' (duration: 197.03229ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:29.518327Z","caller":"traceutil/trace.go:171","msg":"trace[755143252] linearizableReadLoop","detail":"{readStateIndex:5103; appliedIndex:5099; }","duration":"196.966039ms","start":"2026-10-03T05:49:29.321336Z","end":"2026-10-03T05:49:29.518302Z","steps":["trace[755143252] 'read index received' (duration: 62.023485ms)","trace[755143252] 'applied index is now lower than readState.Index' (duration: 134.941424ms)"],"step_count":2} {"level":"info","ts":"2026-10-03T05:49:29.518386Z","caller":"traceutil/trace.go:171","msg":"trace[1616979638] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"196.284727ms","start":"2026-10-03T05:49:29.322078Z","end":"2026-10-03T05:49:29.518363Z","steps":["trace[1616979638] 'process raft request' (duration: 196.109244ms)"],"step_count":1} {"level":"warn","ts":"2026-10-03T05:49:29.518573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.203793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-vkh6x\" ","response":"range_response_count:1 size:9753"} {"level":"info","ts":"2026-10-03T05:49:29.518622Z","caller":"traceutil/trace.go:171","msg":"trace[97464577] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-vkh6x; range_end:; response_count:1; response_revision:4919; }","duration":"197.313624ms","start":"2026-10-03T05:49:29.321295Z","end":"2026-10-03T05:49:29.518608Z","steps":["trace[97464577] 'agreement among raft nodes before linearized reading' (duration: 197.121521ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:29.518628Z","caller":"traceutil/trace.go:171","msg":"trace[1251400702] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"197.980147ms","start":"2026-10-03T05:49:29.32063Z","end":"2026-10-03T05:49:29.51861Z","steps":["trace[1251400702] 'process raft request' (duration: 197.489469ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:29.518802Z","caller":"traceutil/trace.go:171","msg":"trace[281630965] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"193.884624ms","start":"2026-10-03T05:49:29.324882Z","end":"2026-10-03T05:49:29.518766Z","steps":["trace[281630965] 'process raft request' (duration: 193.362445ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:29.518923Z","caller":"traceutil/trace.go:171","msg":"trace[1132701321] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"198.625678ms","start":"2026-10-03T05:49:29.32028Z","end":"2026-10-03T05:49:29.518906Z","steps":["trace[1132701321] 'process raft request' (duration: 197.663651ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:49:34.511865Z","caller":"traceutil/trace.go:171","msg":"trace[723944403] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"136.03984ms","start":"2026-10-03T05:49:34.375798Z","end":"2026-10-03T05:49:34.511838Z","steps":["trace[723944403] 'process raft request' (duration: 135.862697ms)"],"step_count":1} {"level":"info","ts":"2026-10-03T05:50:18.483932Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2907} {"level":"info","ts":"2026-10-03T05:50:18.565214Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2907,"took":"79.604105ms","hash":1620563693,"current-db-size-bytes":52047872,"current-db-size":"52 MB","current-db-size-in-use-bytes":27918336,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-03T05:50:18.565323Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1620563693,"revision":2907,"compact-revision":-1} {"level":"info","ts":"2026-10-03T05:55:18.49049Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5390} {"level":"info","ts":"2026-10-03T05:55:18.602039Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5390,"took":"110.408756ms","hash":685556037,"current-db-size-bytes":52047872,"current-db-size":"52 MB","current-db-size-in-use-bytes":18771968,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-10-03T05:55:18.602101Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":685556037,"revision":5390,"compact-revision":2907}