{"level":"warn","ts":"2026-09-15T22:37:21.102282Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-15T22:37:21.10239Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.164: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.164:2380","--initial-cluster=instance=https://162.253.55.164:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.164:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.164:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-15T22:37:21.102459Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-15T22:37:21.102477Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.164:2380"]} {"level":"info","ts":"2026-09-15T22:37:21.102492Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-15T22:37:21.103143Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"]} {"level":"info","ts":"2026-09-15T22:37:21.10321Z","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.164:2380"],"listen-peer-urls":["https://162.253.55.164:2380"],"advertise-client-urls":["https://162.253.55.164:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.164:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-15T22:37:21.109248Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.848493ms"} {"level":"info","ts":"2026-09-15T22:37:21.119383Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"777352cb93f4c05d","cluster-id":"ebb6470dab83b2e8"} {"level":"info","ts":"2026-09-15T22:37:21.119458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=()"} {"level":"info","ts":"2026-09-15T22:37:21.119724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became follower at term 0"} {"level":"info","ts":"2026-09-15T22:37:21.119733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 777352cb93f4c05d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-15T22:37:21.119771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became follower at term 1"} {"level":"info","ts":"2026-09-15T22:37:21.119804Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=(8607314347149279325)"} {"level":"warn","ts":"2026-09-15T22:37:21.127111Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-15T22:37:21.128294Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-15T22:37:21.129948Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-15T22:37:21.132167Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"777352cb93f4c05d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-15T22:37:21.132335Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"777352cb93f4c05d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-15T22:37:21.132497Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-15T22:37:21.13254Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-15T22:37:21.132548Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-15T22:37:21.136171Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d switched to configuration voters=(8607314347149279325)"} {"level":"info","ts":"2026-09-15T22:37:21.136284Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ebb6470dab83b2e8","local-member-id":"777352cb93f4c05d","added-peer-id":"777352cb93f4c05d","added-peer-peer-urls":["https://162.253.55.164:2380"]} {"level":"info","ts":"2026-09-15T22:37:21.141114Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-15T22:37:21.141161Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.164:2380"} {"level":"info","ts":"2026-09-15T22:37:21.141206Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.164:2380"} {"level":"info","ts":"2026-09-15T22:37:21.141664Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"777352cb93f4c05d","initial-advertise-peer-urls":["https://162.253.55.164:2380"],"listen-peer-urls":["https://162.253.55.164:2380"],"advertise-client-urls":["https://162.253.55.164:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.164:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-15T22:37:21.141709Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-15T22:37:21.920638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d is starting a new election at term 1"} {"level":"info","ts":"2026-09-15T22:37:21.920771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became pre-candidate at term 1"} {"level":"info","ts":"2026-09-15T22:37:21.92081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d received MsgPreVoteResp from 777352cb93f4c05d at term 1"} {"level":"info","ts":"2026-09-15T22:37:21.920839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became candidate at term 2"} {"level":"info","ts":"2026-09-15T22:37:21.92085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d received MsgVoteResp from 777352cb93f4c05d at term 2"} {"level":"info","ts":"2026-09-15T22:37:21.920869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"777352cb93f4c05d became leader at term 2"} {"level":"info","ts":"2026-09-15T22:37:21.920889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 777352cb93f4c05d elected leader 777352cb93f4c05d at term 2"} {"level":"info","ts":"2026-09-15T22:37:21.922578Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"777352cb93f4c05d","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.164:2379]}","request-path":"/0/members/777352cb93f4c05d/attributes","cluster-id":"ebb6470dab83b2e8","publish-timeout":"7s"} {"level":"info","ts":"2026-09-15T22:37:21.922577Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T22:37:21.9226Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-15T22:37:21.922602Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T22:37:21.922964Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-15T22:37:21.922988Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-15T22:37:21.924331Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.164:2379"} {"level":"info","ts":"2026-09-15T22:37:21.925202Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ebb6470dab83b2e8","local-member-id":"777352cb93f4c05d","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T22:37:21.925311Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T22:37:21.925343Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-15T22:37:21.927094Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-09-15T22:37:25.029215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.110438ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-09-15T22:37:25.029331Z","caller":"traceutil/trace.go:171","msg":"trace[1219481099] transaction","detail":"{read_only:false; response_revision:120; number_of_response:1; }","duration":"293.073397ms","start":"2026-09-15T22:37:24.736237Z","end":"2026-09-15T22:37:25.02931Z","steps":["trace[1219481099] 'process raft request' (duration: 191.425905ms)","trace[1219481099] 'compare' (duration: 100.943075ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:37:26.618898Z","caller":"traceutil/trace.go:171","msg":"trace[1619887418] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"142.722281ms","start":"2026-09-15T22:37:26.476152Z","end":"2026-09-15T22:37:26.618874Z","steps":["trace[1619887418] 'process raft request' (duration: 135.254944ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:37:32.146103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.482886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-proxy-stngb.18d59f8c2e56a5ff\" ","response":"range_response_count:1 size:769"} {"level":"warn","ts":"2026-09-15T22:37:32.146127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.217052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-15T22:37:32.146192Z","caller":"traceutil/trace.go:171","msg":"trace[1025203175] range","detail":"{range_begin:/registry/events/kube-system/kube-proxy-stngb.18d59f8c2e56a5ff; range_end:; response_count:1; response_revision:374; }","duration":"179.612128ms","start":"2026-09-15T22:37:31.966558Z","end":"2026-09-15T22:37:32.14617Z","steps":["trace[1025203175] 'range keys from in-memory index tree' (duration: 179.390524ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:37:32.146215Z","caller":"traceutil/trace.go:171","msg":"trace[1392212552] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:374; }","duration":"417.347485ms","start":"2026-09-15T22:37:31.728848Z","end":"2026-09-15T22:37:32.146196Z","steps":["trace[1392212552] 'range keys from in-memory index tree' (duration: 417.09487ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:37:32.146234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.286631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-09-15T22:37:32.146231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.435312ms","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-09-15T22:37:32.146297Z","caller":"traceutil/trace.go:171","msg":"trace[2141409936] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:374; }","duration":"466.377623ms","start":"2026-09-15T22:37:31.679895Z","end":"2026-09-15T22:37:32.146272Z","steps":["trace[2141409936] 'range keys from in-memory index tree' (duration: 466.19576ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:37:32.146259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:37:31.728829Z","time spent":"417.417676ms","remote":"127.0.0.1:40018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-09-15T22:37:32.146341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:37:31.679873Z","time spent":"466.458925ms","remote":"127.0.0.1:40018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"info","ts":"2026-09-15T22:37:32.146349Z","caller":"traceutil/trace.go:171","msg":"trace[926387273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:374; }","duration":"270.611585ms","start":"2026-09-15T22:37:31.875714Z","end":"2026-09-15T22:37:32.146326Z","steps":["trace[926387273] 'range keys from in-memory index tree' (duration: 270.319058ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:37:32.361601Z","caller":"traceutil/trace.go:171","msg":"trace[1573006974] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"209.971441ms","start":"2026-09-15T22:37:32.151587Z","end":"2026-09-15T22:37:32.361559Z","steps":["trace[1573006974] 'process raft request' (duration: 209.761356ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:37:32.361653Z","caller":"traceutil/trace.go:171","msg":"trace[1176790652] linearizableReadLoop","detail":"{readStateIndex:385; appliedIndex:383; }","duration":"209.963911ms","start":"2026-09-15T22:37:32.15166Z","end":"2026-09-15T22:37:32.361624Z","steps":["trace[1176790652] 'read index received' (duration: 92.59396ms)","trace[1176790652] 'applied index is now lower than readState.Index' (duration: 117.366321ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:37:32.361659Z","caller":"traceutil/trace.go:171","msg":"trace[769019509] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"206.607794ms","start":"2026-09-15T22:37:32.155022Z","end":"2026-09-15T22:37:32.361629Z","steps":["trace[769019509] 'process raft request' (duration: 206.458271ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:37:32.3618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.121804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-15T22:37:32.361839Z","caller":"traceutil/trace.go:171","msg":"trace[1277614983] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:377; }","duration":"210.208475ms","start":"2026-09-15T22:37:32.151621Z","end":"2026-09-15T22:37:32.361829Z","steps":["trace[1277614983] 'agreement among raft nodes before linearized reading' (duration: 210.103033ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:38:01.213432Z","caller":"traceutil/trace.go:171","msg":"trace[1835134520] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:524; }","duration":"112.691991ms","start":"2026-09-15T22:38:01.100715Z","end":"2026-09-15T22:38:01.213407Z","steps":["trace[1835134520] 'read index received' (duration: 48.765066ms)","trace[1835134520] 'applied index is now lower than readState.Index' (duration: 63.925705ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:38:01.213622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.886714ms","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-09-15T22:38:01.213663Z","caller":"traceutil/trace.go:171","msg":"trace[446726262] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:509; }","duration":"112.990726ms","start":"2026-09-15T22:38:01.100661Z","end":"2026-09-15T22:38:01.213651Z","steps":["trace[446726262] 'agreement among raft nodes before linearized reading' (duration: 112.859704ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:38:01.213707Z","caller":"traceutil/trace.go:171","msg":"trace[1045784206] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"242.131445ms","start":"2026-09-15T22:38:00.971533Z","end":"2026-09-15T22:38:01.213664Z","steps":["trace[1045784206] 'process raft request' (duration: 177.805263ms)","trace[1045784206] 'compare' (duration: 63.864864ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:38:01.213892Z","caller":"traceutil/trace.go:171","msg":"trace[438218855] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"241.772118ms","start":"2026-09-15T22:38:00.972087Z","end":"2026-09-15T22:38:01.213859Z","steps":["trace[438218855] 'process raft request' (duration: 241.279588ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:38:09.523424Z","caller":"traceutil/trace.go:171","msg":"trace[1325879533] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:670; }","duration":"139.914783ms","start":"2026-09-15T22:38:09.383469Z","end":"2026-09-15T22:38:09.523384Z","steps":["trace[1325879533] 'read index received' (duration: 139.811291ms)","trace[1325879533] 'applied index is now lower than readState.Index' (duration: 102.362µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:38:09.523443Z","caller":"traceutil/trace.go:171","msg":"trace[1026967098] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"243.215998ms","start":"2026-09-15T22:38:09.280203Z","end":"2026-09-15T22:38:09.523419Z","steps":["trace[1026967098] 'process raft request' (duration: 243.033655ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:38:09.523596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.111947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kchqc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-09-15T22:38:09.523634Z","caller":"traceutil/trace.go:171","msg":"trace[2141170036] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kchqc; range_end:; response_count:1; response_revision:650; }","duration":"140.201348ms","start":"2026-09-15T22:38:09.383425Z","end":"2026-09-15T22:38:09.523627Z","steps":["trace[2141170036] 'agreement among raft nodes before linearized reading' (duration: 140.068585ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:38:09.706033Z","caller":"traceutil/trace.go:171","msg":"trace[1652921628] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"182.516948ms","start":"2026-09-15T22:38:09.523492Z","end":"2026-09-15T22:38:09.706009Z","steps":["trace[1652921628] 'read index received' (duration: 174.658754ms)","trace[1652921628] 'applied index is now lower than readState.Index' (duration: 7.857254ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:38:09.706168Z","caller":"traceutil/trace.go:171","msg":"trace[1829154069] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"190.517636ms","start":"2026-09-15T22:38:09.515608Z","end":"2026-09-15T22:38:09.706125Z","steps":["trace[1829154069] 'process raft request' (duration: 182.759773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:38:09.70624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.168995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:38:09.70635Z","caller":"traceutil/trace.go:171","msg":"trace[354174425] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"232.311248ms","start":"2026-09-15T22:38:09.474002Z","end":"2026-09-15T22:38:09.706314Z","steps":["trace[354174425] 'agreement among raft nodes before linearized reading' (duration: 232.111204ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:38:09.728155Z","caller":"traceutil/trace.go:171","msg":"trace[1397664058] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"186.769357ms","start":"2026-09-15T22:38:09.541354Z","end":"2026-09-15T22:38:09.728124Z","steps":["trace[1397664058] 'process raft request' (duration: 186.343038ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:38:09.72875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.951742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-15T22:38:09.728839Z","caller":"traceutil/trace.go:171","msg":"trace[1710745932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:652; }","duration":"199.109025ms","start":"2026-09-15T22:38:09.52971Z","end":"2026-09-15T22:38:09.728819Z","steps":["trace[1710745932] 'agreement among raft nodes before linearized reading' (duration: 198.84683ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:38:10.363401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.95793ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:38:10.363514Z","caller":"traceutil/trace.go:171","msg":"trace[2114483167] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:653; }","duration":"288.084162ms","start":"2026-09-15T22:38:10.075413Z","end":"2026-09-15T22:38:10.363497Z","steps":["trace[2114483167] 'range keys from in-memory index tree' (duration: 287.94321ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:38:10.417878Z","caller":"traceutil/trace.go:171","msg":"trace[1385165920] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"612.852186ms","start":"2026-09-15T22:38:09.805003Z","end":"2026-09-15T22:38:10.417855Z","steps":["trace[1385165920] 'process raft request' (duration: 612.723574ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:38:10.418004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:38:09.804986Z","time spent":"612.960979ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-15T22:38:28.135845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.959976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-15T22:38:28.135935Z","caller":"traceutil/trace.go:171","msg":"trace[564741583] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:816; }","duration":"104.106378ms","start":"2026-09-15T22:38:28.031811Z","end":"2026-09-15T22:38:28.135917Z","steps":["trace[564741583] 'range keys from in-memory index tree' (duration: 103.745411ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:38:28.136367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.02124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-15T22:38:28.136444Z","caller":"traceutil/trace.go:171","msg":"trace[143574119] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"263.158212ms","start":"2026-09-15T22:38:27.873268Z","end":"2026-09-15T22:38:28.136426Z","steps":["trace[143574119] 'range keys from in-memory index tree' (duration: 262.843316ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:38:58.916509Z","caller":"traceutil/trace.go:171","msg":"trace[722494616] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"262.693334ms","start":"2026-09-15T22:38:58.653743Z","end":"2026-09-15T22:38:58.916436Z","steps":["trace[722494616] 'process raft request' (duration: 262.45003ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:39:10.586071Z","caller":"traceutil/trace.go:171","msg":"trace[704179664] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"111.390098ms","start":"2026-09-15T22:39:10.47465Z","end":"2026-09-15T22:39:10.58604Z","steps":["trace[704179664] 'process raft request' (duration: 111.224176ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:39:17.648378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.472329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:39:17.648466Z","caller":"traceutil/trace.go:171","msg":"trace[1250545283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1374; }","duration":"174.57325ms","start":"2026-09-15T22:39:17.473872Z","end":"2026-09-15T22:39:17.648445Z","steps":["trace[1250545283] 'range keys from in-memory index tree' (duration: 174.299726ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:39:52.044066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.578979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-09-15T22:39:52.044145Z","caller":"traceutil/trace.go:171","msg":"trace[2096996004] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1923; }","duration":"110.67154ms","start":"2026-09-15T22:39:51.933456Z","end":"2026-09-15T22:39:52.044127Z","steps":["trace[2096996004] 'range keys from in-memory index tree' (duration: 110.414616ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:39:52.044695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.465595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6693c0d7-b3bf-4505-80ad-7ed83cb31526\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-15T22:39:52.044801Z","caller":"traceutil/trace.go:171","msg":"trace[745753673] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6693c0d7-b3bf-4505-80ad-7ed83cb31526; range_end:; response_count:1; response_revision:1923; }","duration":"100.972412ms","start":"2026-09-15T22:39:51.943803Z","end":"2026-09-15T22:39:52.044775Z","steps":["trace[745753673] 'range keys from in-memory index tree' (duration: 100.246562ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:39:52.270765Z","caller":"traceutil/trace.go:171","msg":"trace[205853152] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"213.253274ms","start":"2026-09-15T22:39:52.057487Z","end":"2026-09-15T22:39:52.27074Z","steps":["trace[205853152] 'process raft request' (duration: 213.07586ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:39:52.660704Z","caller":"traceutil/trace.go:171","msg":"trace[1981720200] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"379.143775ms","start":"2026-09-15T22:39:52.281533Z","end":"2026-09-15T22:39:52.660677Z","steps":["trace[1981720200] 'process raft request' (duration: 283.686242ms)","trace[1981720200] 'compare' (duration: 95.289261ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:39:52.661015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:39:52.281526Z","time spent":"379.246576ms","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T22:39:52.661038Z","caller":"traceutil/trace.go:171","msg":"trace[551813192] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1996; }","duration":"379.170236ms","start":"2026-09-15T22:39:52.281844Z","end":"2026-09-15T22:39:52.661015Z","steps":["trace[551813192] 'read index received' (duration: 24.489588ms)","trace[551813192] 'applied index is now lower than readState.Index' (duration: 354.659298ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:39:52.661295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.714611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:39:52.661313Z","caller":"traceutil/trace.go:171","msg":"trace[1282479382] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"379.678953ms","start":"2026-09-15T22:39:52.281617Z","end":"2026-09-15T22:39:52.661296Z","steps":["trace[1282479382] 'process raft request' (duration: 379.018613ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:39:52.661352Z","caller":"traceutil/trace.go:171","msg":"trace[1756357061] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1931; }","duration":"187.808843ms","start":"2026-09-15T22:39:52.473529Z","end":"2026-09-15T22:39:52.661338Z","steps":["trace[1756357061] 'agreement among raft nodes before linearized reading' (duration: 187.725892ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:39:52.661363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.510557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6693c0d7-b3bf-4505-80ad-7ed83cb31526\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-15T22:39:52.661418Z","caller":"traceutil/trace.go:171","msg":"trace[1711258679] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6693c0d7-b3bf-4505-80ad-7ed83cb31526; range_end:; response_count:1; response_revision:1931; }","duration":"383.624069ms","start":"2026-09-15T22:39:52.277778Z","end":"2026-09-15T22:39:52.661402Z","steps":["trace[1711258679] 'agreement among raft nodes before linearized reading' (duration: 383.422056ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:39:52.661481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:39:52.277756Z","time spent":"383.711539ms","remote":"127.0.0.1:40000","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6693c0d7-b3bf-4505-80ad-7ed83cb31526\" "} {"level":"info","ts":"2026-09-15T22:39:52.661503Z","caller":"traceutil/trace.go:171","msg":"trace[2102417167] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"377.665094ms","start":"2026-09-15T22:39:52.28382Z","end":"2026-09-15T22:39:52.661485Z","steps":["trace[2102417167] 'process raft request' (duration: 377.038304ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:39:52.661595Z","caller":"traceutil/trace.go:171","msg":"trace[384587369] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"375.578114ms","start":"2026-09-15T22:39:52.286005Z","end":"2026-09-15T22:39:52.661583Z","steps":["trace[384587369] 'process raft request' (duration: 374.927754ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:39:52.661592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:39:52.283804Z","time spent":"377.738645ms","remote":"127.0.0.1:40088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:39:52.661425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:39:52.281593Z","time spent":"379.775384ms","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:39:52.661663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:39:52.285986Z","time spent":"375.645815ms","remote":"127.0.0.1:40076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-15T22:40:04.559349Z","caller":"traceutil/trace.go:171","msg":"trace[2141868106] linearizableReadLoop","detail":"{readStateIndex:2100; appliedIndex:2099; }","duration":"159.244038ms","start":"2026-09-15T22:40:04.400083Z","end":"2026-09-15T22:40:04.559327Z","steps":["trace[2141868106] 'read index received' (duration: 159.057506ms)","trace[2141868106] 'applied index is now lower than readState.Index' (duration: 185.832µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:40:04.559523Z","caller":"traceutil/trace.go:171","msg":"trace[750597732] transaction","detail":"{read_only:false; response_revision:2028; number_of_response:1; }","duration":"204.446751ms","start":"2026-09-15T22:40:04.355041Z","end":"2026-09-15T22:40:04.559487Z","steps":["trace[750597732] 'process raft request' (duration: 204.155826ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:40:04.559573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.468232ms","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-09-15T22:40:04.559615Z","caller":"traceutil/trace.go:171","msg":"trace[1167004077] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2028; }","duration":"159.523833ms","start":"2026-09-15T22:40:04.400076Z","end":"2026-09-15T22:40:04.5596Z","steps":["trace[1167004077] 'agreement among raft nodes before linearized reading' (duration: 159.333869ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:40:26.864739Z","caller":"traceutil/trace.go:171","msg":"trace[839163401] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"102.372887ms","start":"2026-09-15T22:40:26.762343Z","end":"2026-09-15T22:40:26.864716Z","steps":["trace[839163401] 'process raft request' (duration: 94.687521ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:40:27.640565Z","caller":"traceutil/trace.go:171","msg":"trace[1100413574] linearizableReadLoop","detail":"{readStateIndex:2253; appliedIndex:2252; }","duration":"139.13ms","start":"2026-09-15T22:40:27.501411Z","end":"2026-09-15T22:40:27.640541Z","steps":["trace[1100413574] 'read index received' (duration: 138.913666ms)","trace[1100413574] 'applied index is now lower than readState.Index' (duration: 215.614µs)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:40:27.640641Z","caller":"traceutil/trace.go:171","msg":"trace[966596826] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"159.320018ms","start":"2026-09-15T22:40:27.481286Z","end":"2026-09-15T22:40:27.640606Z","steps":["trace[966596826] 'process raft request' (duration: 159.102105ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:40:27.640814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.391953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-15T22:40:27.64116Z","caller":"traceutil/trace.go:171","msg":"trace[580255820] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2176; }","duration":"139.713987ms","start":"2026-09-15T22:40:27.501391Z","end":"2026-09-15T22:40:27.641105Z","steps":["trace[580255820] 'agreement among raft nodes before linearized reading' (duration: 139.285342ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:40:28.191595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.890139ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T22:40:28.191759Z","caller":"traceutil/trace.go:171","msg":"trace[1362551963] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"254.773366ms","start":"2026-09-15T22:40:27.936967Z","end":"2026-09-15T22:40:28.191741Z","steps":["trace[1362551963] 'process raft request' (duration: 254.716485ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:40:28.191932Z","caller":"traceutil/trace.go:171","msg":"trace[1200468144] linearizableReadLoop","detail":"{readStateIndex:2254; appliedIndex:2253; }","duration":"455.746466ms","start":"2026-09-15T22:40:27.736156Z","end":"2026-09-15T22:40:28.191903Z","steps":["trace[1200468144] 'read index received' (duration: 154.453102ms)","trace[1200468144] 'applied index is now lower than readState.Index' (duration: 301.290684ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:40:28.191963Z","caller":"traceutil/trace.go:171","msg":"trace[1115733989] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"545.993285ms","start":"2026-09-15T22:40:27.6459Z","end":"2026-09-15T22:40:28.191893Z","steps":["trace[1115733989] 'process raft request' (duration: 244.704331ms)","trace[1115733989] 'compare' (duration: 300.547723ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:40:28.192099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.952909ms","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-09-15T22:40:28.192138Z","caller":"traceutil/trace.go:171","msg":"trace[40034030] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2178; }","duration":"456.0352ms","start":"2026-09-15T22:40:27.736092Z","end":"2026-09-15T22:40:28.192127Z","steps":["trace[40034030] 'agreement among raft nodes before linearized reading' (duration: 455.914457ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:40:28.192165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:40:27.736067Z","time spent":"456.090321ms","remote":"127.0.0.1:35480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-15T22:40:28.192205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:40:27.645877Z","time spent":"546.165377ms","remote":"127.0.0.1:40076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:40:28.1925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.704464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-09-15T22:40:28.192553Z","caller":"traceutil/trace.go:171","msg":"trace[1737603968] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2178; }","duration":"377.794256ms","start":"2026-09-15T22:40:27.814745Z","end":"2026-09-15T22:40:28.192539Z","steps":["trace[1737603968] 'agreement among raft nodes before linearized reading' (duration: 377.310039ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:40:28.192806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:40:27.814732Z","time spent":"377.996088ms","remote":"127.0.0.1:40006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2011,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-09-15T22:42:21.941197Z","caller":"traceutil/trace.go:171","msg":"trace[309137118] linearizableReadLoop","detail":"{readStateIndex:2993; appliedIndex:2990; }","duration":"137.198466ms","start":"2026-09-15T22:42:21.803974Z","end":"2026-09-15T22:42:21.941173Z","steps":["trace[309137118] 'read index received' (duration: 37.389428ms)","trace[309137118] 'applied index is now lower than readState.Index' (duration: 99.807768ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:42:21.941333Z","caller":"traceutil/trace.go:171","msg":"trace[1450187287] transaction","detail":"{read_only:false; response_revision:2890; number_of_response:1; }","duration":"162.859133ms","start":"2026-09-15T22:42:21.77846Z","end":"2026-09-15T22:42:21.941319Z","steps":["trace[1450187287] 'process raft request' (duration: 162.668418ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:42:21.941238Z","caller":"traceutil/trace.go:171","msg":"trace[1049175677] transaction","detail":"{read_only:false; response_revision:2889; number_of_response:1; }","duration":"165.710684ms","start":"2026-09-15T22:42:21.775497Z","end":"2026-09-15T22:42:21.941208Z","steps":["trace[1049175677] 'process raft request' (duration: 162.7252ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:42:21.941439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.450173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-15T22:42:21.941531Z","caller":"traceutil/trace.go:171","msg":"trace[569045335] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:2890; }","duration":"137.584167ms","start":"2026-09-15T22:42:21.803928Z","end":"2026-09-15T22:42:21.941512Z","steps":["trace[569045335] 'agreement among raft nodes before linearized reading' (duration: 137.452184ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:46:58.058364Z","caller":"traceutil/trace.go:171","msg":"trace[781500792] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"115.5248ms","start":"2026-09-15T22:46:57.94281Z","end":"2026-09-15T22:46:58.058335Z","steps":["trace[781500792] 'process raft request' (duration: 115.383997ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:46:58.28978Z","caller":"traceutil/trace.go:171","msg":"trace[295479941] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"139.990905ms","start":"2026-09-15T22:46:58.149739Z","end":"2026-09-15T22:46:58.28973Z","steps":["trace[295479941] 'process raft request' (duration: 139.812212ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:46:58.324586Z","caller":"traceutil/trace.go:171","msg":"trace[638765401] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"174.262837ms","start":"2026-09-15T22:46:58.150295Z","end":"2026-09-15T22:46:58.324558Z","steps":["trace[638765401] 'process raft request' (duration: 174.096694ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:46:58.325002Z","caller":"traceutil/trace.go:171","msg":"trace[1077970479] transaction","detail":"{read_only:false; response_revision:5104; number_of_response:1; }","duration":"108.086827ms","start":"2026-09-15T22:46:58.216873Z","end":"2026-09-15T22:46:58.32496Z","steps":["trace[1077970479] 'process raft request' (duration: 107.651959ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:46:58.766981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.429966ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-15T22:46:58.767376Z","caller":"traceutil/trace.go:171","msg":"trace[1697133329] transaction","detail":"{read_only:false; response_revision:5112; number_of_response:1; }","duration":"141.508983ms","start":"2026-09-15T22:46:58.625844Z","end":"2026-09-15T22:46:58.767353Z","steps":["trace[1697133329] 'process raft request' (duration: 141.438201ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:46:58.767435Z","caller":"traceutil/trace.go:171","msg":"trace[1998768203] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"322.579379ms","start":"2026-09-15T22:46:58.444824Z","end":"2026-09-15T22:46:58.767403Z","steps":["trace[1998768203] 'process raft request' (duration: 322.268684ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:46:58.767439Z","caller":"traceutil/trace.go:171","msg":"trace[1640377950] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"320.577933ms","start":"2026-09-15T22:46:58.446821Z","end":"2026-09-15T22:46:58.767399Z","steps":["trace[1640377950] 'process raft request' (duration: 320.39258ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:46:58.767526Z","caller":"traceutil/trace.go:171","msg":"trace[1305554187] linearizableReadLoop","detail":"{readStateIndex:5300; appliedIndex:5296; }","duration":"315.640826ms","start":"2026-09-15T22:46:58.451861Z","end":"2026-09-15T22:46:58.767502Z","steps":["trace[1305554187] 'read index received' (duration: 11.834262ms)","trace[1305554187] 'applied index is now lower than readState.Index' (duration: 303.804134ms)"],"step_count":2} {"level":"info","ts":"2026-09-15T22:46:58.76748Z","caller":"traceutil/trace.go:171","msg":"trace[163927682] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"323.71979ms","start":"2026-09-15T22:46:58.44374Z","end":"2026-09-15T22:46:58.767459Z","steps":["trace[163927682] 'process raft request' (duration: 128.656564ms)","trace[163927682] 'compare' (duration: 194.17314ms)"],"step_count":2} {"level":"warn","ts":"2026-09-15T22:46:58.767767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.89915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-15T22:46:58.767832Z","caller":"traceutil/trace.go:171","msg":"trace[1264660289] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:5112; }","duration":"315.968631ms","start":"2026-09-15T22:46:58.451822Z","end":"2026-09-15T22:46:58.767791Z","steps":["trace[1264660289] 'agreement among raft nodes before linearized reading' (duration: 315.89228ms)"],"step_count":1} {"level":"warn","ts":"2026-09-15T22:46:58.767818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:46:58.446803Z","time spent":"320.705136ms","remote":"127.0.0.1:40088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1869,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:46:58.767812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:46:58.444801Z","time spent":"322.695321ms","remote":"127.0.0.1:39972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1283,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:46:58.767894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:46:58.443716Z","time spent":"324.066096ms","remote":"127.0.0.1:40088","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1455,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-15T22:46:58.767978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.854728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-15T22:46:58.767876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-15T22:46:58.451812Z","time spent":"316.051713ms","remote":"127.0.0.1:40306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-09-15T22:46:58.768055Z","caller":"traceutil/trace.go:171","msg":"trace[1532063789] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5112; }","duration":"293.936679ms","start":"2026-09-15T22:46:58.474088Z","end":"2026-09-15T22:46:58.768025Z","steps":["trace[1532063789] 'agreement among raft nodes before linearized reading' (duration: 293.862368ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:47:21.970149Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2892} {"level":"info","ts":"2026-09-15T22:47:22.048164Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2892,"took":"76.576637ms","hash":2923046667,"current-db-size-bytes":52387840,"current-db-size":"52 MB","current-db-size-in-use-bytes":27590656,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-15T22:47:22.048229Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2923046667,"revision":2892,"compact-revision":-1} {"level":"info","ts":"2026-09-15T22:47:47.65481Z","caller":"traceutil/trace.go:171","msg":"trace[1747577574] transaction","detail":"{read_only:false; response_revision:5613; number_of_response:1; }","duration":"118.938798ms","start":"2026-09-15T22:47:47.535842Z","end":"2026-09-15T22:47:47.654781Z","steps":["trace[1747577574] 'process raft request' (duration: 118.777835ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:50:58.437396Z","caller":"traceutil/trace.go:171","msg":"trace[971142630] transaction","detail":"{read_only:false; response_revision:6923; number_of_response:1; }","duration":"108.500207ms","start":"2026-09-15T22:50:58.328871Z","end":"2026-09-15T22:50:58.437371Z","steps":["trace[971142630] 'process raft request' (duration: 108.361282ms)"],"step_count":1} {"level":"info","ts":"2026-09-15T22:52:21.977186Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5363} {"level":"info","ts":"2026-09-15T22:52:22.111883Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5363,"took":"133.515351ms","hash":3873112133,"current-db-size-bytes":52387840,"current-db-size":"52 MB","current-db-size-in-use-bytes":18837504,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-15T22:52:22.11195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3873112133,"revision":5363,"compact-revision":2892}