{"level":"warn","ts":"2026-04-08T17:06:18.352965Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T17:06:18.35308Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.35: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://199.19.213.35:2380","--initial-cluster=instance=https://199.19.213.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.35: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-04-08T17:06:18.353158Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T17:06:18.353169Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.35:2380"]} {"level":"info","ts":"2026-04-08T17:06:18.353194Z","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-04-08T17:06:18.354088Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"]} {"level":"info","ts":"2026-04-08T17:06:18.354184Z","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://199.19.213.35:2380"],"listen-peer-urls":["https://199.19.213.35:2380"],"advertise-client-urls":["https://199.19.213.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.35: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-04-08T17:06:18.357869Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.452883ms"} {"level":"info","ts":"2026-04-08T17:06:18.366915Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d1606b245347dc08","cluster-id":"e68e205b85faf98a"} {"level":"info","ts":"2026-04-08T17:06:18.366981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T17:06:18.366999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became follower at term 0"} {"level":"info","ts":"2026-04-08T17:06:18.367009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d1606b245347dc08 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T17:06:18.367021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became follower at term 1"} {"level":"info","ts":"2026-04-08T17:06:18.367053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=(15087176555451374600)"} {"level":"warn","ts":"2026-04-08T17:06:18.372225Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T17:06:18.373565Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T17:06:18.374761Z","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-04-08T17:06:18.378072Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d1606b245347dc08","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T17:06:18.378484Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d1606b245347dc08","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T17:06:18.378602Z","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-04-08T17:06:18.378784Z","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-04-08T17:06:18.37889Z","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-04-08T17:06:18.382309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 switched to configuration voters=(15087176555451374600)"} {"level":"info","ts":"2026-04-08T17:06:18.382947Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e68e205b85faf98a","local-member-id":"d1606b245347dc08","added-peer-id":"d1606b245347dc08","added-peer-peer-urls":["https://199.19.213.35:2380"]} {"level":"info","ts":"2026-04-08T17:06:18.384924Z","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-04-08T17:06:18.384998Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.35:2380"} {"level":"info","ts":"2026-04-08T17:06:18.385036Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.35:2380"} {"level":"info","ts":"2026-04-08T17:06:18.385208Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d1606b245347dc08","initial-advertise-peer-urls":["https://199.19.213.35:2380"],"listen-peer-urls":["https://199.19.213.35:2380"],"advertise-client-urls":["https://199.19.213.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T17:06:18.385272Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T17:06:18.968039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T17:06:18.968125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T17:06:18.968167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 received MsgPreVoteResp from d1606b245347dc08 at term 1"} {"level":"info","ts":"2026-04-08T17:06:18.968188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became candidate at term 2"} {"level":"info","ts":"2026-04-08T17:06:18.968206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 received MsgVoteResp from d1606b245347dc08 at term 2"} {"level":"info","ts":"2026-04-08T17:06:18.968222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d1606b245347dc08 became leader at term 2"} {"level":"info","ts":"2026-04-08T17:06:18.968248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d1606b245347dc08 elected leader d1606b245347dc08 at term 2"} {"level":"info","ts":"2026-04-08T17:06:18.969197Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T17:06:18.970395Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T17:06:18.970399Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d1606b245347dc08","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.35:2379]}","request-path":"/0/members/d1606b245347dc08/attributes","cluster-id":"e68e205b85faf98a","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T17:06:18.970646Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T17:06:18.970893Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T17:06:18.971028Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T17:06:18.971239Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e68e205b85faf98a","local-member-id":"d1606b245347dc08","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T17:06:18.971475Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T17:06:18.971678Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T17:06:18.972749Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.35:2379"} {"level":"info","ts":"2026-04-08T17:06:18.974534Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T17:06:46.24028Z","caller":"traceutil/trace.go:171","msg":"trace[1828588752] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"288.339086ms","start":"2026-04-08T17:06:45.951914Z","end":"2026-04-08T17:06:46.240253Z","steps":["trace[1828588752] 'process raft request' (duration: 288.256634ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:06:46.240301Z","caller":"traceutil/trace.go:171","msg":"trace[767675508] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"291.260046ms","start":"2026-04-08T17:06:45.948986Z","end":"2026-04-08T17:06:46.240246Z","steps":["trace[767675508] 'process raft request' (duration: 198.154327ms)","trace[767675508] 'compare' (duration: 92.758941ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:06:46.241404Z","caller":"traceutil/trace.go:171","msg":"trace[2061400339] transaction","detail":"{read_only:false; response_revision:405; number_of_response:1; }","duration":"273.272653ms","start":"2026-04-08T17:06:45.968123Z","end":"2026-04-08T17:06:46.241395Z","steps":["trace[2061400339] 'process raft request' (duration: 273.219332ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:06:46.241406Z","caller":"traceutil/trace.go:171","msg":"trace[2017744180] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"275.999439ms","start":"2026-04-08T17:06:45.965375Z","end":"2026-04-08T17:06:46.241375Z","steps":["trace[2017744180] 'process raft request' (duration: 275.872376ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:06:46.241567Z","caller":"traceutil/trace.go:171","msg":"trace[1798974392] transaction","detail":"{read_only:false; response_revision:404; number_of_response:1; }","duration":"274.018201ms","start":"2026-04-08T17:06:45.967543Z","end":"2026-04-08T17:06:46.241561Z","steps":["trace[1798974392] 'process raft request' (duration: 273.742195ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:06:46.242522Z","caller":"traceutil/trace.go:171","msg":"trace[1856589888] transaction","detail":"{read_only:false; response_revision:406; number_of_response:1; }","duration":"273.769586ms","start":"2026-04-08T17:06:45.968732Z","end":"2026-04-08T17:06:46.242501Z","steps":["trace[1856589888] 'process raft request' (duration: 272.641129ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:00.383816Z","caller":"traceutil/trace.go:171","msg":"trace[781996215] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"102.411577ms","start":"2026-04-08T17:07:00.281382Z","end":"2026-04-08T17:07:00.383794Z","steps":["trace[781996215] 'process raft request' (duration: 102.296085ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:00.391707Z","caller":"traceutil/trace.go:171","msg":"trace[1276668344] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"100.132312ms","start":"2026-04-08T17:07:00.291558Z","end":"2026-04-08T17:07:00.39169Z","steps":["trace[1276668344] 'process raft request' (duration: 99.659551ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:00.590885Z","caller":"traceutil/trace.go:171","msg":"trace[1696958885] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"145.663252ms","start":"2026-04-08T17:07:00.445195Z","end":"2026-04-08T17:07:00.590858Z","steps":["trace[1696958885] 'process raft request' (duration: 97.415476ms)","trace[1696958885] 'compare' (duration: 47.99728ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:07:00.591121Z","caller":"traceutil/trace.go:171","msg":"trace[483983218] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"137.530253ms","start":"2026-04-08T17:07:00.453565Z","end":"2026-04-08T17:07:00.591095Z","steps":["trace[483983218] 'process raft request' (duration: 137.247706ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:00.591507Z","caller":"traceutil/trace.go:171","msg":"trace[1996615376] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"131.878766ms","start":"2026-04-08T17:07:00.459583Z","end":"2026-04-08T17:07:00.591462Z","steps":["trace[1996615376] 'process raft request' (duration: 131.434795ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:00.591688Z","caller":"traceutil/trace.go:171","msg":"trace[245374548] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"125.800278ms","start":"2026-04-08T17:07:00.46586Z","end":"2026-04-08T17:07:00.59166Z","steps":["trace[245374548] 'process raft request' (duration: 125.617033ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:07:07.032427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.711959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T17:07:07.032566Z","caller":"traceutil/trace.go:171","msg":"trace[1853194766] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"229.206029ms","start":"2026-04-08T17:07:06.803348Z","end":"2026-04-08T17:07:07.032554Z","steps":["trace[1853194766] 'process raft request' (duration: 59.009739ms)","trace[1853194766] 'compare' (duration: 169.611235ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:07:07.199569Z","caller":"traceutil/trace.go:171","msg":"trace[1624853308] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"364.354495ms","start":"2026-04-08T17:07:06.835189Z","end":"2026-04-08T17:07:07.199544Z","steps":["trace[1624853308] 'process raft request' (duration: 344.082651ms)","trace[1624853308] 'compare' (duration: 19.810943ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:07:07.199706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.598876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T17:07:07.199554Z","caller":"traceutil/trace.go:171","msg":"trace[1072525991] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"160.396122ms","start":"2026-04-08T17:07:07.039102Z","end":"2026-04-08T17:07:07.199498Z","steps":["trace[1072525991] 'read index received' (duration: 139.505483ms)","trace[1072525991] 'applied index is now lower than readState.Index' (duration: 20.889669ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:07:07.199752Z","caller":"traceutil/trace.go:171","msg":"trace[154862288] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"160.691358ms","start":"2026-04-08T17:07:07.039049Z","end":"2026-04-08T17:07:07.19974Z","steps":["trace[154862288] 'agreement among raft nodes before linearized reading' (duration: 160.555455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:07:07.199734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:07:06.835109Z","time spent":"364.520629ms","remote":"127.0.0.1:46296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T17:07:07.200082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.355429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T17:07:07.200172Z","caller":"traceutil/trace.go:171","msg":"trace[537281709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"153.496282ms","start":"2026-04-08T17:07:07.046653Z","end":"2026-04-08T17:07:07.200149Z","steps":["trace[537281709] 'agreement among raft nodes before linearized reading' (duration: 153.240576ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:07.665491Z","caller":"traceutil/trace.go:171","msg":"trace[1832585373] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"437.647392ms","start":"2026-04-08T17:07:07.227817Z","end":"2026-04-08T17:07:07.665465Z","steps":["trace[1832585373] 'process raft request' (duration: 388.397892ms)","trace[1832585373] 'compare' (duration: 49.077866ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:07:07.665621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:07:07.227794Z","time spent":"437.774054ms","remote":"127.0.0.1:46378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T17:07:07.713162Z","caller":"traceutil/trace.go:171","msg":"trace[1166341435] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"456.898571ms","start":"2026-04-08T17:07:07.256222Z","end":"2026-04-08T17:07:07.713121Z","steps":["trace[1166341435] 'process raft request' (duration: 456.644095ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:07:07.713384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:07:07.256199Z","time spent":"457.093927ms","remote":"127.0.0.1:46436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T17:07:23.399712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.856047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T17:07:23.399794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.397302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T17:07:23.399812Z","caller":"traceutil/trace.go:171","msg":"trace[970555986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:767; }","duration":"187.004061ms","start":"2026-04-08T17:07:23.212787Z","end":"2026-04-08T17:07:23.399791Z","steps":["trace[970555986] 'range keys from in-memory index tree' (duration: 186.716263ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:23.399867Z","caller":"traceutil/trace.go:171","msg":"trace[839400264] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:767; }","duration":"126.497344ms","start":"2026-04-08T17:07:23.27335Z","end":"2026-04-08T17:07:23.399848Z","steps":["trace[839400264] 'range keys from in-memory index tree' (duration: 126.285449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:07:23.400335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.199944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-08T17:07:23.400465Z","caller":"traceutil/trace.go:171","msg":"trace[1655357850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:767; }","duration":"123.418689ms","start":"2026-04-08T17:07:23.277019Z","end":"2026-04-08T17:07:23.400438Z","steps":["trace[1655357850] 'range keys from in-memory index tree' (duration: 122.905868ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:41.340585Z","caller":"traceutil/trace.go:171","msg":"trace[1659948100] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"128.38466ms","start":"2026-04-08T17:07:41.212186Z","end":"2026-04-08T17:07:41.34057Z","steps":["trace[1659948100] 'read index received' (duration: 128.255537ms)","trace[1659948100] 'applied index is now lower than readState.Index' (duration: 128.293µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:07:41.340666Z","caller":"traceutil/trace.go:171","msg":"trace[728937865] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"129.742974ms","start":"2026-04-08T17:07:41.210915Z","end":"2026-04-08T17:07:41.340658Z","steps":["trace[728937865] 'process raft request' (duration: 129.560079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:07:41.340836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.620645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-08T17:07:41.340885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.524302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-08T17:07:41.340921Z","caller":"traceutil/trace.go:171","msg":"trace[50958146] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1085; }","duration":"128.732038ms","start":"2026-04-08T17:07:41.212171Z","end":"2026-04-08T17:07:41.340903Z","steps":["trace[50958146] 'agreement among raft nodes before linearized reading' (duration: 128.597774ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:07:41.340932Z","caller":"traceutil/trace.go:171","msg":"trace[1673010888] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1085; }","duration":"114.621574ms","start":"2026-04-08T17:07:41.226298Z","end":"2026-04-08T17:07:41.34092Z","steps":["trace[1673010888] 'agreement among raft nodes before linearized reading' (duration: 114.43301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:08:37.3529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.885795ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T17:08:37.353043Z","caller":"traceutil/trace.go:171","msg":"trace[187143534] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1887; }","duration":"139.595286ms","start":"2026-04-08T17:08:37.213427Z","end":"2026-04-08T17:08:37.353022Z","steps":["trace[187143534] 'read index received' (duration: 34.81µs)","trace[187143534] 'applied index is now lower than readState.Index' (duration: 139.558836ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:08:37.353215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.762961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T17:08:37.353339Z","caller":"traceutil/trace.go:171","msg":"trace[50925979] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1816; }","duration":"139.926994ms","start":"2026-04-08T17:08:37.213391Z","end":"2026-04-08T17:08:37.353318Z","steps":["trace[50925979] 'agreement among raft nodes before linearized reading' (duration: 139.737439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:08:37.35338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.627569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0efd3222-23e0-4a8d-8e44-5623d16e6f68\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-08T17:08:37.353129Z","caller":"traceutil/trace.go:171","msg":"trace[1789014287] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"328.717396ms","start":"2026-04-08T17:08:37.024373Z","end":"2026-04-08T17:08:37.35309Z","steps":["trace[1789014287] 'process raft request' (duration: 108.533163ms)","trace[1789014287] 'compare' (duration: 219.764403ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:08:37.353483Z","caller":"traceutil/trace.go:171","msg":"trace[278603339] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0efd3222-23e0-4a8d-8e44-5623d16e6f68; range_end:; response_count:1; response_revision:1816; }","duration":"109.789963ms","start":"2026-04-08T17:08:37.24367Z","end":"2026-04-08T17:08:37.35346Z","steps":["trace[278603339] 'agreement among raft nodes before linearized reading' (duration: 109.515327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:08:37.353669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:08:37.024351Z","time spent":"329.216908ms","remote":"127.0.0.1:46468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T17:08:37.87262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.635441ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-08T17:08:37.873184Z","caller":"traceutil/trace.go:171","msg":"trace[32093186] linearizableReadLoop","detail":"{readStateIndex:1890; appliedIndex:1889; }","duration":"267.576315ms","start":"2026-04-08T17:08:37.605593Z","end":"2026-04-08T17:08:37.873169Z","steps":["trace[32093186] 'read index received' (duration: 56.481µs)","trace[32093186] 'applied index is now lower than readState.Index' (duration: 267.518064ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:08:37.873386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.79319ms","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-04-08T17:08:37.873432Z","caller":"traceutil/trace.go:171","msg":"trace[1250897243] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1817; }","duration":"267.910713ms","start":"2026-04-08T17:08:37.605513Z","end":"2026-04-08T17:08:37.873424Z","steps":["trace[1250897243] 'agreement among raft nodes before linearized reading' (duration: 267.77275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:08:37.873655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.918691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0efd3222-23e0-4a8d-8e44-5623d16e6f68\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-04-08T17:08:37.873665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.235887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T17:08:37.873746Z","caller":"traceutil/trace.go:171","msg":"trace[644475604] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0efd3222-23e0-4a8d-8e44-5623d16e6f68; range_end:; response_count:1; response_revision:1817; }","duration":"229.032553ms","start":"2026-04-08T17:08:37.64469Z","end":"2026-04-08T17:08:37.873723Z","steps":["trace[644475604] 'agreement among raft nodes before linearized reading' (duration: 228.781457ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:08:37.873758Z","caller":"traceutil/trace.go:171","msg":"trace[1098843241] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1817; }","duration":"216.357351ms","start":"2026-04-08T17:08:37.65738Z","end":"2026-04-08T17:08:37.873737Z","steps":["trace[1098843241] 'agreement among raft nodes before linearized reading' (duration: 216.130555ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:08:45.019476Z","caller":"traceutil/trace.go:171","msg":"trace[1189526835] transaction","detail":"{read_only:false; response_revision:1897; number_of_response:1; }","duration":"107.000198ms","start":"2026-04-08T17:08:44.912448Z","end":"2026-04-08T17:08:45.019448Z","steps":["trace[1189526835] 'process raft request' (duration: 25.49841ms)","trace[1189526835] 'compare' (duration: 81.386205ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:08:50.844475Z","caller":"traceutil/trace.go:171","msg":"trace[1244666527] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"236.285416ms","start":"2026-04-08T17:08:50.608145Z","end":"2026-04-08T17:08:50.844431Z","steps":["trace[1244666527] 'process raft request' (duration: 236.124362ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:09:28.378071Z","caller":"traceutil/trace.go:171","msg":"trace[1225867241] transaction","detail":"{read_only:false; response_revision:2147; number_of_response:1; }","duration":"131.052643ms","start":"2026-04-08T17:09:28.246995Z","end":"2026-04-08T17:09:28.378047Z","steps":["trace[1225867241] 'process raft request' (duration: 77.78805ms)","trace[1225867241] 'compare' (duration: 52.689339ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:09:28.383052Z","caller":"traceutil/trace.go:171","msg":"trace[55210670] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"108.564255ms","start":"2026-04-08T17:09:28.274473Z","end":"2026-04-08T17:09:28.383038Z","steps":["trace[55210670] 'process raft request' (duration: 108.33568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:09:28.711292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.196777ms","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:7"} {"level":"info","ts":"2026-04-08T17:09:28.711432Z","caller":"traceutil/trace.go:171","msg":"trace[1705827128] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:2149; }","duration":"211.383402ms","start":"2026-04-08T17:09:28.500023Z","end":"2026-04-08T17:09:28.711407Z","steps":["trace[1705827128] 'count revisions from in-memory index tree' (duration: 211.082684ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:09:28.863314Z","caller":"traceutil/trace.go:171","msg":"trace[959502082] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"148.235012ms","start":"2026-04-08T17:09:28.715052Z","end":"2026-04-08T17:09:28.863287Z","steps":["trace[959502082] 'process raft request' (duration: 148.055197ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:10:52.939986Z","caller":"traceutil/trace.go:171","msg":"trace[1636258765] transaction","detail":"{read_only:false; response_revision:2801; number_of_response:1; }","duration":"204.689231ms","start":"2026-04-08T17:10:52.73527Z","end":"2026-04-08T17:10:52.939959Z","steps":["trace[1636258765] 'process raft request' (duration: 123.637004ms)","trace[1636258765] 'compare' (duration: 80.676379ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:13:13.667808Z","caller":"traceutil/trace.go:171","msg":"trace[1475933814] transaction","detail":"{read_only:false; response_revision:3745; number_of_response:1; }","duration":"112.916476ms","start":"2026-04-08T17:13:13.554862Z","end":"2026-04-08T17:13:13.667779Z","steps":["trace[1475933814] 'process raft request' (duration: 112.731382ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:14:42.646034Z","caller":"traceutil/trace.go:171","msg":"trace[740768655] linearizableReadLoop","detail":"{readStateIndex:4990; appliedIndex:4989; }","duration":"118.088005ms","start":"2026-04-08T17:14:42.527923Z","end":"2026-04-08T17:14:42.646011Z","steps":["trace[740768655] 'read index received' (duration: 87.259506ms)","trace[740768655] 'applied index is now lower than readState.Index' (duration: 30.827579ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:14:42.64607Z","caller":"traceutil/trace.go:171","msg":"trace[428673125] transaction","detail":"{read_only:false; response_revision:4805; number_of_response:1; }","duration":"119.566621ms","start":"2026-04-08T17:14:42.526458Z","end":"2026-04-08T17:14:42.646025Z","steps":["trace[428673125] 'process raft request' (duration: 88.165668ms)","trace[428673125] 'compare' (duration: 31.26982ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:14:42.646315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.374281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62904"} {"level":"info","ts":"2026-04-08T17:14:42.646358Z","caller":"traceutil/trace.go:171","msg":"trace[1953480107] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4805; }","duration":"118.439523ms","start":"2026-04-08T17:14:42.527907Z","end":"2026-04-08T17:14:42.646347Z","steps":["trace[1953480107] 'agreement among raft nodes before linearized reading' (duration: 118.190457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:14:42.651955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.939607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:2643"} {"level":"info","ts":"2026-04-08T17:14:42.65202Z","caller":"traceutil/trace.go:171","msg":"trace[1524198782] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4806; }","duration":"124.03732ms","start":"2026-04-08T17:14:42.527974Z","end":"2026-04-08T17:14:42.652012Z","steps":["trace[1524198782] 'agreement among raft nodes before linearized reading' (duration: 123.904797ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:14:42.652218Z","caller":"traceutil/trace.go:171","msg":"trace[619864470] transaction","detail":"{read_only:false; response_revision:4806; number_of_response:1; }","duration":"117.749146ms","start":"2026-04-08T17:14:42.534461Z","end":"2026-04-08T17:14:42.65221Z","steps":["trace[619864470] 'process raft request' (duration: 117.318065ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:14:47.242984Z","caller":"traceutil/trace.go:171","msg":"trace[1810274748] linearizableReadLoop","detail":"{readStateIndex:5166; appliedIndex:5165; }","duration":"120.436272ms","start":"2026-04-08T17:14:47.122522Z","end":"2026-04-08T17:14:47.242959Z","steps":["trace[1810274748] 'read index received' (duration: 120.237457ms)","trace[1810274748] 'applied index is now lower than readState.Index' (duration: 197.495µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:14:47.243291Z","caller":"traceutil/trace.go:171","msg":"trace[1520581042] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"126.033879ms","start":"2026-04-08T17:14:47.117243Z","end":"2026-04-08T17:14:47.243277Z","steps":["trace[1520581042] 'process raft request' (duration: 125.580928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:14:47.243748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.20071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-08T17:14:47.243843Z","caller":"traceutil/trace.go:171","msg":"trace[1348850325] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4976; }","duration":"121.334704ms","start":"2026-04-08T17:14:47.122483Z","end":"2026-04-08T17:14:47.243818Z","steps":["trace[1348850325] 'agreement among raft nodes before linearized reading' (duration: 121.038916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:14:56.860306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.993069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-tg8b2\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-08T17:14:56.860432Z","caller":"traceutil/trace.go:171","msg":"trace[621052598] range","detail":"{range_begin:/registry/pods/openstack/keepalived-tg8b2; range_end:; response_count:1; response_revision:5172; }","duration":"141.166653ms","start":"2026-04-08T17:14:56.719237Z","end":"2026-04-08T17:14:56.860404Z","steps":["trace[621052598] 'range keys from in-memory index tree' (duration: 140.794693ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:05.46644Z","caller":"traceutil/trace.go:171","msg":"trace[1346465051] linearizableReadLoop","detail":"{readStateIndex:5546; appliedIndex:5545; }","duration":"116.981857ms","start":"2026-04-08T17:15:05.349434Z","end":"2026-04-08T17:15:05.466416Z","steps":["trace[1346465051] 'read index received' (duration: 116.707931ms)","trace[1346465051] 'applied index is now lower than readState.Index' (duration: 272.616µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:15:05.46648Z","caller":"traceutil/trace.go:171","msg":"trace[1890629674] transaction","detail":"{read_only:false; response_revision:5344; number_of_response:1; }","duration":"140.26733ms","start":"2026-04-08T17:15:05.326185Z","end":"2026-04-08T17:15:05.466452Z","steps":["trace[1890629674] 'process raft request' (duration: 140.072906ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:05.466765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.301015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-04-08T17:15:05.466835Z","caller":"traceutil/trace.go:171","msg":"trace[829174227] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5344; }","duration":"117.426858ms","start":"2026-04-08T17:15:05.349393Z","end":"2026-04-08T17:15:05.46682Z","steps":["trace[829174227] 'agreement among raft nodes before linearized reading' (duration: 117.134821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:05.756794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.749913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T17:15:05.756933Z","caller":"traceutil/trace.go:171","msg":"trace[1039082482] transaction","detail":"{read_only:false; response_revision:5345; number_of_response:1; }","duration":"285.486722ms","start":"2026-04-08T17:15:05.471415Z","end":"2026-04-08T17:15:05.756901Z","steps":["trace[1039082482] 'process raft request' (duration: 137.557283ms)","trace[1039082482] 'compare' (duration: 147.574979ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:15:05.756977Z","caller":"traceutil/trace.go:171","msg":"trace[1303577994] transaction","detail":"{read_only:false; response_revision:5346; number_of_response:1; }","duration":"129.789782ms","start":"2026-04-08T17:15:05.627163Z","end":"2026-04-08T17:15:05.756953Z","steps":["trace[1303577994] 'process raft request' (duration: 129.741251ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:05.756988Z","caller":"traceutil/trace.go:171","msg":"trace[1504705251] linearizableReadLoop","detail":"{readStateIndex:5547; appliedIndex:5546; }","duration":"284.353384ms","start":"2026-04-08T17:15:05.472594Z","end":"2026-04-08T17:15:05.756947Z","steps":["trace[1504705251] 'read index received' (duration: 136.378684ms)","trace[1504705251] 'applied index is now lower than readState.Index' (duration: 147.97127ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:15:05.75726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.632031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-04-08T17:15:05.757348Z","caller":"traceutil/trace.go:171","msg":"trace[1877529826] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5346; }","duration":"284.773004ms","start":"2026-04-08T17:15:05.472551Z","end":"2026-04-08T17:15:05.757324Z","steps":["trace[1877529826] 'agreement among raft nodes before linearized reading' (duration: 284.523248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:05.757286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.187497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2b1a5bc-056a-4391-84f0-2a7e447d4a3d\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-08T17:15:05.757425Z","caller":"traceutil/trace.go:171","msg":"trace[433680525] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2b1a5bc-056a-4391-84f0-2a7e447d4a3d; range_end:; response_count:1; response_revision:5346; }","duration":"277.362391ms","start":"2026-04-08T17:15:05.480048Z","end":"2026-04-08T17:15:05.757411Z","steps":["trace[433680525] 'agreement among raft nodes before linearized reading' (duration: 277.080274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:05.757284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.624948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c2b1a5bc-056a-4391-84f0-2a7e447d4a3d\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-08T17:15:05.757589Z","caller":"traceutil/trace.go:171","msg":"trace[1351733757] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c2b1a5bc-056a-4391-84f0-2a7e447d4a3d; range_end:; response_count:1; response_revision:5346; }","duration":"203.939016ms","start":"2026-04-08T17:15:05.55363Z","end":"2026-04-08T17:15:05.757569Z","steps":["trace[1351733757] 'agreement among raft nodes before linearized reading' (duration: 203.510946ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:05.887453Z","caller":"traceutil/trace.go:171","msg":"trace[453637186] linearizableReadLoop","detail":"{readStateIndex:5549; appliedIndex:5548; }","duration":"122.078682ms","start":"2026-04-08T17:15:05.76535Z","end":"2026-04-08T17:15:05.887429Z","steps":["trace[453637186] 'read index received' (duration: 117.336405ms)","trace[453637186] 'applied index is now lower than readState.Index' (duration: 4.741197ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:15:05.887619Z","caller":"traceutil/trace.go:171","msg":"trace[1444298937] transaction","detail":"{read_only:false; response_revision:5347; number_of_response:1; }","duration":"122.646257ms","start":"2026-04-08T17:15:05.76494Z","end":"2026-04-08T17:15:05.887586Z","steps":["trace[1444298937] 'process raft request' (duration: 117.858318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:05.88772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.346158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-08T17:15:05.88779Z","caller":"traceutil/trace.go:171","msg":"trace[902736046] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5347; }","duration":"122.443651ms","start":"2026-04-08T17:15:05.765328Z","end":"2026-04-08T17:15:05.887772Z","steps":["trace[902736046] 'agreement among raft nodes before linearized reading' (duration: 122.232436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:06.154414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.934294ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T17:15:06.154526Z","caller":"traceutil/trace.go:171","msg":"trace[2064832095] linearizableReadLoop","detail":"{readStateIndex:5550; appliedIndex:5549; }","duration":"261.601324ms","start":"2026-04-08T17:15:05.89291Z","end":"2026-04-08T17:15:06.154511Z","steps":["trace[2064832095] 'read index received' (duration: 116.499856ms)","trace[2064832095] 'applied index is now lower than readState.Index' (duration: 145.100428ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:15:06.154754Z","caller":"traceutil/trace.go:171","msg":"trace[1918758452] transaction","detail":"{read_only:false; response_revision:5348; number_of_response:1; }","duration":"262.909347ms","start":"2026-04-08T17:15:05.891834Z","end":"2026-04-08T17:15:06.154744Z","steps":["trace[1918758452] 'process raft request' (duration: 117.572112ms)","trace[1918758452] 'compare' (duration: 144.800871ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:15:06.155023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.086747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-04-08T17:15:06.155231Z","caller":"traceutil/trace.go:171","msg":"trace[621872874] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:5348; }","duration":"262.336583ms","start":"2026-04-08T17:15:05.892869Z","end":"2026-04-08T17:15:06.155206Z","steps":["trace[621872874] 'agreement among raft nodes before linearized reading' (duration: 261.971204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:06.155385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.479276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-08T17:15:06.155423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.368914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-08T17:15:06.155476Z","caller":"traceutil/trace.go:171","msg":"trace[225175421] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5348; }","duration":"201.612559ms","start":"2026-04-08T17:15:05.953843Z","end":"2026-04-08T17:15:06.155456Z","steps":["trace[225175421] 'agreement among raft nodes before linearized reading' (duration: 201.357673ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:06.155516Z","caller":"traceutil/trace.go:171","msg":"trace[1813713184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5348; }","duration":"199.504336ms","start":"2026-04-08T17:15:05.955991Z","end":"2026-04-08T17:15:06.155495Z","steps":["trace[1813713184] 'agreement among raft nodes before linearized reading' (duration: 199.23446ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:06.387614Z","caller":"traceutil/trace.go:171","msg":"trace[236912717] transaction","detail":"{read_only:false; response_revision:5351; number_of_response:1; }","duration":"227.367153ms","start":"2026-04-08T17:15:06.16023Z","end":"2026-04-08T17:15:06.387598Z","steps":["trace[236912717] 'process raft request' (duration: 227.288311ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:06.387638Z","caller":"traceutil/trace.go:171","msg":"trace[341174062] transaction","detail":"{read_only:false; response_revision:5350; number_of_response:1; }","duration":"228.108991ms","start":"2026-04-08T17:15:06.1595Z","end":"2026-04-08T17:15:06.387609Z","steps":["trace[341174062] 'process raft request' (duration: 227.963437ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:06.38768Z","caller":"traceutil/trace.go:171","msg":"trace[602648555] transaction","detail":"{read_only:false; response_revision:5349; number_of_response:1; }","duration":"228.91763ms","start":"2026-04-08T17:15:06.158747Z","end":"2026-04-08T17:15:06.387664Z","steps":["trace[602648555] 'process raft request' (duration: 136.533098ms)","trace[602648555] 'compare' (duration: 92.015483ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:15:06.387814Z","caller":"traceutil/trace.go:171","msg":"trace[1194840721] linearizableReadLoop","detail":"{readStateIndex:5552; appliedIndex:5550; }","duration":"228.262645ms","start":"2026-04-08T17:15:06.159543Z","end":"2026-04-08T17:15:06.387806Z","steps":["trace[1194840721] 'read index received' (duration: 135.748449ms)","trace[1194840721] 'applied index is now lower than readState.Index' (duration: 92.513526ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:15:06.387877Z","caller":"traceutil/trace.go:171","msg":"trace[262440420] transaction","detail":"{read_only:false; response_revision:5352; number_of_response:1; }","duration":"227.219898ms","start":"2026-04-08T17:15:06.160648Z","end":"2026-04-08T17:15:06.387868Z","steps":["trace[262440420] 'process raft request' (duration: 226.922341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:06.388137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.560642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"warn","ts":"2026-04-08T17:15:06.388184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.139483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T17:15:06.388222Z","caller":"traceutil/trace.go:171","msg":"trace[70060215] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:5352; }","duration":"228.662134ms","start":"2026-04-08T17:15:06.159538Z","end":"2026-04-08T17:15:06.3882Z","steps":["trace[70060215] 'agreement among raft nodes before linearized reading' (duration: 228.386648ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:06.388245Z","caller":"traceutil/trace.go:171","msg":"trace[1649475652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5353; }","duration":"174.251626ms","start":"2026-04-08T17:15:06.213977Z","end":"2026-04-08T17:15:06.388229Z","steps":["trace[1649475652] 'agreement among raft nodes before linearized reading' (duration: 174.101132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:15:06.388251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.879413ms","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-04-08T17:15:06.388287Z","caller":"traceutil/trace.go:171","msg":"trace[1213721474] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5353; }","duration":"135.966194ms","start":"2026-04-08T17:15:06.252313Z","end":"2026-04-08T17:15:06.388279Z","steps":["trace[1213721474] 'agreement among raft nodes before linearized reading' (duration: 135.80167ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:19.844693Z","caller":"traceutil/trace.go:171","msg":"trace[1049111953] transaction","detail":"{read_only:false; response_revision:5526; number_of_response:1; }","duration":"113.47158ms","start":"2026-04-08T17:15:19.731198Z","end":"2026-04-08T17:15:19.84467Z","steps":["trace[1049111953] 'process raft request' (duration: 77.006064ms)","trace[1049111953] 'compare' (duration: 36.272532ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:15:19.844991Z","caller":"traceutil/trace.go:171","msg":"trace[968895545] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"113.700596ms","start":"2026-04-08T17:15:19.731265Z","end":"2026-04-08T17:15:19.844966Z","steps":["trace[968895545] 'process raft request' (duration: 113.357407ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:15:19.845123Z","caller":"traceutil/trace.go:171","msg":"trace[981809927] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"113.724318ms","start":"2026-04-08T17:15:19.731371Z","end":"2026-04-08T17:15:19.845095Z","steps":["trace[981809927] 'process raft request' (duration: 113.505741ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:16:18.994287Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2945} {"level":"info","ts":"2026-04-08T17:16:19.065662Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2945,"took":"70.152695ms","hash":3840268662,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":33492992,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-08T17:16:19.065727Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3840268662,"revision":2945,"compact-revision":-1} {"level":"info","ts":"2026-04-08T17:21:19.000557Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6009} {"level":"info","ts":"2026-04-08T17:21:19.095707Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6009,"took":"92.240399ms","hash":3427630771,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":23629824,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-08T17:21:19.095789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3427630771,"revision":6009,"compact-revision":2945} {"level":"info","ts":"2026-04-08T17:21:29.836092Z","caller":"traceutil/trace.go:171","msg":"trace[465456098] transaction","detail":"{read_only:false; response_revision:8286; number_of_response:1; }","duration":"111.401236ms","start":"2026-04-08T17:21:29.724667Z","end":"2026-04-08T17:21:29.836069Z","steps":["trace[465456098] 'process raft request' (duration: 111.233332ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:21:29.870913Z","caller":"traceutil/trace.go:171","msg":"trace[1192099423] transaction","detail":"{read_only:false; response_revision:8287; number_of_response:1; }","duration":"134.617879ms","start":"2026-04-08T17:21:29.736258Z","end":"2026-04-08T17:21:29.870876Z","steps":["trace[1192099423] 'process raft request' (duration: 134.340283ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:21:29.870913Z","caller":"traceutil/trace.go:171","msg":"trace[1355257690] transaction","detail":"{read_only:false; response_revision:8288; number_of_response:1; }","duration":"127.322776ms","start":"2026-04-08T17:21:29.743567Z","end":"2026-04-08T17:21:29.87089Z","steps":["trace[1355257690] 'process raft request' (duration: 127.225693ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:21:30.315692Z","caller":"traceutil/trace.go:171","msg":"trace[400574574] linearizableReadLoop","detail":"{readStateIndex:8586; appliedIndex:8585; }","duration":"180.661177ms","start":"2026-04-08T17:21:30.135008Z","end":"2026-04-08T17:21:30.315669Z","steps":["trace[400574574] 'read index received' (duration: 180.419381ms)","trace[400574574] 'applied index is now lower than readState.Index' (duration: 240.756µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:21:30.315767Z","caller":"traceutil/trace.go:171","msg":"trace[564130427] transaction","detail":"{read_only:false; response_revision:8291; number_of_response:1; }","duration":"185.283037ms","start":"2026-04-08T17:21:30.130462Z","end":"2026-04-08T17:21:30.315745Z","steps":["trace[564130427] 'process raft request' (duration: 185.054942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:21:30.315927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.898773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-08T17:21:30.315966Z","caller":"traceutil/trace.go:171","msg":"trace[1066776837] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8291; }","duration":"180.989445ms","start":"2026-04-08T17:21:30.134967Z","end":"2026-04-08T17:21:30.315957Z","steps":["trace[1066776837] 'agreement among raft nodes before linearized reading' (duration: 180.845631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:21:30.316059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.164833ms","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-04-08T17:21:30.316161Z","caller":"traceutil/trace.go:171","msg":"trace[642032194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8291; }","duration":"174.315807ms","start":"2026-04-08T17:21:30.141822Z","end":"2026-04-08T17:21:30.316138Z","steps":["trace[642032194] 'agreement among raft nodes before linearized reading' (duration: 174.073121ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:21:30.466552Z","caller":"traceutil/trace.go:171","msg":"trace[1289929787] linearizableReadLoop","detail":"{readStateIndex:8588; appliedIndex:8586; }","duration":"117.04051ms","start":"2026-04-08T17:21:30.349495Z","end":"2026-04-08T17:21:30.466535Z","steps":["trace[1289929787] 'read index received' (duration: 64.256891ms)","trace[1289929787] 'applied index is now lower than readState.Index' (duration: 52.782748ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:21:30.46662Z","caller":"traceutil/trace.go:171","msg":"trace[907510442] transaction","detail":"{read_only:false; response_revision:8293; number_of_response:1; }","duration":"145.624062ms","start":"2026-04-08T17:21:30.320972Z","end":"2026-04-08T17:21:30.466596Z","steps":["trace[907510442] 'process raft request' (duration: 145.53295ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:21:30.466624Z","caller":"traceutil/trace.go:171","msg":"trace[977199038] transaction","detail":"{read_only:false; response_revision:8292; number_of_response:1; }","duration":"146.166015ms","start":"2026-04-08T17:21:30.320412Z","end":"2026-04-08T17:21:30.466578Z","steps":["trace[977199038] 'process raft request' (duration: 93.317524ms)","trace[977199038] 'compare' (duration: 52.679997ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:21:30.466723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.210043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-08T17:21:30.466761Z","caller":"traceutil/trace.go:171","msg":"trace[863281138] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8293; }","duration":"117.283396ms","start":"2026-04-08T17:21:30.349465Z","end":"2026-04-08T17:21:30.466748Z","steps":["trace[863281138] 'agreement among raft nodes before linearized reading' (duration: 117.136642ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:21:46.500879Z","caller":"traceutil/trace.go:171","msg":"trace[1397973977] transaction","detail":"{read_only:false; response_revision:8383; number_of_response:1; }","duration":"118.073585ms","start":"2026-04-08T17:21:46.382782Z","end":"2026-04-08T17:21:46.500856Z","steps":["trace[1397973977] 'process raft request' (duration: 106.53839ms)","trace[1397973977] 'compare' (duration: 11.453143ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:21:56.199282Z","caller":"traceutil/trace.go:171","msg":"trace[2011349375] transaction","detail":"{read_only:false; response_revision:8483; number_of_response:1; }","duration":"159.748449ms","start":"2026-04-08T17:21:56.039503Z","end":"2026-04-08T17:21:56.199252Z","steps":["trace[2011349375] 'process raft request' (duration: 149.687299ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:21:59.589673Z","caller":"traceutil/trace.go:171","msg":"trace[1701713218] linearizableReadLoop","detail":"{readStateIndex:8801; appliedIndex:8800; }","duration":"206.957044ms","start":"2026-04-08T17:21:59.382693Z","end":"2026-04-08T17:21:59.58965Z","steps":["trace[1701713218] 'read index received' (duration: 206.745439ms)","trace[1701713218] 'applied index is now lower than readState.Index' (duration: 210.295µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:21:59.58974Z","caller":"traceutil/trace.go:171","msg":"trace[1819637559] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"207.029016ms","start":"2026-04-08T17:21:59.382665Z","end":"2026-04-08T17:21:59.589694Z","steps":["trace[1819637559] 'process raft request' (duration: 206.77076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:21:59.589915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.198559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-08T17:21:59.589959Z","caller":"traceutil/trace.go:171","msg":"trace[816618419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8498; }","duration":"207.284362ms","start":"2026-04-08T17:21:59.382662Z","end":"2026-04-08T17:21:59.589947Z","steps":["trace[816618419] 'agreement among raft nodes before linearized reading' (duration: 207.127068ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:21:59.589985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.2093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T17:21:59.590253Z","caller":"traceutil/trace.go:171","msg":"trace[1562100080] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:8498; }","duration":"207.55282ms","start":"2026-04-08T17:21:59.382679Z","end":"2026-04-08T17:21:59.590232Z","steps":["trace[1562100080] 'agreement among raft nodes before linearized reading' (duration: 207.20686ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:21:59.736404Z","caller":"traceutil/trace.go:171","msg":"trace[452879878] transaction","detail":"{read_only:false; response_revision:8500; number_of_response:1; }","duration":"122.403849ms","start":"2026-04-08T17:21:59.61398Z","end":"2026-04-08T17:21:59.736384Z","steps":["trace[452879878] 'process raft request' (duration: 113.456395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:02.47568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.739376ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-04-08T17:22:02.475785Z","caller":"traceutil/trace.go:171","msg":"trace[962334532] linearizableReadLoop","detail":"{readStateIndex:8820; appliedIndex:8819; }","duration":"376.754995ms","start":"2026-04-08T17:22:02.099014Z","end":"2026-04-08T17:22:02.475769Z","steps":["trace[962334532] 'read index received' (duration: 134.845615ms)","trace[962334532] 'applied index is now lower than readState.Index' (duration: 241.90787ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:22:02.475808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:22:02.085067Z","time spent":"390.731897ms","remote":"127.0.0.1:46228","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-08T17:22:02.475922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.609699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T17:22:02.476034Z","caller":"traceutil/trace.go:171","msg":"trace[990430688] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8516; }","duration":"264.755033ms","start":"2026-04-08T17:22:02.211266Z","end":"2026-04-08T17:22:02.476021Z","steps":["trace[990430688] 'agreement among raft nodes before linearized reading' (duration: 264.598439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:02.4761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.191994ms","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-04-08T17:22:02.476178Z","caller":"traceutil/trace.go:171","msg":"trace[95283222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8516; }","duration":"252.336857ms","start":"2026-04-08T17:22:02.223824Z","end":"2026-04-08T17:22:02.47616Z","steps":["trace[95283222] 'agreement among raft nodes before linearized reading' (duration: 252.118672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:02.476651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.617005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-08T17:22:02.476722Z","caller":"traceutil/trace.go:171","msg":"trace[1844738540] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:8516; }","duration":"377.716577ms","start":"2026-04-08T17:22:02.098987Z","end":"2026-04-08T17:22:02.476703Z","steps":["trace[1844738540] 'agreement among raft nodes before linearized reading' (duration: 376.854697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:02.476759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:22:02.098974Z","time spent":"377.776559ms","remote":"127.0.0.1:46354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" "} {"level":"warn","ts":"2026-04-08T17:22:02.725502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.134481ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T17:22:02.725673Z","caller":"traceutil/trace.go:171","msg":"trace[638961207] linearizableReadLoop","detail":"{readStateIndex:8821; appliedIndex:8820; }","duration":"245.506645ms","start":"2026-04-08T17:22:02.480144Z","end":"2026-04-08T17:22:02.725651Z","steps":["trace[638961207] 'read index received' (duration: 121.135119ms)","trace[638961207] 'applied index is now lower than readState.Index' (duration: 124.369586ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:22:02.725807Z","caller":"traceutil/trace.go:171","msg":"trace[2047003530] transaction","detail":"{read_only:false; response_revision:8517; number_of_response:1; }","duration":"248.709741ms","start":"2026-04-08T17:22:02.47704Z","end":"2026-04-08T17:22:02.72575Z","steps":["trace[2047003530] 'process raft request' (duration: 124.227502ms)","trace[2047003530] 'compare' (duration: 123.947046ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:22:02.726004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.839783ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-ec857cb8-906e-44fe-88f3-89bf34926342\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-08T17:22:02.726089Z","caller":"traceutil/trace.go:171","msg":"trace[742235634] range","detail":"{range_begin:/registry/persistentvolumes/pvc-ec857cb8-906e-44fe-88f3-89bf34926342; range_end:; response_count:1; response_revision:8517; }","duration":"245.968256ms","start":"2026-04-08T17:22:02.480098Z","end":"2026-04-08T17:22:02.726066Z","steps":["trace[742235634] 'agreement among raft nodes before linearized reading' (duration: 245.674589ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:22:02.892515Z","caller":"traceutil/trace.go:171","msg":"trace[788964030] linearizableReadLoop","detail":"{readStateIndex:8822; appliedIndex:8821; }","duration":"166.784503ms","start":"2026-04-08T17:22:02.725713Z","end":"2026-04-08T17:22:02.892497Z","steps":["trace[788964030] 'read index received' (duration: 137.687832ms)","trace[788964030] 'applied index is now lower than readState.Index' (duration: 29.096021ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:22:02.892692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.63292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-08T17:22:02.892726Z","caller":"traceutil/trace.go:171","msg":"trace[141321072] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:8518; }","duration":"328.715623ms","start":"2026-04-08T17:22:02.564003Z","end":"2026-04-08T17:22:02.892719Z","steps":["trace[141321072] 'agreement among raft nodes before linearized reading' (duration: 328.58726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:02.89275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:22:02.563988Z","time spent":"328.756163ms","remote":"127.0.0.1:46646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":11,"response size":31,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-04-08T17:22:02.892722Z","caller":"traceutil/trace.go:171","msg":"trace[293929928] transaction","detail":"{read_only:false; response_revision:8518; number_of_response:1; }","duration":"412.34338ms","start":"2026-04-08T17:22:02.480347Z","end":"2026-04-08T17:22:02.89269Z","steps":["trace[293929928] 'process raft request' (duration: 383.034094ms)","trace[293929928] 'compare' (duration: 29.013289ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:22:02.892768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.560659ms","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-04-08T17:22:02.892812Z","caller":"traceutil/trace.go:171","msg":"trace[148667642] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8518; }","duration":"323.629021ms","start":"2026-04-08T17:22:02.569171Z","end":"2026-04-08T17:22:02.8928Z","steps":["trace[148667642] 'agreement among raft nodes before linearized reading' (duration: 323.406016ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:02.892815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.993758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-08T17:22:02.892844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:22:02.569161Z","time spent":"323.675482ms","remote":"127.0.0.1:46468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-08T17:22:02.892867Z","caller":"traceutil/trace.go:171","msg":"trace[457058171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8518; }","duration":"281.100821ms","start":"2026-04-08T17:22:02.611753Z","end":"2026-04-08T17:22:02.892854Z","steps":["trace[457058171] 'agreement among raft nodes before linearized reading' (duration: 280.875565ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:02.892873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T17:22:02.48033Z","time spent":"412.463162ms","remote":"127.0.0.1:46468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T17:22:02.892971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.134337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-04-08T17:22:02.893089Z","caller":"traceutil/trace.go:171","msg":"trace[1882714531] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8518; }","duration":"163.314592ms","start":"2026-04-08T17:22:02.729745Z","end":"2026-04-08T17:22:02.893059Z","steps":["trace[1882714531] 'agreement among raft nodes before linearized reading' (duration: 162.979084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:02.893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.757329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-08T17:22:02.893168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.34171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-04-08T17:22:02.893194Z","caller":"traceutil/trace.go:171","msg":"trace[1580820561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8518; }","duration":"266.987906ms","start":"2026-04-08T17:22:02.626194Z","end":"2026-04-08T17:22:02.893182Z","steps":["trace[1580820561] 'agreement among raft nodes before linearized reading' (duration: 266.373961ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:22:02.893216Z","caller":"traceutil/trace.go:171","msg":"trace[320093486] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:8518; }","duration":"165.414042ms","start":"2026-04-08T17:22:02.727785Z","end":"2026-04-08T17:22:02.893199Z","steps":["trace[320093486] 'agreement among raft nodes before linearized reading' (duration: 164.94161ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:22:13.080982Z","caller":"traceutil/trace.go:171","msg":"trace[1383356541] linearizableReadLoop","detail":"{readStateIndex:8921; appliedIndex:8920; }","duration":"147.501585ms","start":"2026-04-08T17:22:12.933457Z","end":"2026-04-08T17:22:13.080959Z","steps":["trace[1383356541] 'read index received' (duration: 147.28075ms)","trace[1383356541] 'applied index is now lower than readState.Index' (duration: 219.815µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:22:13.081103Z","caller":"traceutil/trace.go:171","msg":"trace[358348150] transaction","detail":"{read_only:false; response_revision:8613; number_of_response:1; }","duration":"147.660199ms","start":"2026-04-08T17:22:12.933431Z","end":"2026-04-08T17:22:13.081092Z","steps":["trace[358348150] 'process raft request' (duration: 147.377093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:13.081363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.888064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-08T17:22:13.081404Z","caller":"traceutil/trace.go:171","msg":"trace[410178655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8613; }","duration":"147.968896ms","start":"2026-04-08T17:22:12.933424Z","end":"2026-04-08T17:22:13.081393Z","steps":["trace[410178655] 'agreement among raft nodes before linearized reading' (duration: 147.833553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:13.081557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.071324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-08T17:22:13.081563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.957789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-08T17:22:13.08163Z","caller":"traceutil/trace.go:171","msg":"trace[1123927267] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8613; }","duration":"131.202767ms","start":"2026-04-08T17:22:12.95041Z","end":"2026-04-08T17:22:13.081613Z","steps":["trace[1123927267] 'agreement among raft nodes before linearized reading' (duration: 130.980972ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:22:13.081677Z","caller":"traceutil/trace.go:171","msg":"trace[974772176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8613; }","duration":"117.116543ms","start":"2026-04-08T17:22:12.964538Z","end":"2026-04-08T17:22:13.081654Z","steps":["trace[974772176] 'agreement among raft nodes before linearized reading' (duration: 116.901927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:13.081671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.841746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T17:22:13.081832Z","caller":"traceutil/trace.go:171","msg":"trace[314268014] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8613; }","duration":"125.032342ms","start":"2026-04-08T17:22:12.956783Z","end":"2026-04-08T17:22:13.081815Z","steps":["trace[314268014] 'agreement among raft nodes before linearized reading' (duration: 124.707963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:14.10043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.170688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-08T17:22:14.100514Z","caller":"traceutil/trace.go:171","msg":"trace[867517751] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8621; }","duration":"179.309121ms","start":"2026-04-08T17:22:13.921187Z","end":"2026-04-08T17:22:14.100496Z","steps":["trace[867517751] 'range keys from in-memory index tree' (duration: 179.011944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:14.10056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.050901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-08T17:22:14.100628Z","caller":"traceutil/trace.go:171","msg":"trace[1328405264] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8621; }","duration":"170.165225ms","start":"2026-04-08T17:22:13.930446Z","end":"2026-04-08T17:22:14.100611Z","steps":["trace[1328405264] 'range keys from in-memory index tree' (duration: 169.863396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T17:22:14.10088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.735953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-xg5xt\" ","response":"range_response_count:1 size:4652"} {"level":"info","ts":"2026-04-08T17:22:14.100961Z","caller":"traceutil/trace.go:171","msg":"trace[1823009118] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"165.932574ms","start":"2026-04-08T17:22:13.935018Z","end":"2026-04-08T17:22:14.100951Z","steps":["trace[1823009118] 'process raft request' (duration: 81.288352ms)","trace[1823009118] 'compare' (duration: 84.382616ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:22:14.100954Z","caller":"traceutil/trace.go:171","msg":"trace[2029123095] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-xg5xt; range_end:; response_count:1; response_revision:8621; }","duration":"166.831265ms","start":"2026-04-08T17:22:13.934103Z","end":"2026-04-08T17:22:14.100935Z","steps":["trace[2029123095] 'range keys from in-memory index tree' (duration: 166.600209ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:22:14.100967Z","caller":"traceutil/trace.go:171","msg":"trace[1034726403] transaction","detail":"{read_only:false; response_revision:8623; number_of_response:1; }","duration":"100.861048ms","start":"2026-04-08T17:22:14.000083Z","end":"2026-04-08T17:22:14.100944Z","steps":["trace[1034726403] 'process raft request' (duration: 100.793966ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:22:29.833578Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000239f.wal"} {"level":"info","ts":"2026-04-08T17:23:27.695936Z","caller":"traceutil/trace.go:171","msg":"trace[437895958] transaction","detail":"{read_only:false; response_revision:9356; number_of_response:1; }","duration":"174.646921ms","start":"2026-04-08T17:23:27.521256Z","end":"2026-04-08T17:23:27.695903Z","steps":["trace[437895958] 'process raft request' (duration: 118.415924ms)","trace[437895958] 'compare' (duration: 56.011161ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T17:23:27.69611Z","caller":"traceutil/trace.go:171","msg":"trace[369119698] linearizableReadLoop","detail":"{readStateIndex:9684; appliedIndex:9683; }","duration":"102.415474ms","start":"2026-04-08T17:23:27.593671Z","end":"2026-04-08T17:23:27.696086Z","steps":["trace[369119698] 'read index received' (duration: 46.014954ms)","trace[369119698] 'applied index is now lower than readState.Index' (duration: 56.39898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T17:23:27.696209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.476819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T17:23:27.696337Z","caller":"traceutil/trace.go:171","msg":"trace[802908096] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:9357; }","duration":"135.562351ms","start":"2026-04-08T17:23:27.560664Z","end":"2026-04-08T17:23:27.696226Z","steps":["trace[802908096] 'agreement among raft nodes before linearized reading' (duration: 135.49806ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T17:24:08.701677Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"d1606b245347dc08","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-08T17:24:08.710357Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-08T17:24:08.710427Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-08T17:26:19.006117Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8232} {"level":"info","ts":"2026-04-08T17:26:19.078644Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8232,"took":"70.025475ms","hash":2969817294,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":25567232,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-08T17:26:19.078714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2969817294,"revision":8232,"compact-revision":6009} {"level":"info","ts":"2026-04-08T17:31:19.011074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10630} {"level":"info","ts":"2026-04-08T17:31:19.088208Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10630,"took":"75.617587ms","hash":1189561748,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":20795392,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-08T17:31:19.088264Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1189561748,"revision":10630,"compact-revision":8232}