{"level":"warn","ts":"2026-10-17T10:57:37.989845Z","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-17T10:57:37.989964Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.123: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.123:2380","--initial-cluster=instance=https://162.253.55.123:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.123:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.123: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-17T10:57:37.99004Z","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-17T10:57:37.990065Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.123:2380"]} {"level":"info","ts":"2026-10-17T10:57:37.990096Z","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-17T10:57:37.993161Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.123:2379"]} {"level":"info","ts":"2026-10-17T10:57:37.993453Z","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":16,"max-cpu-available":16,"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.123:2380"],"listen-peer-urls":["https://162.253.55.123:2380"],"advertise-client-urls":["https://162.253.55.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.123: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-17T10:57:37.996864Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.944907ms"} {"level":"info","ts":"2026-10-17T10:57:38.002302Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dd65ba9af29ebfc9","cluster-id":"67ca29879725fb76"} {"level":"info","ts":"2026-10-17T10:57:38.002417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 switched to configuration voters=()"} {"level":"info","ts":"2026-10-17T10:57:38.002446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became follower at term 0"} {"level":"info","ts":"2026-10-17T10:57:38.002473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dd65ba9af29ebfc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-17T10:57:38.002492Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became follower at term 1"} {"level":"info","ts":"2026-10-17T10:57:38.002558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 switched to configuration voters=(15953362429688070089)"} {"level":"warn","ts":"2026-10-17T10:57:38.008544Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-17T10:57:38.012674Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-17T10:57:38.014665Z","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-17T10:57:38.018027Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dd65ba9af29ebfc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-17T10:57:38.018245Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dd65ba9af29ebfc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-17T10:57:38.018309Z","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-17T10:57:38.018667Z","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-17T10:57:38.01875Z","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-17T10:57:38.01948Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 switched to configuration voters=(15953362429688070089)"} {"level":"info","ts":"2026-10-17T10:57:38.019627Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"67ca29879725fb76","local-member-id":"dd65ba9af29ebfc9","added-peer-id":"dd65ba9af29ebfc9","added-peer-peer-urls":["https://162.253.55.123:2380"]} {"level":"info","ts":"2026-10-17T10:57:38.022276Z","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-17T10:57:38.022409Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.123:2380"} {"level":"info","ts":"2026-10-17T10:57:38.022435Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.123:2380"} {"level":"info","ts":"2026-10-17T10:57:38.02268Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dd65ba9af29ebfc9","initial-advertise-peer-urls":["https://162.253.55.123:2380"],"listen-peer-urls":["https://162.253.55.123:2380"],"advertise-client-urls":["https://162.253.55.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-17T10:57:38.02275Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-17T10:57:39.00321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 is starting a new election at term 1"} {"level":"info","ts":"2026-10-17T10:57:39.003312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-17T10:57:39.003416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 received MsgPreVoteResp from dd65ba9af29ebfc9 at term 1"} {"level":"info","ts":"2026-10-17T10:57:39.003447Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became candidate at term 2"} {"level":"info","ts":"2026-10-17T10:57:39.003463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 received MsgVoteResp from dd65ba9af29ebfc9 at term 2"} {"level":"info","ts":"2026-10-17T10:57:39.003481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dd65ba9af29ebfc9 became leader at term 2"} {"level":"info","ts":"2026-10-17T10:57:39.003495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dd65ba9af29ebfc9 elected leader dd65ba9af29ebfc9 at term 2"} {"level":"info","ts":"2026-10-17T10:57:39.004968Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dd65ba9af29ebfc9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.123:2379]}","request-path":"/0/members/dd65ba9af29ebfc9/attributes","cluster-id":"67ca29879725fb76","publish-timeout":"7s"} {"level":"info","ts":"2026-10-17T10:57:39.005017Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:57:39.004975Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:57:39.004982Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-17T10:57:39.005315Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-17T10:57:39.00547Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-17T10:57:39.006343Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"67ca29879725fb76","local-member-id":"dd65ba9af29ebfc9","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:57:39.006487Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:57:39.006522Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-17T10:57:39.008763Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-17T10:57:39.008846Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.123:2379"} {"level":"warn","ts":"2026-10-17T10:57:54.958485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.71289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-17T10:57:54.958524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.845703ms","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-10-17T10:57:54.95866Z","caller":"traceutil/trace.go:171","msg":"trace[1475860805] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:411; }","duration":"179.914675ms","start":"2026-10-17T10:57:54.778709Z","end":"2026-10-17T10:57:54.958624Z","steps":["trace[1475860805] 'range keys from in-memory index tree' (duration: 179.553976ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:57:54.958688Z","caller":"traceutil/trace.go:171","msg":"trace[1624685375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:411; }","duration":"180.07849ms","start":"2026-10-17T10:57:54.778583Z","end":"2026-10-17T10:57:54.958661Z","steps":["trace[1624685375] 'range keys from in-memory index tree' (duration: 179.581647ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:05.528328Z","caller":"traceutil/trace.go:171","msg":"trace[1855242561] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"131.626189ms","start":"2026-10-17T10:58:05.396671Z","end":"2026-10-17T10:58:05.528297Z","steps":["trace[1855242561] 'process raft request' (duration: 131.480456ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:33.421842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.084273ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T10:58:33.421969Z","caller":"traceutil/trace.go:171","msg":"trace[1346664140] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"126.672983ms","start":"2026-10-17T10:58:33.29528Z","end":"2026-10-17T10:58:33.421953Z","steps":["trace[1346664140] 'read index received' (duration: 16.665217ms)","trace[1346664140] 'applied index is now lower than readState.Index' (duration: 110.006446ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:33.422034Z","caller":"traceutil/trace.go:171","msg":"trace[1033814934] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"127.899974ms","start":"2026-10-17T10:58:33.294093Z","end":"2026-10-17T10:58:33.421993Z","steps":["trace[1033814934] 'process raft request' (duration: 17.928889ms)","trace[1033814934] 'compare' (duration: 108.943949ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:33.422134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.848277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T10:58:33.42221Z","caller":"traceutil/trace.go:171","msg":"trace[685922557] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:663; }","duration":"126.894418ms","start":"2026-10-17T10:58:33.295262Z","end":"2026-10-17T10:58:33.422156Z","steps":["trace[685922557] 'agreement among raft nodes before linearized reading' (duration: 126.735124ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:33.820871Z","caller":"traceutil/trace.go:171","msg":"trace[1600465768] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"305.926428ms","start":"2026-10-17T10:58:33.514894Z","end":"2026-10-17T10:58:33.820821Z","steps":["trace[1600465768] 'process raft request' (duration: 305.678932ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:33.821066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:33.514874Z","time spent":"306.096093ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T10:58:33.875578Z","caller":"traceutil/trace.go:171","msg":"trace[829066158] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"245.740506ms","start":"2026-10-17T10:58:33.629806Z","end":"2026-10-17T10:58:33.875546Z","steps":["trace[829066158] 'process raft request' (duration: 245.030067ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:34.26357Z","caller":"traceutil/trace.go:171","msg":"trace[924825831] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"243.474689ms","start":"2026-10-17T10:58:34.02006Z","end":"2026-10-17T10:58:34.263535Z","steps":["trace[924825831] 'read index received' (duration: 189.305997ms)","trace[924825831] 'applied index is now lower than readState.Index' (duration: 54.167202ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T10:58:34.263654Z","caller":"traceutil/trace.go:171","msg":"trace[1815067772] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"320.846301ms","start":"2026-10-17T10:58:33.942781Z","end":"2026-10-17T10:58:34.263627Z","steps":["trace[1815067772] 'process raft request' (duration: 266.579096ms)","trace[1815067772] 'compare' (duration: 53.984498ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T10:58:34.263786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T10:58:33.94276Z","time spent":"320.947534ms","remote":"127.0.0.1:35780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-17T10:58:34.263944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.87429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-nbm7k\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-10-17T10:58:34.264027Z","caller":"traceutil/trace.go:171","msg":"trace[43910104] range","detail":"{range_begin:/registry/pods/kube-system/cilium-nbm7k; range_end:; response_count:1; response_revision:667; }","duration":"244.013273ms","start":"2026-10-17T10:58:34.01999Z","end":"2026-10-17T10:58:34.264003Z","steps":["trace[43910104] 'agreement among raft nodes before linearized reading' (duration: 243.703265ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:58:34.263985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.299506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T10:58:34.264206Z","caller":"traceutil/trace.go:171","msg":"trace[1191269413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"229.559052ms","start":"2026-10-17T10:58:34.034589Z","end":"2026-10-17T10:58:34.264148Z","steps":["trace[1191269413] 'agreement among raft nodes before linearized reading' (duration: 229.210754ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:34.40923Z","caller":"traceutil/trace.go:171","msg":"trace[346585723] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"115.675798ms","start":"2026-10-17T10:58:34.293521Z","end":"2026-10-17T10:58:34.409197Z","steps":["trace[346585723] 'process raft request' (duration: 110.106619ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T10:58:50.031483Z","caller":"traceutil/trace.go:171","msg":"trace[491619785] transaction","detail":"{read_only:false; response_revision:826; number_of_response:1; }","duration":"130.14921ms","start":"2026-10-17T10:58:49.901268Z","end":"2026-10-17T10:58:50.031417Z","steps":["trace[491619785] 'process raft request' (duration: 129.886004ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:59:37.920761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.241262ms","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-10-17T10:59:37.92088Z","caller":"traceutil/trace.go:171","msg":"trace[1908562876] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1373; }","duration":"134.419697ms","start":"2026-10-17T10:59:37.786437Z","end":"2026-10-17T10:59:37.920856Z","steps":["trace[1908562876] 'range keys from in-memory index tree' (duration: 133.763081ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T10:59:37.921066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.527988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T10:59:37.92118Z","caller":"traceutil/trace.go:171","msg":"trace[1933134525] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1373; }","duration":"127.744704ms","start":"2026-10-17T10:59:37.793412Z","end":"2026-10-17T10:59:37.921157Z","steps":["trace[1933134525] 'range keys from in-memory index tree' (duration: 126.705307ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:00:16.788638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.789349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-622bc691-fbf9-4ca9-a336-0249221d4fd1\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-17T11:00:16.788729Z","caller":"traceutil/trace.go:171","msg":"trace[200279544] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-622bc691-fbf9-4ca9-a336-0249221d4fd1; range_end:; response_count:1; response_revision:1940; }","duration":"161.933924ms","start":"2026-10-17T11:00:16.626777Z","end":"2026-10-17T11:00:16.788711Z","steps":["trace[200279544] 'range keys from in-memory index tree' (duration: 161.633334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:00:16.788969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.689556ms","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-17T11:00:16.789151Z","caller":"traceutil/trace.go:171","msg":"trace[1756855667] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1940; }","duration":"279.919032ms","start":"2026-10-17T11:00:16.509201Z","end":"2026-10-17T11:00:16.78912Z","steps":["trace[1756855667] 'range keys from in-memory index tree' (duration: 279.509272ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:00:16.952288Z","caller":"traceutil/trace.go:171","msg":"trace[138025661] linearizableReadLoop","detail":"{readStateIndex:2018; appliedIndex:2016; }","duration":"115.203827ms","start":"2026-10-17T11:00:16.83705Z","end":"2026-10-17T11:00:16.952254Z","steps":["trace[138025661] 'read index received' (duration: 104.082298ms)","trace[138025661] 'applied index is now lower than readState.Index' (duration: 11.119839ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:00:16.952426Z","caller":"traceutil/trace.go:171","msg":"trace[805954305] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"158.359661ms","start":"2026-10-17T11:00:16.794027Z","end":"2026-10-17T11:00:16.952387Z","steps":["trace[805954305] 'process raft request' (duration: 147.17622ms)","trace[805954305] 'compare' (duration: 10.76518ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:00:16.952467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.387142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:00:16.952471Z","caller":"traceutil/trace.go:171","msg":"trace[150654265] transaction","detail":"{read_only:false; response_revision:1943; number_of_response:1; }","duration":"155.314792ms","start":"2026-10-17T11:00:16.797102Z","end":"2026-10-17T11:00:16.952417Z","steps":["trace[150654265] 'process raft request' (duration: 155.062575ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:00:16.952522Z","caller":"traceutil/trace.go:171","msg":"trace[1157369276] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1943; }","duration":"115.473665ms","start":"2026-10-17T11:00:16.837029Z","end":"2026-10-17T11:00:16.952502Z","steps":["trace[1157369276] 'agreement among raft nodes before linearized reading' (duration: 115.355132ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:07.270973Z","caller":"traceutil/trace.go:171","msg":"trace[251950530] transaction","detail":"{read_only:false; response_revision:2272; number_of_response:1; }","duration":"101.761784ms","start":"2026-10-17T11:01:07.169174Z","end":"2026-10-17T11:01:07.270936Z","steps":["trace[251950530] 'process raft request' (duration: 101.494857ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:01:13.245958Z","caller":"traceutil/trace.go:171","msg":"trace[2098484129] transaction","detail":"{read_only:false; response_revision:2303; number_of_response:1; }","duration":"173.426009ms","start":"2026-10-17T11:01:13.072509Z","end":"2026-10-17T11:01:13.245935Z","steps":["trace[2098484129] 'process raft request' (duration: 144.167883ms)","trace[2098484129] 'compare' (duration: 29.163933ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:01:13.249488Z","caller":"traceutil/trace.go:171","msg":"trace[704306814] transaction","detail":"{read_only:false; response_revision:2304; number_of_response:1; }","duration":"174.758432ms","start":"2026-10-17T11:01:13.074704Z","end":"2026-10-17T11:01:13.249462Z","steps":["trace[704306814] 'process raft request' (duration: 174.589848ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:02:42.754939Z","caller":"traceutil/trace.go:171","msg":"trace[1790612794] transaction","detail":"{read_only:false; response_revision:2981; number_of_response:1; }","duration":"153.104525ms","start":"2026-10-17T11:02:42.60179Z","end":"2026-10-17T11:02:42.754895Z","steps":["trace[1790612794] 'process raft request' (duration: 146.456456ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:02:43.206657Z","caller":"traceutil/trace.go:171","msg":"trace[886096575] transaction","detail":"{read_only:false; response_revision:2983; number_of_response:1; }","duration":"185.734078ms","start":"2026-10-17T11:02:43.020891Z","end":"2026-10-17T11:02:43.206625Z","steps":["trace[886096575] 'process raft request' (duration: 127.851511ms)","trace[886096575] 'compare' (duration: 57.6212ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:02:43.206661Z","caller":"traceutil/trace.go:171","msg":"trace[303648886] linearizableReadLoop","detail":"{readStateIndex:3097; appliedIndex:3095; }","duration":"180.682029ms","start":"2026-10-17T11:02:43.025945Z","end":"2026-10-17T11:02:43.206627Z","steps":["trace[303648886] 'read index received' (duration: 35.183447ms)","trace[303648886] 'applied index is now lower than readState.Index' (duration: 145.497112ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:02:43.20695Z","caller":"traceutil/trace.go:171","msg":"trace[1795500696] transaction","detail":"{read_only:false; response_revision:2984; number_of_response:1; }","duration":"144.458645ms","start":"2026-10-17T11:02:43.062442Z","end":"2026-10-17T11:02:43.206901Z","steps":["trace[1795500696] 'process raft request' (duration: 144.118587ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:02:43.20742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.438318ms","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-10-17T11:02:43.207485Z","caller":"traceutil/trace.go:171","msg":"trace[26249348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2984; }","duration":"181.547571ms","start":"2026-10-17T11:02:43.025918Z","end":"2026-10-17T11:02:43.207465Z","steps":["trace[26249348] 'agreement among raft nodes before linearized reading' (duration: 180.868384ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:06:12.037047Z","caller":"traceutil/trace.go:171","msg":"trace[1939375645] transaction","detail":"{read_only:false; response_revision:4280; number_of_response:1; }","duration":"204.632382ms","start":"2026-10-17T11:06:11.832379Z","end":"2026-10-17T11:06:12.037012Z","steps":["trace[1939375645] 'process raft request' (duration: 204.393595ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:37.267831Z","caller":"traceutil/trace.go:171","msg":"trace[230502363] transaction","detail":"{read_only:false; response_revision:5230; number_of_response:1; }","duration":"109.975226ms","start":"2026-10-17T11:07:37.157829Z","end":"2026-10-17T11:07:37.267804Z","steps":["trace[230502363] 'process raft request' (duration: 109.776171ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:39.036608Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2962} {"level":"info","ts":"2026-10-17T11:07:39.114593Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2962,"took":"75.925712ms","hash":2833144429,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":28332032,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:07:39.11469Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2833144429,"revision":2962,"compact-revision":-1} {"level":"info","ts":"2026-10-17T11:07:46.62572Z","caller":"traceutil/trace.go:171","msg":"trace[1764650247] linearizableReadLoop","detail":"{readStateIndex:5722; appliedIndex:5721; }","duration":"195.167278ms","start":"2026-10-17T11:07:46.430508Z","end":"2026-10-17T11:07:46.625676Z","steps":["trace[1764650247] 'read index received' (duration: 194.791668ms)","trace[1764650247] 'applied index is now lower than readState.Index' (duration: 373.93µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:07:46.625749Z","caller":"traceutil/trace.go:171","msg":"trace[2022466964] transaction","detail":"{read_only:false; response_revision:5510; number_of_response:1; }","duration":"224.601684ms","start":"2026-10-17T11:07:46.401095Z","end":"2026-10-17T11:07:46.625697Z","steps":["trace[2022466964] 'process raft request' (duration: 224.258135ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:46.626118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.576218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-14431359-f149-466d-84c5-736626cbca87\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-17T11:07:46.626205Z","caller":"traceutil/trace.go:171","msg":"trace[335955224] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-14431359-f149-466d-84c5-736626cbca87; range_end:; response_count:1; response_revision:5510; }","duration":"195.724793ms","start":"2026-10-17T11:07:46.430445Z","end":"2026-10-17T11:07:46.62617Z","steps":["trace[335955224] 'agreement among raft nodes before linearized reading' (duration: 195.388284ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:46.755982Z","caller":"traceutil/trace.go:171","msg":"trace[1407488560] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"269.135179ms","start":"2026-10-17T11:07:46.486819Z","end":"2026-10-17T11:07:46.755954Z","steps":["trace[1407488560] 'process raft request' (duration: 268.875392ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:46.756201Z","caller":"traceutil/trace.go:171","msg":"trace[687636200] linearizableReadLoop","detail":"{readStateIndex:5724; appliedIndex:5722; }","duration":"130.309755ms","start":"2026-10-17T11:07:46.625849Z","end":"2026-10-17T11:07:46.756159Z","steps":["trace[687636200] 'read index received' (duration: 129.845353ms)","trace[687636200] 'applied index is now lower than readState.Index' (duration: 462.062µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:07:46.756397Z","caller":"traceutil/trace.go:171","msg":"trace[1021874243] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"197.947671ms","start":"2026-10-17T11:07:46.558435Z","end":"2026-10-17T11:07:46.756382Z","steps":["trace[1021874243] 'process raft request' (duration: 197.460869ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:46.756581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.211276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-w2nlq-tls\" ","response":"range_response_count:1 size:1967"} {"level":"info","ts":"2026-10-17T11:07:46.756638Z","caller":"traceutil/trace.go:171","msg":"trace[321475041] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-w2nlq-tls; range_end:; response_count:1; response_revision:5512; }","duration":"295.316819ms","start":"2026-10-17T11:07:46.461304Z","end":"2026-10-17T11:07:46.756621Z","steps":["trace[321475041] 'agreement among raft nodes before linearized reading' (duration: 295.134084ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:46.762747Z","caller":"traceutil/trace.go:171","msg":"trace[46922116] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"128.531599ms","start":"2026-10-17T11:07:46.634197Z","end":"2026-10-17T11:07:46.762728Z","steps":["trace[46922116] 'process raft request' (duration: 128.440046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:07:46.763388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.320529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-17T11:07:46.763435Z","caller":"traceutil/trace.go:171","msg":"trace[849028071] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5513; }","duration":"134.40622ms","start":"2026-10-17T11:07:46.629014Z","end":"2026-10-17T11:07:46.763421Z","steps":["trace[849028071] 'agreement among raft nodes before linearized reading' (duration: 134.211885ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:07:47.010645Z","caller":"traceutil/trace.go:171","msg":"trace[678209110] transaction","detail":"{read_only:false; response_revision:5523; number_of_response:1; }","duration":"109.733501ms","start":"2026-10-17T11:07:46.900881Z","end":"2026-10-17T11:07:47.010615Z","steps":["trace[678209110] 'process raft request' (duration: 86.276681ms)","trace[678209110] 'compare' (duration: 23.308856ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:07:47.019308Z","caller":"traceutil/trace.go:171","msg":"trace[839575404] transaction","detail":"{read_only:false; response_revision:5524; number_of_response:1; }","duration":"115.827319ms","start":"2026-10-17T11:07:46.903449Z","end":"2026-10-17T11:07:47.019276Z","steps":["trace[839575404] 'process raft request' (duration: 115.514241ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:01.662217Z","caller":"traceutil/trace.go:171","msg":"trace[703908872] transaction","detail":"{read_only:false; response_revision:5780; number_of_response:1; }","duration":"278.464157ms","start":"2026-10-17T11:08:01.383726Z","end":"2026-10-17T11:08:01.66219Z","steps":["trace[703908872] 'process raft request' (duration: 278.304903ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:01.904314Z","caller":"traceutil/trace.go:171","msg":"trace[2116368440] linearizableReadLoop","detail":"{readStateIndex:6001; appliedIndex:5998; }","duration":"428.093495ms","start":"2026-10-17T11:08:01.47619Z","end":"2026-10-17T11:08:01.904283Z","steps":["trace[2116368440] 'read index received' (duration: 185.964624ms)","trace[2116368440] 'applied index is now lower than readState.Index' (duration: 242.128031ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:08:01.904367Z","caller":"traceutil/trace.go:171","msg":"trace[465761909] transaction","detail":"{read_only:false; response_revision:5781; number_of_response:1; }","duration":"516.237936ms","start":"2026-10-17T11:08:01.388109Z","end":"2026-10-17T11:08:01.904347Z","steps":["trace[465761909] 'process raft request' (duration: 420.877663ms)","trace[465761909] 'compare' (duration: 94.912011ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:08:01.904445Z","caller":"traceutil/trace.go:171","msg":"trace[1524507705] transaction","detail":"{read_only:false; response_revision:5782; number_of_response:1; }","duration":"432.542999ms","start":"2026-10-17T11:08:01.471891Z","end":"2026-10-17T11:08:01.904434Z","steps":["trace[1524507705] 'process raft request' (duration: 432.24031ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:01.904479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:08:01.388071Z","time spent":"516.352289ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8335,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:08:01.904546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:08:01.471876Z","time spent":"432.594481ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:08:01.904582Z","caller":"traceutil/trace.go:171","msg":"trace[1404114596] transaction","detail":"{read_only:false; response_revision:5783; number_of_response:1; }","duration":"220.137717ms","start":"2026-10-17T11:08:01.684417Z","end":"2026-10-17T11:08:01.904555Z","steps":["trace[1404114596] 'process raft request' (duration: 219.829458ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:01.90471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.557662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-zgvh8\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-10-17T11:08:01.90473Z","caller":"traceutil/trace.go:171","msg":"trace[1502596201] range","detail":"{range_begin:/registry/pods/openstack/keepalived-zgvh8; range_end:; response_count:1; response_revision:5783; }","duration":"315.628054ms","start":"2026-10-17T11:08:01.589097Z","end":"2026-10-17T11:08:01.904725Z","steps":["trace[1502596201] 'agreement among raft nodes before linearized reading' (duration: 315.552101ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:01.904743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:08:01.589085Z","time spent":"315.654754ms","remote":"127.0.0.1:35450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6545,"request content":"key:\"/registry/pods/openstack/keepalived-zgvh8\" "} {"level":"warn","ts":"2026-10-17T11:08:01.904841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.196622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:08:01.904856Z","caller":"traceutil/trace.go:171","msg":"trace[264882218] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:5783; }","duration":"277.234632ms","start":"2026-10-17T11:08:01.627616Z","end":"2026-10-17T11:08:01.90485Z","steps":["trace[264882218] 'agreement among raft nodes before linearized reading' (duration: 277.205661ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:01.904824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.003154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-10-17T11:08:01.904892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.153513ms","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-17T11:08:01.904905Z","caller":"traceutil/trace.go:171","msg":"trace[865564562] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5783; }","duration":"128.158958ms","start":"2026-10-17T11:08:01.776727Z","end":"2026-10-17T11:08:01.904886Z","steps":["trace[865564562] 'agreement among raft nodes before linearized reading' (duration: 127.946322ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:08:01.904928Z","caller":"traceutil/trace.go:171","msg":"trace[1170756266] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5783; }","duration":"212.247497ms","start":"2026-10-17T11:08:01.69267Z","end":"2026-10-17T11:08:01.904918Z","steps":["trace[1170756266] 'agreement among raft nodes before linearized reading' (duration: 212.059322ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:01.905076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.880117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-17T11:08:01.905107Z","caller":"traceutil/trace.go:171","msg":"trace[1687480301] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:5783; }","duration":"428.950299ms","start":"2026-10-17T11:08:01.476144Z","end":"2026-10-17T11:08:01.905094Z","steps":["trace[1687480301] 'agreement among raft nodes before linearized reading' (duration: 428.884917ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:08:01.905133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:08:01.476125Z","time spent":"428.999751ms","remote":"127.0.0.1:35756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":19,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-10-17T11:08:09.29702Z","caller":"traceutil/trace.go:171","msg":"trace[494624033] transaction","detail":"{read_only:false; response_revision:5959; number_of_response:1; }","duration":"139.575638ms","start":"2026-10-17T11:08:09.157415Z","end":"2026-10-17T11:08:09.296991Z","steps":["trace[494624033] 'process raft request' (duration: 81.243979ms)","trace[494624033] 'compare' (duration: 57.915147ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:12:39.042368Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5292} {"level":"info","ts":"2026-10-17T11:12:39.117592Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5292,"took":"73.515282ms","hash":759869942,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":27656192,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-17T11:12:39.117647Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":759869942,"revision":5292,"compact-revision":2962} {"level":"info","ts":"2026-10-17T11:14:33.173046Z","caller":"traceutil/trace.go:171","msg":"trace[1478105675] transaction","detail":"{read_only:false; response_revision:8869; number_of_response:1; }","duration":"104.125297ms","start":"2026-10-17T11:14:33.068883Z","end":"2026-10-17T11:14:33.173008Z","steps":["trace[1478105675] 'process raft request' (duration: 34.161265ms)","trace[1478105675] 'compare' (duration: 69.661885ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:14:33.49833Z","caller":"traceutil/trace.go:171","msg":"trace[1558434200] transaction","detail":"{read_only:false; response_revision:8871; number_of_response:1; }","duration":"111.344293ms","start":"2026-10-17T11:14:33.386957Z","end":"2026-10-17T11:14:33.498301Z","steps":["trace[1558434200] 'process raft request' (duration: 70.289652ms)","trace[1558434200] 'compare' (duration: 40.847426ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:15:02.859469Z","caller":"traceutil/trace.go:171","msg":"trace[1712819813] transaction","detail":"{read_only:false; response_revision:9085; number_of_response:1; }","duration":"146.290328ms","start":"2026-10-17T11:15:02.713151Z","end":"2026-10-17T11:15:02.859441Z","steps":["trace[1712819813] 'process raft request' (duration: 146.048832ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:15:12.447567Z","caller":"traceutil/trace.go:171","msg":"trace[251069239] linearizableReadLoop","detail":"{readStateIndex:9460; appliedIndex:9459; }","duration":"196.33831ms","start":"2026-10-17T11:15:12.251197Z","end":"2026-10-17T11:15:12.447536Z","steps":["trace[251069239] 'read index received' (duration: 196.148405ms)","trace[251069239] 'applied index is now lower than readState.Index' (duration: 188.745µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:15:12.447944Z","caller":"traceutil/trace.go:171","msg":"trace[1363518065] transaction","detail":"{read_only:false; response_revision:9134; number_of_response:1; }","duration":"231.489321ms","start":"2026-10-17T11:15:12.216441Z","end":"2026-10-17T11:15:12.44793Z","steps":["trace[1363518065] 'process raft request' (duration: 230.777263ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:15:12.448259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.038277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:15:12.448328Z","caller":"traceutil/trace.go:171","msg":"trace[79423218] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:9134; }","duration":"197.177761ms","start":"2026-10-17T11:15:12.251113Z","end":"2026-10-17T11:15:12.448291Z","steps":["trace[79423218] 'agreement among raft nodes before linearized reading' (duration: 197.045318ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:15:15.680863Z","caller":"traceutil/trace.go:171","msg":"trace[376624180] transaction","detail":"{read_only:false; number_of_response:1; response_revision:9164; }","duration":"131.102889ms","start":"2026-10-17T11:15:15.549721Z","end":"2026-10-17T11:15:15.680824Z","steps":["trace[376624180] 'process raft request' (duration: 125.187698ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:15:15.834385Z","caller":"traceutil/trace.go:171","msg":"trace[624781896] transaction","detail":"{read_only:false; response_revision:9165; number_of_response:1; }","duration":"284.049408ms","start":"2026-10-17T11:15:15.550315Z","end":"2026-10-17T11:15:15.834364Z","steps":["trace[624781896] 'process raft request' (duration: 283.914375ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:15:15.853275Z","caller":"traceutil/trace.go:171","msg":"trace[191092447] linearizableReadLoop","detail":"{readStateIndex:9494; appliedIndex:9491; }","duration":"113.401825ms","start":"2026-10-17T11:15:15.739859Z","end":"2026-10-17T11:15:15.853261Z","steps":["trace[191092447] 'read index received' (duration: 94.430769ms)","trace[191092447] 'applied index is now lower than readState.Index' (duration: 18.969876ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:15:15.853548Z","caller":"traceutil/trace.go:171","msg":"trace[2145086646] transaction","detail":"{read_only:false; response_revision:9166; number_of_response:1; }","duration":"159.181349ms","start":"2026-10-17T11:15:15.694356Z","end":"2026-10-17T11:15:15.853537Z","steps":["trace[2145086646] 'process raft request' (duration: 158.758907ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:15:15.853761Z","caller":"traceutil/trace.go:171","msg":"trace[1486967020] transaction","detail":"{read_only:false; response_revision:9167; number_of_response:1; }","duration":"123.737071ms","start":"2026-10-17T11:15:15.730012Z","end":"2026-10-17T11:15:15.853749Z","steps":["trace[1486967020] 'process raft request' (duration: 123.173156ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:15:15.855279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.357135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-17T11:15:15.855389Z","caller":"traceutil/trace.go:171","msg":"trace[35836960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9168; }","duration":"115.55144ms","start":"2026-10-17T11:15:15.739822Z","end":"2026-10-17T11:15:15.855373Z","steps":["trace[35836960] 'agreement among raft nodes before linearized reading' (duration: 115.254023ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:15:15.855817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.83576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-17T11:15:15.855884Z","caller":"traceutil/trace.go:171","msg":"trace[671742041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9168; }","duration":"103.937303ms","start":"2026-10-17T11:15:15.751931Z","end":"2026-10-17T11:15:15.855868Z","steps":["trace[671742041] 'agreement among raft nodes before linearized reading' (duration: 103.774628ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:15:17.776731Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000252a.wal"} {"level":"info","ts":"2026-10-17T11:16:11.624056Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dd65ba9af29ebfc9","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:16:11.629733Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-17T11:16:11.629863Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-17T11:17:39.053896Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7989} {"level":"info","ts":"2026-10-17T11:17:39.147324Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7989,"took":"91.273237ms","hash":3580777924,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":26107904,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:17:39.147444Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3580777924,"revision":7989,"compact-revision":5292} {"level":"info","ts":"2026-10-17T11:22:24.262068Z","caller":"traceutil/trace.go:171","msg":"trace[39593795] linearizableReadLoop","detail":"{readStateIndex:12882; appliedIndex:12881; }","duration":"146.886616ms","start":"2026-10-17T11:22:24.115149Z","end":"2026-10-17T11:22:24.262036Z","steps":["trace[39593795] 'read index received' (duration: 146.801374ms)","trace[39593795] 'applied index is now lower than readState.Index' (duration: 83.932µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:22:24.26214Z","caller":"traceutil/trace.go:171","msg":"trace[1731148265] transaction","detail":"{read_only:false; response_revision:12447; number_of_response:1; }","duration":"162.162858ms","start":"2026-10-17T11:22:24.099948Z","end":"2026-10-17T11:22:24.262111Z","steps":["trace[1731148265] 'process raft request' (duration: 161.884931ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:22:24.262423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.200166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-17T11:22:24.262452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.287556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-17T11:22:24.262582Z","caller":"traceutil/trace.go:171","msg":"trace[1138566024] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:12447; }","duration":"142.417141ms","start":"2026-10-17T11:22:24.120143Z","end":"2026-10-17T11:22:24.26256Z","steps":["trace[1138566024] 'agreement among raft nodes before linearized reading' (duration: 142.160435ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:22:24.262633Z","caller":"traceutil/trace.go:171","msg":"trace[740936290] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:12447; }","duration":"147.505952ms","start":"2026-10-17T11:22:24.115108Z","end":"2026-10-17T11:22:24.262614Z","steps":["trace[740936290] 'agreement among raft nodes before linearized reading' (duration: 147.137252ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:22:39.059656Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10410} {"level":"info","ts":"2026-10-17T11:22:39.139798Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10410,"took":"77.657051ms","hash":3838759989,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":25903104,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-17T11:22:39.139869Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3838759989,"revision":10410,"compact-revision":7989} {"level":"info","ts":"2026-10-17T11:27:39.099745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12572} {"level":"info","ts":"2026-10-17T11:27:39.220362Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12572,"took":"117.948581ms","hash":3534158282,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":27209728,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-10-17T11:27:39.220459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3534158282,"revision":12572,"compact-revision":10410} {"level":"info","ts":"2026-10-17T11:28:59.426352Z","caller":"traceutil/trace.go:171","msg":"trace[1051296542] transaction","detail":"{read_only:false; response_revision:15095; number_of_response:1; }","duration":"388.705905ms","start":"2026-10-17T11:28:59.037625Z","end":"2026-10-17T11:28:59.426331Z","steps":["trace[1051296542] 'process raft request' (duration: 388.563071ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:28:59.426458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:28:59.037596Z","time spent":"388.808788ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:28:59.428482Z","caller":"traceutil/trace.go:171","msg":"trace[256581500] transaction","detail":"{read_only:false; response_revision:15096; number_of_response:1; }","duration":"385.572264ms","start":"2026-10-17T11:28:59.042884Z","end":"2026-10-17T11:28:59.428457Z","steps":["trace[256581500] 'process raft request' (duration: 385.437131ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:28:59.429265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:28:59.042844Z","time spent":"385.715709ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:29:10.110126Z","caller":"traceutil/trace.go:171","msg":"trace[719244877] transaction","detail":"{read_only:false; response_revision:15268; number_of_response:1; }","duration":"122.716758ms","start":"2026-10-17T11:29:09.98738Z","end":"2026-10-17T11:29:10.110097Z","steps":["trace[719244877] 'process raft request' (duration: 121.988949ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:10.371639Z","caller":"traceutil/trace.go:171","msg":"trace[312948834] transaction","detail":"{read_only:false; response_revision:15269; number_of_response:1; }","duration":"248.501716ms","start":"2026-10-17T11:29:10.123111Z","end":"2026-10-17T11:29:10.371613Z","steps":["trace[312948834] 'process raft request' (duration: 248.325032ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:10.525872Z","caller":"traceutil/trace.go:171","msg":"trace[2146104508] linearizableReadLoop","detail":"{readStateIndex:15803; appliedIndex:15802; }","duration":"146.794439ms","start":"2026-10-17T11:29:10.379052Z","end":"2026-10-17T11:29:10.525846Z","steps":["trace[2146104508] 'read index received' (duration: 146.648795ms)","trace[2146104508] 'applied index is now lower than readState.Index' (duration: 144.684µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:29:10.52593Z","caller":"traceutil/trace.go:171","msg":"trace[1888854220] transaction","detail":"{read_only:false; response_revision:15270; number_of_response:1; }","duration":"148.363539ms","start":"2026-10-17T11:29:10.377539Z","end":"2026-10-17T11:29:10.525902Z","steps":["trace[1888854220] 'process raft request' (duration: 148.105302ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:29:10.52717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.095352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/ovn-controller-default-f72vt.18df4da53fd20b20\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-10-17T11:29:10.527462Z","caller":"traceutil/trace.go:171","msg":"trace[2009884829] range","detail":"{range_begin:/registry/events/openstack/ovn-controller-default-f72vt.18df4da53fd20b20; range_end:; response_count:1; response_revision:15270; }","duration":"148.198814ms","start":"2026-10-17T11:29:10.379022Z","end":"2026-10-17T11:29:10.52722Z","steps":["trace[2009884829] 'agreement among raft nodes before linearized reading' (duration: 146.935642ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:10.538189Z","caller":"traceutil/trace.go:171","msg":"trace[2056293363] transaction","detail":"{read_only:false; response_revision:15271; number_of_response:1; }","duration":"158.332405ms","start":"2026-10-17T11:29:10.379842Z","end":"2026-10-17T11:29:10.538174Z","steps":["trace[2056293363] 'process raft request' (duration: 158.167651ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:29:10.538367Z","caller":"traceutil/trace.go:171","msg":"trace[528470492] transaction","detail":"{read_only:false; response_revision:15272; number_of_response:1; }","duration":"153.851ms","start":"2026-10-17T11:29:10.384485Z","end":"2026-10-17T11:29:10.538336Z","steps":["trace[528470492] 'process raft request' (duration: 153.634255ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:30:41.487639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.025318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-10-17T11:30:41.487738Z","caller":"traceutil/trace.go:171","msg":"trace[1191404187] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16311; }","duration":"177.194243ms","start":"2026-10-17T11:30:41.310526Z","end":"2026-10-17T11:30:41.48772Z","steps":["trace[1191404187] 'range keys from in-memory index tree' (duration: 176.848984ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:30:41.488119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.348082ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:30:41.488227Z","caller":"traceutil/trace.go:171","msg":"trace[761628287] linearizableReadLoop","detail":"{readStateIndex:16876; appliedIndex:16875; }","duration":"147.695302ms","start":"2026-10-17T11:30:41.340514Z","end":"2026-10-17T11:30:41.488209Z","steps":["trace[761628287] 'read index received' (duration: 47.081932ms)","trace[761628287] 'applied index is now lower than readState.Index' (duration: 100.61227ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:30:41.488323Z","caller":"traceutil/trace.go:171","msg":"trace[996327702] transaction","detail":"{read_only:false; response_revision:16312; number_of_response:1; }","duration":"155.535895ms","start":"2026-10-17T11:30:41.332776Z","end":"2026-10-17T11:30:41.488312Z","steps":["trace[996327702] 'process raft request' (duration: 54.904765ms)","trace[996327702] 'compare' (duration: 100.24055ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:30:41.488475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.94877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-17T11:30:41.488546Z","caller":"traceutil/trace.go:171","msg":"trace[822732613] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16312; }","duration":"148.055082ms","start":"2026-10-17T11:30:41.340471Z","end":"2026-10-17T11:30:41.488526Z","steps":["trace[822732613] 'agreement among raft nodes before linearized reading' (duration: 147.920938ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:30:41.488621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.817356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:30:41.488536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.93744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-17T11:30:41.488758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.569793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-17T11:30:41.488882Z","caller":"traceutil/trace.go:171","msg":"trace[1440390137] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16312; }","duration":"137.717548ms","start":"2026-10-17T11:30:41.351139Z","end":"2026-10-17T11:30:41.488856Z","steps":["trace[1440390137] 'agreement among raft nodes before linearized reading' (duration: 137.39988ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:30:41.488763Z","caller":"traceutil/trace.go:171","msg":"trace[1907684651] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16312; }","duration":"148.178566ms","start":"2026-10-17T11:30:41.34056Z","end":"2026-10-17T11:30:41.488739Z","steps":["trace[1907684651] 'agreement among raft nodes before linearized reading' (duration: 147.883307ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:30:41.488659Z","caller":"traceutil/trace.go:171","msg":"trace[296252627] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16312; }","duration":"147.882708ms","start":"2026-10-17T11:30:41.340767Z","end":"2026-10-17T11:30:41.488649Z","steps":["trace[296252627] 'agreement among raft nodes before linearized reading' (duration: 147.830237ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:30:42.50081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.999271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-17T11:30:42.501126Z","caller":"traceutil/trace.go:171","msg":"trace[958880410] transaction","detail":"{read_only:false; response_revision:16317; number_of_response:1; }","duration":"379.905054ms","start":"2026-10-17T11:30:42.121186Z","end":"2026-10-17T11:30:42.501091Z","steps":["trace[958880410] 'process raft request' (duration: 231.549444ms)","trace[958880410] 'compare' (duration: 147.779765ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:30:42.501349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:30:42.121164Z","time spent":"380.072888ms","remote":"127.0.0.1:38872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417656,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:32:39.105934Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14584} {"level":"info","ts":"2026-10-17T11:32:39.182037Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14584,"took":"73.377729ms","hash":874208178,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":31178752,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T11:32:39.182106Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":874208178,"revision":14584,"compact-revision":12572} {"level":"info","ts":"2026-10-17T11:36:25.201187Z","caller":"traceutil/trace.go:171","msg":"trace[204228429] transaction","detail":"{read_only:false; response_revision:18841; number_of_response:1; }","duration":"222.387674ms","start":"2026-10-17T11:36:24.97875Z","end":"2026-10-17T11:36:25.201138Z","steps":["trace[204228429] 'process raft request' (duration: 138.210011ms)","trace[204228429] 'compare' (duration: 84.047549ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:36:25.201299Z","caller":"traceutil/trace.go:171","msg":"trace[1481863465] linearizableReadLoop","detail":"{readStateIndex:19490; appliedIndex:19489; }","duration":"167.419731ms","start":"2026-10-17T11:36:25.033845Z","end":"2026-10-17T11:36:25.201264Z","steps":["trace[1481863465] 'read index received' (duration: 83.035813ms)","trace[1481863465] 'applied index is now lower than readState.Index' (duration: 84.379858ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:36:25.201439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.578125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:36:25.20173Z","caller":"traceutil/trace.go:171","msg":"trace[1290884929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18842; }","duration":"167.916264ms","start":"2026-10-17T11:36:25.033796Z","end":"2026-10-17T11:36:25.201712Z","steps":["trace[1290884929] 'agreement among raft nodes before linearized reading' (duration: 167.548884ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:36:26.102613Z","caller":"traceutil/trace.go:171","msg":"trace[1832566082] transaction","detail":"{read_only:false; response_revision:18869; number_of_response:1; }","duration":"101.455376ms","start":"2026-10-17T11:36:26.001125Z","end":"2026-10-17T11:36:26.10258Z","steps":["trace[1832566082] 'process raft request' (duration: 50.044306ms)","trace[1832566082] 'compare' (duration: 51.067692ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:36:26.102851Z","caller":"traceutil/trace.go:171","msg":"trace[1240361044] transaction","detail":"{read_only:false; response_revision:18870; number_of_response:1; }","duration":"100.546012ms","start":"2026-10-17T11:36:26.002237Z","end":"2026-10-17T11:36:26.102783Z","steps":["trace[1240361044] 'process raft request' (duration: 100.167033ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:36:31.900495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.477441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-7zkd2\" ","response":"range_response_count:1 size:22126"} {"level":"info","ts":"2026-10-17T11:36:31.90059Z","caller":"traceutil/trace.go:171","msg":"trace[1948662860] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-7zkd2; range_end:; response_count:1; response_revision:18969; }","duration":"128.609194ms","start":"2026-10-17T11:36:31.771956Z","end":"2026-10-17T11:36:31.900565Z","steps":["trace[1948662860] 'range keys from in-memory index tree' (duration: 128.290976ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:36:31.900969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.782238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T11:36:31.901061Z","caller":"traceutil/trace.go:171","msg":"trace[909447702] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:18969; }","duration":"207.90871ms","start":"2026-10-17T11:36:31.693105Z","end":"2026-10-17T11:36:31.901014Z","steps":["trace[909447702] 'count revisions from in-memory index tree' (duration: 207.697576ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:37:00.602592Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dd65ba9af29ebfc9","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:37:00.611532Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-17T11:37:00.611702Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-17T11:37:39.112683Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17049} {"level":"info","ts":"2026-10-17T11:37:39.214183Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17049,"took":"99.309493ms","hash":3859347313,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":34443264,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T11:37:39.214375Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3859347313,"revision":17049,"compact-revision":14584} {"level":"info","ts":"2026-10-17T11:42:03.202026Z","caller":"traceutil/trace.go:171","msg":"trace[142325765] transaction","detail":"{read_only:false; response_revision:21501; number_of_response:1; }","duration":"114.542607ms","start":"2026-10-17T11:42:03.08746Z","end":"2026-10-17T11:42:03.202002Z","steps":["trace[142325765] 'process raft request' (duration: 114.182877ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:03.423227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.813677ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:42:03.423463Z","caller":"traceutil/trace.go:171","msg":"trace[1196267831] linearizableReadLoop","detail":"{readStateIndex:22239; appliedIndex:22237; }","duration":"134.131011ms","start":"2026-10-17T11:42:03.289315Z","end":"2026-10-17T11:42:03.423446Z","steps":["trace[1196267831] 'read index received' (duration: 987.305µs)","trace[1196267831] 'applied index is now lower than readState.Index' (duration: 133.142696ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:03.423554Z","caller":"traceutil/trace.go:171","msg":"trace[27829879] transaction","detail":"{read_only:false; response_revision:21502; number_of_response:1; }","duration":"215.346901ms","start":"2026-10-17T11:42:03.208174Z","end":"2026-10-17T11:42:03.423521Z","steps":["trace[27829879] 'process raft request' (duration: 82.122283ms)","trace[27829879] 'compare' (duration: 132.620251ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:03.423627Z","caller":"traceutil/trace.go:171","msg":"trace[698871077] transaction","detail":"{read_only:false; response_revision:21503; number_of_response:1; }","duration":"188.907801ms","start":"2026-10-17T11:42:03.234708Z","end":"2026-10-17T11:42:03.423616Z","steps":["trace[698871077] 'process raft request' (duration: 188.646864ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:03.423576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.252294ms","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:8"} {"level":"info","ts":"2026-10-17T11:42:03.423824Z","caller":"traceutil/trace.go:171","msg":"trace[1477261793] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:21503; }","duration":"134.536821ms","start":"2026-10-17T11:42:03.289271Z","end":"2026-10-17T11:42:03.423808Z","steps":["trace[1477261793] 'agreement among raft nodes before linearized reading' (duration: 134.228083ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:13.943971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.482357ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-17T11:42:13.944104Z","caller":"traceutil/trace.go:171","msg":"trace[502421165] transaction","detail":"{read_only:false; response_revision:21556; number_of_response:1; }","duration":"151.104868ms","start":"2026-10-17T11:42:13.792978Z","end":"2026-10-17T11:42:13.944082Z","steps":["trace[502421165] 'process raft request' (duration: 48.410795ms)","trace[502421165] 'compare' (duration: 102.162599ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:19.400291Z","caller":"traceutil/trace.go:171","msg":"trace[64367168] transaction","detail":"{read_only:false; response_revision:21585; number_of_response:1; }","duration":"119.814972ms","start":"2026-10-17T11:42:19.280451Z","end":"2026-10-17T11:42:19.400266Z","steps":["trace[64367168] 'process raft request' (duration: 119.643478ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:19.610104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.959155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-17T11:42:19.610448Z","caller":"traceutil/trace.go:171","msg":"trace[533270859] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21585; }","duration":"118.349815ms","start":"2026-10-17T11:42:19.492069Z","end":"2026-10-17T11:42:19.610419Z","steps":["trace[533270859] 'range keys from in-memory index tree' (duration: 117.694538ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:20.149424Z","caller":"traceutil/trace.go:171","msg":"trace[1621926238] linearizableReadLoop","detail":"{readStateIndex:22327; appliedIndex:22326; }","duration":"115.06998ms","start":"2026-10-17T11:42:20.034331Z","end":"2026-10-17T11:42:20.149401Z","steps":["trace[1621926238] 'read index received' (duration: 91.648148ms)","trace[1621926238] 'applied index is now lower than readState.Index' (duration: 23.420692ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:42:20.14956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.225274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:42:20.149595Z","caller":"traceutil/trace.go:171","msg":"trace[1831641416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21588; }","duration":"115.317347ms","start":"2026-10-17T11:42:20.034269Z","end":"2026-10-17T11:42:20.149586Z","steps":["trace[1831641416] 'agreement among raft nodes before linearized reading' (duration: 115.223314ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:20.149561Z","caller":"traceutil/trace.go:171","msg":"trace[1397563784] transaction","detail":"{read_only:false; response_revision:21588; number_of_response:1; }","duration":"176.956602ms","start":"2026-10-17T11:42:19.972564Z","end":"2026-10-17T11:42:20.14952Z","steps":["trace[1397563784] 'process raft request' (duration: 153.417827ms)","trace[1397563784] 'compare' (duration: 23.311839ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:20.445355Z","caller":"traceutil/trace.go:171","msg":"trace[1762665662] linearizableReadLoop","detail":"{readStateIndex:22328; appliedIndex:22327; }","duration":"294.740533ms","start":"2026-10-17T11:42:20.150587Z","end":"2026-10-17T11:42:20.445327Z","steps":["trace[1762665662] 'read index received' (duration: 204.756778ms)","trace[1762665662] 'applied index is now lower than readState.Index' (duration: 89.982284ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:42:20.445598Z","caller":"traceutil/trace.go:171","msg":"trace[1467253339] transaction","detail":"{read_only:false; response_revision:21589; number_of_response:1; }","duration":"350.431865ms","start":"2026-10-17T11:42:20.095027Z","end":"2026-10-17T11:42:20.445459Z","steps":["trace[1467253339] 'process raft request' (duration: 260.283096ms)","trace[1467253339] 'compare' (duration: 89.766969ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:42:20.445598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.993569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:42:20.445668Z","caller":"traceutil/trace.go:171","msg":"trace[1855818439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21589; }","duration":"295.103262ms","start":"2026-10-17T11:42:20.150547Z","end":"2026-10-17T11:42:20.44565Z","steps":["trace[1855818439] 'agreement among raft nodes before linearized reading' (duration: 294.982179ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:20.445821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:42:20.095004Z","time spent":"350.63291ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:42:20.445952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.919998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T11:42:20.445937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.850026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:42:20.446056Z","caller":"traceutil/trace.go:171","msg":"trace[1000753399] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:21589; }","duration":"119.074002ms","start":"2026-10-17T11:42:20.326954Z","end":"2026-10-17T11:42:20.446028Z","steps":["trace[1000753399] 'agreement among raft nodes before linearized reading' (duration: 118.907848ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:20.446103Z","caller":"traceutil/trace.go:171","msg":"trace[737506240] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:21589; }","duration":"105.079193ms","start":"2026-10-17T11:42:20.341005Z","end":"2026-10-17T11:42:20.446084Z","steps":["trace[737506240] 'agreement among raft nodes before linearized reading' (duration: 104.842727ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:42:20.446308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.367629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:42:20.446542Z","caller":"traceutil/trace.go:171","msg":"trace[377233447] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:21589; }","duration":"283.616216ms","start":"2026-10-17T11:42:20.162874Z","end":"2026-10-17T11:42:20.446491Z","steps":["trace[377233447] 'agreement among raft nodes before linearized reading' (duration: 282.881717ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:42:39.125493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19698} {"level":"info","ts":"2026-10-17T11:42:39.255732Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19698,"took":"126.861994ms","hash":2664283093,"current-db-size-bytes":51712000,"current-db-size":"52 MB","current-db-size-in-use-bytes":30040064,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T11:42:39.255809Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2664283093,"revision":19698,"compact-revision":17049} {"level":"info","ts":"2026-10-17T11:47:39.132296Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21687} {"level":"info","ts":"2026-10-17T11:47:39.253074Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21687,"took":"112.771522ms","hash":649203628,"current-db-size-bytes":54435840,"current-db-size":"54 MB","current-db-size-in-use-bytes":43487232,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-10-17T11:47:39.253187Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":649203628,"revision":21687,"compact-revision":19698} {"level":"info","ts":"2026-10-17T11:49:35.742476Z","caller":"traceutil/trace.go:171","msg":"trace[929847059] linearizableReadLoop","detail":"{readStateIndex:26856; appliedIndex:26855; }","duration":"159.648777ms","start":"2026-10-17T11:49:35.582784Z","end":"2026-10-17T11:49:35.742433Z","steps":["trace[929847059] 'read index received' (duration: 159.480083ms)","trace[929847059] 'applied index is now lower than readState.Index' (duration: 167.394µs)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:49:35.742551Z","caller":"traceutil/trace.go:171","msg":"trace[1872518998] transaction","detail":"{read_only:false; response_revision:25992; number_of_response:1; }","duration":"176.792997ms","start":"2026-10-17T11:49:35.565721Z","end":"2026-10-17T11:49:35.742514Z","steps":["trace[1872518998] 'process raft request' (duration: 176.52788ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:49:35.742745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.928935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4799"} {"level":"info","ts":"2026-10-17T11:49:35.742836Z","caller":"traceutil/trace.go:171","msg":"trace[33068084] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:25992; }","duration":"160.064159ms","start":"2026-10-17T11:49:35.58275Z","end":"2026-10-17T11:49:35.742814Z","steps":["trace[33068084] 'agreement among raft nodes before linearized reading' (duration: 159.801122ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:49:35.749049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.974499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-17T11:49:35.749189Z","caller":"traceutil/trace.go:171","msg":"trace[1518203456] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:25993; }","duration":"152.166504ms","start":"2026-10-17T11:49:35.597Z","end":"2026-10-17T11:49:35.749166Z","steps":["trace[1518203456] 'agreement among raft nodes before linearized reading' (duration: 151.932208ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:49:35.7492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.401548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-17T11:49:35.749253Z","caller":"traceutil/trace.go:171","msg":"trace[249001662] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25993; }","duration":"141.48285ms","start":"2026-10-17T11:49:35.607756Z","end":"2026-10-17T11:49:35.749239Z","steps":["trace[249001662] 'agreement among raft nodes before linearized reading' (duration: 141.330516ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:49:35.749366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.868617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3685"} {"level":"info","ts":"2026-10-17T11:49:35.749419Z","caller":"traceutil/trace.go:171","msg":"trace[1948723883] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:25993; }","duration":"151.978959ms","start":"2026-10-17T11:49:35.597426Z","end":"2026-10-17T11:49:35.749405Z","steps":["trace[1948723883] 'agreement among raft nodes before linearized reading' (duration: 151.841826ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:49:42.1272Z","caller":"traceutil/trace.go:171","msg":"trace[2045956515] transaction","detail":"{read_only:false; response_revision:26054; number_of_response:1; }","duration":"112.456883ms","start":"2026-10-17T11:49:42.014718Z","end":"2026-10-17T11:49:42.127175Z","steps":["trace[2045956515] 'process raft request' (duration: 111.930899ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:49:48.100257Z","caller":"traceutil/trace.go:171","msg":"trace[1253888008] linearizableReadLoop","detail":"{readStateIndex:26965; appliedIndex:26964; }","duration":"255.105452ms","start":"2026-10-17T11:49:47.845125Z","end":"2026-10-17T11:49:48.100231Z","steps":["trace[1253888008] 'read index received' (duration: 166.976784ms)","trace[1253888008] 'applied index is now lower than readState.Index' (duration: 88.127148ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:49:48.100487Z","caller":"traceutil/trace.go:171","msg":"trace[386043121] transaction","detail":"{read_only:false; response_revision:26099; number_of_response:1; }","duration":"278.676629ms","start":"2026-10-17T11:49:47.821719Z","end":"2026-10-17T11:49:48.100395Z","steps":["trace[386043121] 'process raft request' (duration: 190.455729ms)","trace[386043121] 'compare' (duration: 87.927903ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:49:48.10056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.40935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-17T11:49:48.10064Z","caller":"traceutil/trace.go:171","msg":"trace[877321725] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26099; }","duration":"255.533403ms","start":"2026-10-17T11:49:47.845088Z","end":"2026-10-17T11:49:48.100621Z","steps":["trace[877321725] 'agreement among raft nodes before linearized reading' (duration: 255.277397ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:49:48.249133Z","caller":"traceutil/trace.go:171","msg":"trace[1804337292] transaction","detail":"{read_only:false; response_revision:26100; number_of_response:1; }","duration":"141.12627ms","start":"2026-10-17T11:49:48.107969Z","end":"2026-10-17T11:49:48.249096Z","steps":["trace[1804337292] 'process raft request' (duration: 139.164639ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:49:48.249146Z","caller":"traceutil/trace.go:171","msg":"trace[1840577723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26100; }","duration":"100.020283ms","start":"2026-10-17T11:49:48.1491Z","end":"2026-10-17T11:49:48.24912Z","steps":["trace[1840577723] 'agreement among raft nodes before linearized reading' (duration: 99.89898ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:49:49.105396Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006969.wal"} {"level":"info","ts":"2026-10-17T11:50:48.206728Z","caller":"traceutil/trace.go:171","msg":"trace[1262418022] transaction","detail":"{read_only:false; response_revision:26678; number_of_response:1; }","duration":"148.096899ms","start":"2026-10-17T11:50:48.058601Z","end":"2026-10-17T11:50:48.206698Z","steps":["trace[1262418022] 'process raft request' (duration: 122.735147ms)","trace[1262418022] 'compare' (duration: 25.25529ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:50:48.48539Z","caller":"traceutil/trace.go:171","msg":"trace[889690416] transaction","detail":"{read_only:false; response_revision:26679; number_of_response:1; }","duration":"147.111983ms","start":"2026-10-17T11:50:48.338248Z","end":"2026-10-17T11:50:48.48536Z","steps":["trace[889690416] 'process raft request' (duration: 126.026801ms)","trace[889690416] 'compare' (duration: 20.763854ms)"],"step_count":2} {"level":"warn","ts":"2026-10-17T11:50:48.664691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.55206ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-10-17T11:50:48.838894Z","caller":"traceutil/trace.go:171","msg":"trace[1898859688] transaction","detail":"{read_only:false; response_revision:26680; number_of_response:1; }","duration":"284.095217ms","start":"2026-10-17T11:50:48.554765Z","end":"2026-10-17T11:50:48.83886Z","steps":["trace[1898859688] 'process raft request' (duration: 283.895112ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:50:48.898772Z","caller":"traceutil/trace.go:171","msg":"trace[1242028382] linearizableReadLoop","detail":"{readStateIndex:27562; appliedIndex:27559; }","duration":"331.690032ms","start":"2026-10-17T11:50:48.567056Z","end":"2026-10-17T11:50:48.898746Z","steps":["trace[1242028382] 'read index received' (duration: 271.631297ms)","trace[1242028382] 'applied index is now lower than readState.Index' (duration: 60.056055ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:50:48.898809Z","caller":"traceutil/trace.go:171","msg":"trace[283780606] transaction","detail":"{read_only:false; response_revision:26681; number_of_response:1; }","duration":"342.710106ms","start":"2026-10-17T11:50:48.55582Z","end":"2026-10-17T11:50:48.89853Z","steps":["trace[283780606] 'process raft request' (duration: 341.579656ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:48.898975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.990898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-17T11:50:48.899024Z","caller":"traceutil/trace.go:171","msg":"trace[1958033164] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:26682; }","duration":"204.059749ms","start":"2026-10-17T11:50:48.694947Z","end":"2026-10-17T11:50:48.899007Z","steps":["trace[1958033164] 'agreement among raft nodes before linearized reading' (duration: 203.975177ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:48.89906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.266296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-10-17T11:50:48.899123Z","caller":"traceutil/trace.go:171","msg":"trace[168093109] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26682; }","duration":"330.357728ms","start":"2026-10-17T11:50:48.568747Z","end":"2026-10-17T11:50:48.899105Z","steps":["trace[168093109] 'agreement among raft nodes before linearized reading' (duration: 330.163433ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:48.899122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:50:48.555802Z","time spent":"343.076646ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-17T11:50:48.899178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:50:48.568708Z","time spent":"330.45253ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-10-17T11:50:48.898822Z","caller":"traceutil/trace.go:171","msg":"trace[422248295] transaction","detail":"{read_only:false; response_revision:26682; number_of_response:1; }","duration":"342.480419ms","start":"2026-10-17T11:50:48.556327Z","end":"2026-10-17T11:50:48.898807Z","steps":["trace[422248295] 'process raft request' (duration: 342.020457ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:48.899174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.052325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-10-17T11:50:48.899399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:50:48.556314Z","time spent":"342.994453ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-17T11:50:48.899434Z","caller":"traceutil/trace.go:171","msg":"trace[66600844] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:26682; }","duration":"261.341832ms","start":"2026-10-17T11:50:48.638073Z","end":"2026-10-17T11:50:48.899415Z","steps":["trace[66600844] 'agreement among raft nodes before linearized reading' (duration: 260.967013ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:48.899664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.374147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-10-17T11:50:48.899792Z","caller":"traceutil/trace.go:171","msg":"trace[161597825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26682; }","duration":"281.517491ms","start":"2026-10-17T11:50:48.618251Z","end":"2026-10-17T11:50:48.899768Z","steps":["trace[161597825] 'agreement among raft nodes before linearized reading' (duration: 280.896576ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:48.901402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.326241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-10-17T11:50:48.901529Z","caller":"traceutil/trace.go:171","msg":"trace[243841359] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26682; }","duration":"334.477955ms","start":"2026-10-17T11:50:48.567007Z","end":"2026-10-17T11:50:48.901485Z","steps":["trace[243841359] 'agreement among raft nodes before linearized reading' (duration: 331.878408ms)"],"step_count":1} {"level":"warn","ts":"2026-10-17T11:50:48.901569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-17T11:50:48.566985Z","time spent":"334.574077ms","remote":"127.0.0.1:35522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-10-17T11:52:39.13885Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24946} {"level":"info","ts":"2026-10-17T11:52:39.310291Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24946,"took":"167.57626ms","hash":3469603543,"current-db-size-bytes":56561664,"current-db-size":"57 MB","current-db-size-in-use-bytes":36724736,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-10-17T11:52:39.310356Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3469603543,"revision":24946,"compact-revision":21687} {"level":"info","ts":"2026-10-17T11:54:27.900967Z","caller":"traceutil/trace.go:171","msg":"trace[310634769] transaction","detail":"{read_only:false; response_revision:28794; number_of_response:1; }","duration":"138.543545ms","start":"2026-10-17T11:54:27.762393Z","end":"2026-10-17T11:54:27.900936Z","steps":["trace[310634769] 'process raft request' (duration: 67.855671ms)","trace[310634769] 'compare' (duration: 70.335785ms)"],"step_count":2} {"level":"info","ts":"2026-10-17T11:54:27.918443Z","caller":"traceutil/trace.go:171","msg":"trace[789113116] transaction","detail":"{read_only:false; response_revision:28795; number_of_response:1; }","duration":"146.249984ms","start":"2026-10-17T11:54:27.772156Z","end":"2026-10-17T11:54:27.918406Z","steps":["trace[789113116] 'process raft request' (duration: 146.014417ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:54:49.879762Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dd65ba9af29ebfc9","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T11:54:49.885793Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-17T11:54:49.885889Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-17T11:55:02.401974Z","caller":"traceutil/trace.go:171","msg":"trace[1987780790] transaction","detail":"{read_only:false; response_revision:29174; number_of_response:1; }","duration":"106.273777ms","start":"2026-10-17T11:55:02.295669Z","end":"2026-10-17T11:55:02.401943Z","steps":["trace[1987780790] 'process raft request' (duration: 106.067842ms)"],"step_count":1} {"level":"info","ts":"2026-10-17T11:57:39.146787Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27757} {"level":"info","ts":"2026-10-17T11:57:39.287781Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27757,"took":"136.139174ms","hash":1116021689,"current-db-size-bytes":57827328,"current-db-size":"58 MB","current-db-size-in-use-bytes":34103296,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-17T11:57:39.287842Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1116021689,"revision":27757,"compact-revision":24946} {"level":"info","ts":"2026-10-17T12:02:39.16592Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30360} {"level":"info","ts":"2026-10-17T12:02:39.312035Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30360,"took":"142.536717ms","hash":3264102341,"current-db-size-bytes":57827328,"current-db-size":"58 MB","current-db-size-in-use-bytes":31064064,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:02:39.312107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3264102341,"revision":30360,"compact-revision":27757} {"level":"info","ts":"2026-10-17T12:07:39.171424Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32710} {"level":"info","ts":"2026-10-17T12:07:39.32959Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32710,"took":"153.431567ms","hash":433123186,"current-db-size-bytes":58871808,"current-db-size":"59 MB","current-db-size-in-use-bytes":30461952,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-17T12:07:39.32968Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":433123186,"revision":32710,"compact-revision":30360} {"level":"info","ts":"2026-10-17T12:12:39.179078Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34973} {"level":"info","ts":"2026-10-17T12:12:39.312381Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34973,"took":"127.446628ms","hash":2573877465,"current-db-size-bytes":58871808,"current-db-size":"59 MB","current-db-size-in-use-bytes":31911936,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:12:39.312498Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2573877465,"revision":34973,"compact-revision":32710} {"level":"info","ts":"2026-10-17T12:15:57.082317Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"dd65ba9af29ebfc9","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-17T12:15:57.088498Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-17T12:15:57.088665Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-17T12:17:39.187288Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37264} {"level":"info","ts":"2026-10-17T12:17:39.331072Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37264,"took":"139.246252ms","hash":4157406356,"current-db-size-bytes":58871808,"current-db-size":"59 MB","current-db-size-in-use-bytes":31322112,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-17T12:17:39.331143Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4157406356,"revision":37264,"compact-revision":34973} {"level":"info","ts":"2026-10-17T12:22:39.195147Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39541} {"level":"info","ts":"2026-10-17T12:22:39.324859Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39541,"took":"125.364413ms","hash":96587729,"current-db-size-bytes":59293696,"current-db-size":"59 MB","current-db-size-in-use-bytes":31666176,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-17T12:22:39.324931Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":96587729,"revision":39541,"compact-revision":37264}