{"level":"warn","ts":"2026-04-15T05:02:08.506098Z","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-15T05:02:08.506195Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.99: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.99:2380","--initial-cluster=instance=https://199.19.213.99:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.99:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.99: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-15T05:02:08.506272Z","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-15T05:02:08.506286Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.99:2380"]} {"level":"info","ts":"2026-04-15T05:02:08.506307Z","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-15T05:02:08.506932Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.99:2379"]} {"level":"info","ts":"2026-04-15T05:02:08.507013Z","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.99:2380"],"listen-peer-urls":["https://199.19.213.99:2380"],"advertise-client-urls":["https://199.19.213.99:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.99:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.99: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-15T05:02:08.511057Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.796462ms"} {"level":"info","ts":"2026-04-15T05:02:08.516026Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4da37caf00b87dfe","cluster-id":"221bed930aa36d2e"} {"level":"info","ts":"2026-04-15T05:02:08.516085Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T05:02:08.516104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe became follower at term 0"} {"level":"info","ts":"2026-04-15T05:02:08.516117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4da37caf00b87dfe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T05:02:08.516126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe became follower at term 1"} {"level":"info","ts":"2026-04-15T05:02:08.51616Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe switched to configuration voters=(5594452253197499902)"} {"level":"warn","ts":"2026-04-15T05:02:08.520865Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T05:02:08.522562Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T05:02:08.523756Z","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-15T05:02:08.526102Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4da37caf00b87dfe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T05:02:08.526614Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4da37caf00b87dfe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T05:02:08.526782Z","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-15T05:02:08.52684Z","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-15T05:02:08.526849Z","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-15T05:02:08.529643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe switched to configuration voters=(5594452253197499902)"} {"level":"info","ts":"2026-04-15T05:02:08.529759Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"221bed930aa36d2e","local-member-id":"4da37caf00b87dfe","added-peer-id":"4da37caf00b87dfe","added-peer-peer-urls":["https://199.19.213.99:2380"]} {"level":"info","ts":"2026-04-15T05:02:08.530372Z","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-15T05:02:08.530476Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.99:2380"} {"level":"info","ts":"2026-04-15T05:02:08.530516Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.99:2380"} {"level":"info","ts":"2026-04-15T05:02:08.530715Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4da37caf00b87dfe","initial-advertise-peer-urls":["https://199.19.213.99:2380"],"listen-peer-urls":["https://199.19.213.99:2380"],"advertise-client-urls":["https://199.19.213.99:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.99:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T05:02:08.530774Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T05:02:09.11675Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T05:02:09.116806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T05:02:09.116843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe received MsgPreVoteResp from 4da37caf00b87dfe at term 1"} {"level":"info","ts":"2026-04-15T05:02:09.116862Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe became candidate at term 2"} {"level":"info","ts":"2026-04-15T05:02:09.116878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe received MsgVoteResp from 4da37caf00b87dfe at term 2"} {"level":"info","ts":"2026-04-15T05:02:09.116897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4da37caf00b87dfe became leader at term 2"} {"level":"info","ts":"2026-04-15T05:02:09.116914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4da37caf00b87dfe elected leader 4da37caf00b87dfe at term 2"} {"level":"info","ts":"2026-04-15T05:02:09.119171Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4da37caf00b87dfe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.99:2379]}","request-path":"/0/members/4da37caf00b87dfe/attributes","cluster-id":"221bed930aa36d2e","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T05:02:09.119392Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T05:02:09.119486Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T05:02:09.119519Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T05:02:09.119588Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T05:02:09.119647Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T05:02:09.120881Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"221bed930aa36d2e","local-member-id":"4da37caf00b87dfe","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T05:02:09.121081Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T05:02:09.12113Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T05:02:09.122831Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-15T05:02:09.123157Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.99:2379"} {"level":"info","ts":"2026-04-15T05:02:30.991955Z","caller":"traceutil/trace.go:171","msg":"trace[1431637425] transaction","detail":"{read_only:false; response_revision:385; number_of_response:1; }","duration":"111.320608ms","start":"2026-04-15T05:02:30.880613Z","end":"2026-04-15T05:02:30.991934Z","steps":["trace[1431637425] 'process raft request' (duration: 111.192565ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:02:36.676633Z","caller":"traceutil/trace.go:171","msg":"trace[1983248313] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"122.702604ms","start":"2026-04-15T05:02:36.553904Z","end":"2026-04-15T05:02:36.676607Z","steps":["trace[1983248313] 'process raft request' (duration: 122.54857ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:02:36.678475Z","caller":"traceutil/trace.go:171","msg":"trace[1831921279] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"123.768532ms","start":"2026-04-15T05:02:36.554665Z","end":"2026-04-15T05:02:36.678433Z","steps":["trace[1831921279] 'process raft request' (duration: 123.669379ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:03:36.555014Z","caller":"traceutil/trace.go:171","msg":"trace[1041738095] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"101.251054ms","start":"2026-04-15T05:03:36.453725Z","end":"2026-04-15T05:03:36.554976Z","steps":["trace[1041738095] 'process raft request' (duration: 101.034948ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:03:36.556281Z","caller":"traceutil/trace.go:171","msg":"trace[1639168231] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"102.412796ms","start":"2026-04-15T05:03:36.453835Z","end":"2026-04-15T05:03:36.556248Z","steps":["trace[1639168231] 'process raft request' (duration: 102.272222ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:03:40.382627Z","caller":"traceutil/trace.go:171","msg":"trace[861274039] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"146.401755ms","start":"2026-04-15T05:03:40.236206Z","end":"2026-04-15T05:03:40.382608Z","steps":["trace[861274039] 'process raft request' (duration: 145.902611ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:03:40.959598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.124681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T05:03:40.959717Z","caller":"traceutil/trace.go:171","msg":"trace[1046543335] linearizableReadLoop","detail":"{readStateIndex:740; appliedIndex:739; }","duration":"497.015883ms","start":"2026-04-15T05:03:40.462686Z","end":"2026-04-15T05:03:40.959702Z","steps":["trace[1046543335] 'read index received' (duration: 37.212503ms)","trace[1046543335] 'applied index is now lower than readState.Index' (duration: 459.80183ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:03:40.959795Z","caller":"traceutil/trace.go:171","msg":"trace[1201185186] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"519.157961ms","start":"2026-04-15T05:03:40.440627Z","end":"2026-04-15T05:03:40.959785Z","steps":["trace[1201185186] 'process raft request' (duration: 59.343421ms)","trace[1201185186] 'compare' (duration: 458.846594ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:03:40.959855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:03:40.440609Z","time spent":"519.219243ms","remote":"127.0.0.1:37186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T05:03:40.959919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.145627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:03:40.960002Z","caller":"traceutil/trace.go:171","msg":"trace[319311012] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:705; }","duration":"433.259411ms","start":"2026-04-15T05:03:40.52672Z","end":"2026-04-15T05:03:40.959979Z","steps":["trace[319311012] 'agreement among raft nodes before linearized reading' (duration: 433.088236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:03:40.960079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:03:40.526709Z","time spent":"433.361083ms","remote":"127.0.0.1:36922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-15T05:03:40.960209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.496656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:03:40.960286Z","caller":"traceutil/trace.go:171","msg":"trace[1753594089] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:705; }","duration":"497.628119ms","start":"2026-04-15T05:03:40.462637Z","end":"2026-04-15T05:03:40.960265Z","steps":["trace[1753594089] 'agreement among raft nodes before linearized reading' (duration: 497.481605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:03:40.960388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:03:40.462622Z","time spent":"497.752833ms","remote":"127.0.0.1:37380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-04-15T05:03:42.302835Z","caller":"traceutil/trace.go:171","msg":"trace[1586015994] transaction","detail":"{read_only:false; response_revision:728; number_of_response:1; }","duration":"137.032827ms","start":"2026-04-15T05:03:42.165776Z","end":"2026-04-15T05:03:42.302809Z","steps":["trace[1586015994] 'process raft request' (duration: 136.897733ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:03:55.367255Z","caller":"traceutil/trace.go:171","msg":"trace[1143113896] linearizableReadLoop","detail":"{readStateIndex:902; appliedIndex:901; }","duration":"246.832732ms","start":"2026-04-15T05:03:55.120393Z","end":"2026-04-15T05:03:55.367226Z","steps":["trace[1143113896] 'read index received' (duration: 246.479593ms)","trace[1143113896] 'applied index is now lower than readState.Index' (duration: 351.689µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:03:55.367379Z","caller":"traceutil/trace.go:171","msg":"trace[1679148113] transaction","detail":"{read_only:false; response_revision:863; number_of_response:1; }","duration":"250.350379ms","start":"2026-04-15T05:03:55.116998Z","end":"2026-04-15T05:03:55.367348Z","steps":["trace[1679148113] 'process raft request' (duration: 249.962588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:03:55.367678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.254244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-15T05:03:55.367778Z","caller":"traceutil/trace.go:171","msg":"trace[182251351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:863; }","duration":"247.392207ms","start":"2026-04-15T05:03:55.120367Z","end":"2026-04-15T05:03:55.36776Z","steps":["trace[182251351] 'agreement among raft nodes before linearized reading' (duration: 247.021187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:03:55.36775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.39686ms","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-15T05:03:55.367948Z","caller":"traceutil/trace.go:171","msg":"trace[949505930] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:863; }","duration":"246.610256ms","start":"2026-04-15T05:03:55.121295Z","end":"2026-04-15T05:03:55.367905Z","steps":["trace[949505930] 'agreement among raft nodes before linearized reading' (duration: 246.179324ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:04:22.437445Z","caller":"traceutil/trace.go:171","msg":"trace[1477164342] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"151.446329ms","start":"2026-04-15T05:04:22.285975Z","end":"2026-04-15T05:04:22.437421Z","steps":["trace[1477164342] 'process raft request' (duration: 151.301275ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:05:10.703417Z","caller":"traceutil/trace.go:171","msg":"trace[759279525] linearizableReadLoop","detail":"{readStateIndex:2017; appliedIndex:2016; }","duration":"236.269872ms","start":"2026-04-15T05:05:10.467119Z","end":"2026-04-15T05:05:10.703389Z","steps":["trace[759279525] 'read index received' (duration: 236.097677ms)","trace[759279525] 'applied index is now lower than readState.Index' (duration: 170.995µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:05:10.703477Z","caller":"traceutil/trace.go:171","msg":"trace[438827645] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"244.343682ms","start":"2026-04-15T05:05:10.459102Z","end":"2026-04-15T05:05:10.703446Z","steps":["trace[438827645] 'process raft request' (duration: 244.125206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:05:10.703722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.57562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-71ebc208-b787-457d-bad3-6c564cfd6a0f\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-15T05:05:10.70382Z","caller":"traceutil/trace.go:171","msg":"trace[249426951] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-71ebc208-b787-457d-bad3-6c564cfd6a0f; range_end:; response_count:1; response_revision:1937; }","duration":"236.728884ms","start":"2026-04-15T05:05:10.467071Z","end":"2026-04-15T05:05:10.7038Z","steps":["trace[249426951] 'agreement among raft nodes before linearized reading' (duration: 236.436256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:05:10.706004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.16322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:05:10.70604Z","caller":"traceutil/trace.go:171","msg":"trace[791168216] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1938; }","duration":"179.258493ms","start":"2026-04-15T05:05:10.526773Z","end":"2026-04-15T05:05:10.706032Z","steps":["trace[791168216] 'agreement among raft nodes before linearized reading' (duration: 179.190081ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:06:01.205341Z","caller":"traceutil/trace.go:171","msg":"trace[24268641] transaction","detail":"{read_only:false; response_revision:2262; number_of_response:1; }","duration":"152.671415ms","start":"2026-04-15T05:06:01.052626Z","end":"2026-04-15T05:06:01.205297Z","steps":["trace[24268641] 'process raft request' (duration: 152.46653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:06:01.514188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.901808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T05:06:01.514332Z","caller":"traceutil/trace.go:171","msg":"trace[1629765099] transaction","detail":"{read_only:false; response_revision:2263; number_of_response:1; }","duration":"304.532219ms","start":"2026-04-15T05:06:01.209775Z","end":"2026-04-15T05:06:01.514307Z","steps":["trace[1629765099] 'process raft request' (duration: 151.562465ms)","trace[1629765099] 'compare' (duration: 150.652851ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:06:01.514416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:06:01.209754Z","time spent":"304.619001ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:06:01.793191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.036371ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T05:06:01.793381Z","caller":"traceutil/trace.go:171","msg":"trace[129554185] transaction","detail":"{read_only:false; response_revision:2265; number_of_response:1; }","duration":"129.61692ms","start":"2026-04-15T05:06:01.663746Z","end":"2026-04-15T05:06:01.793363Z","steps":["trace[129554185] 'process raft request' (duration: 129.550798ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:06:01.79344Z","caller":"traceutil/trace.go:171","msg":"trace[1634909821] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"553.53386ms","start":"2026-04-15T05:06:01.239856Z","end":"2026-04-15T05:06:01.793389Z","steps":["trace[1634909821] 'process raft request' (duration: 388.209661ms)","trace[1634909821] 'compare' (duration: 164.806425ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:06:01.793589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:06:01.239829Z","time spent":"553.685555ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T05:06:50.121233Z","caller":"traceutil/trace.go:171","msg":"trace[989722557] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"167.392175ms","start":"2026-04-15T05:06:49.95382Z","end":"2026-04-15T05:06:50.121212Z","steps":["trace[989722557] 'process raft request' (duration: 167.259281ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:06:50.122397Z","caller":"traceutil/trace.go:171","msg":"trace[1375554462] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"166.08913ms","start":"2026-04-15T05:06:49.956287Z","end":"2026-04-15T05:06:50.122376Z","steps":["trace[1375554462] 'process raft request' (duration: 165.949686ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:07:23.749636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.856405ms","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-15T05:07:23.749746Z","caller":"traceutil/trace.go:171","msg":"trace[399935497] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2902; }","duration":"103.039761ms","start":"2026-04-15T05:07:23.646686Z","end":"2026-04-15T05:07:23.749726Z","steps":["trace[399935497] 'range keys from in-memory index tree' (duration: 102.62366ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:07:23.889008Z","caller":"traceutil/trace.go:171","msg":"trace[637953361] transaction","detail":"{read_only:false; response_revision:2903; number_of_response:1; }","duration":"133.820081ms","start":"2026-04-15T05:07:23.755165Z","end":"2026-04-15T05:07:23.888985Z","steps":["trace[637953361] 'process raft request' (duration: 133.684528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:09:59.073514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.710203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hbp7s\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-15T05:09:59.073585Z","caller":"traceutil/trace.go:171","msg":"trace[611100011] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hbp7s; range_end:; response_count:1; response_revision:3916; }","duration":"328.822596ms","start":"2026-04-15T05:09:58.744746Z","end":"2026-04-15T05:09:59.073568Z","steps":["trace[611100011] 'range keys from in-memory index tree' (duration: 328.559218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:09:59.073612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:09:58.744725Z","time spent":"328.880948ms","remote":"127.0.0.1:37128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-hbp7s\" "} {"level":"info","ts":"2026-04-15T05:09:59.073821Z","caller":"traceutil/trace.go:171","msg":"trace[1203811009] transaction","detail":"{read_only:false; response_revision:3917; number_of_response:1; }","duration":"280.691023ms","start":"2026-04-15T05:09:58.79309Z","end":"2026-04-15T05:09:59.073781Z","steps":["trace[1203811009] 'process raft request' (duration: 233.861734ms)","trace[1203811009] 'compare' (duration: 46.658954ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:09:59.078871Z","caller":"traceutil/trace.go:171","msg":"trace[407470343] transaction","detail":"{read_only:false; response_revision:3918; number_of_response:1; }","duration":"284.188537ms","start":"2026-04-15T05:09:58.79463Z","end":"2026-04-15T05:09:59.078818Z","steps":["trace[407470343] 'process raft request' (duration: 284.018693ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:09:59.079333Z","caller":"traceutil/trace.go:171","msg":"trace[1541018542] transaction","detail":"{read_only:false; response_revision:3919; number_of_response:1; }","duration":"280.94586ms","start":"2026-04-15T05:09:58.798358Z","end":"2026-04-15T05:09:59.079304Z","steps":["trace[1541018542] 'process raft request' (duration: 280.414125ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:11.349322Z","caller":"traceutil/trace.go:171","msg":"trace[1138838837] linearizableReadLoop","detail":"{readStateIndex:4594; appliedIndex:4593; }","duration":"200.633547ms","start":"2026-04-15T05:11:11.148671Z","end":"2026-04-15T05:11:11.349305Z","steps":["trace[1138838837] 'read index received' (duration: 200.514624ms)","trace[1138838837] 'applied index is now lower than readState.Index' (duration: 118.283µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:11.349383Z","caller":"traceutil/trace.go:171","msg":"trace[642996600] transaction","detail":"{read_only:false; response_revision:4409; number_of_response:1; }","duration":"311.572982ms","start":"2026-04-15T05:11:11.037794Z","end":"2026-04-15T05:11:11.349367Z","steps":["trace[642996600] 'process raft request' (duration: 311.374006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:11.349481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.805341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-create-kr445\" ","response":"range_response_count:1 size:4681"} {"level":"warn","ts":"2026-04-15T05:11:11.349489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:11.037766Z","time spent":"311.653084ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T05:11:11.349518Z","caller":"traceutil/trace.go:171","msg":"trace[885152978] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-admission-create-kr445; range_end:; response_count:1; response_revision:4409; }","duration":"200.874043ms","start":"2026-04-15T05:11:11.148634Z","end":"2026-04-15T05:11:11.349508Z","steps":["trace[885152978] 'agreement among raft nodes before linearized reading' (duration: 200.74279ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:21.505646Z","caller":"traceutil/trace.go:171","msg":"trace[1707347594] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"162.757722ms","start":"2026-04-15T05:11:21.342863Z","end":"2026-04-15T05:11:21.505621Z","steps":["trace[1707347594] 'process raft request' (duration: 149.102292ms)","trace[1707347594] 'compare' (duration: 13.194217ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:21.505826Z","caller":"traceutil/trace.go:171","msg":"trace[1451599521] linearizableReadLoop","detail":"{readStateIndex:5133; appliedIndex:5132; }","duration":"161.167119ms","start":"2026-04-15T05:11:21.344651Z","end":"2026-04-15T05:11:21.505818Z","steps":["trace[1451599521] 'read index received' (duration: 147.296544ms)","trace[1451599521] 'applied index is now lower than readState.Index' (duration: 13.869695ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:11:21.506219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.551179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-04-15T05:11:21.506257Z","caller":"traceutil/trace.go:171","msg":"trace[1664089482] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4941; }","duration":"161.606111ms","start":"2026-04-15T05:11:21.34464Z","end":"2026-04-15T05:11:21.506246Z","steps":["trace[1664089482] 'agreement among raft nodes before linearized reading' (duration: 161.493868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:21.506571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.625552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:520012"} {"level":"info","ts":"2026-04-15T05:11:21.506601Z","caller":"traceutil/trace.go:171","msg":"trace[1872561528] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:4941; }","duration":"113.692224ms","start":"2026-04-15T05:11:21.392902Z","end":"2026-04-15T05:11:21.506595Z","steps":["trace[1872561528] 'agreement among raft nodes before linearized reading' (duration: 113.455348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:21.506877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.567371ms","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-15T05:11:21.507103Z","caller":"traceutil/trace.go:171","msg":"trace[384578148] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4941; }","duration":"113.853819ms","start":"2026-04-15T05:11:21.393218Z","end":"2026-04-15T05:11:21.507072Z","steps":["trace[384578148] 'agreement among raft nodes before linearized reading' (duration: 113.448248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:22.211898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9078867138556899368,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T05:11:22.712252Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9078867138556899368,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T05:11:23.212899Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9078867138556899368,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T05:11:23.713993Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9078867138556899368,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T05:11:24.028399Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.319493041s","expected-duration":"1s"} {"level":"info","ts":"2026-04-15T05:11:24.028821Z","caller":"traceutil/trace.go:171","msg":"trace[1743477434] transaction","detail":"{read_only:false; response_revision:4961; number_of_response:1; }","duration":"2.320003984s","start":"2026-04-15T05:11:21.708793Z","end":"2026-04-15T05:11:24.028797Z","steps":["trace[1743477434] 'process raft request' (duration: 2.319831269s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.028966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.708764Z","time spent":"2.320139598s","remote":"127.0.0.1:59012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3745,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T05:11:24.175914Z","caller":"traceutil/trace.go:171","msg":"trace[48021189] transaction","detail":"{read_only:false; response_revision:4963; number_of_response:1; }","duration":"2.369862174s","start":"2026-04-15T05:11:21.806022Z","end":"2026-04-15T05:11:24.175884Z","steps":["trace[48021189] 'process raft request' (duration: 2.369674419s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.176023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.806008Z","time spent":"2.369966936s","remote":"127.0.0.1:59052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2573,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T05:11:24.176094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.46479296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-15T05:11:24.176133Z","caller":"traceutil/trace.go:171","msg":"trace[1390730102] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4968; }","duration":"2.464873302s","start":"2026-04-15T05:11:21.711253Z","end":"2026-04-15T05:11:24.176126Z","steps":["trace[1390730102] 'agreement among raft nodes before linearized reading' (duration: 2.464708068s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.176156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.71124Z","time spent":"2.464909953s","remote":"127.0.0.1:37026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":730,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" "} {"level":"info","ts":"2026-04-15T05:11:24.176197Z","caller":"traceutil/trace.go:171","msg":"trace[1813879257] transaction","detail":"{read_only:false; response_revision:4962; number_of_response:1; }","duration":"2.462518069s","start":"2026-04-15T05:11:21.713665Z","end":"2026-04-15T05:11:24.176183Z","steps":["trace[1813879257] 'process raft request' (duration: 2.427138322s)","trace[1813879257] 'compare' (duration: 34.096212ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:11:24.176279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.713642Z","time spent":"2.46259407s","remote":"127.0.0.1:34180","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1951,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T05:11:24.176427Z","caller":"traceutil/trace.go:171","msg":"trace[1594139483] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"653.968297ms","start":"2026-04-15T05:11:23.522452Z","end":"2026-04-15T05:11:24.176421Z","steps":["trace[1594139483] 'process raft request' (duration: 653.428153ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.175917Z","caller":"traceutil/trace.go:171","msg":"trace[1244348579] linearizableReadLoop","detail":"{readStateIndex:5165; appliedIndex:5157; }","duration":"2.464614845s","start":"2026-04-15T05:11:21.711286Z","end":"2026-04-15T05:11:24.175901Z","steps":["trace[1244348579] 'read index received' (duration: 2.317352723s)","trace[1244348579] 'applied index is now lower than readState.Index' (duration: 147.261582ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:24.176518Z","caller":"traceutil/trace.go:171","msg":"trace[1850086222] transaction","detail":"{read_only:false; response_revision:4964; number_of_response:1; }","duration":"2.087037655s","start":"2026-04-15T05:11:22.08947Z","end":"2026-04-15T05:11:24.176508Z","steps":["trace[1850086222] 'process raft request' (duration: 2.086292554s)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.176523Z","caller":"traceutil/trace.go:171","msg":"trace[1539155163] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"662.750864ms","start":"2026-04-15T05:11:23.513713Z","end":"2026-04-15T05:11:24.176464Z","steps":["trace[1539155163] 'process raft request' (duration: 662.150638ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.176591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:22.089444Z","time spent":"2.087108246s","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T05:11:24.176476Z","caller":"traceutil/trace.go:171","msg":"trace[962971196] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"1.537117601s","start":"2026-04-15T05:11:22.639344Z","end":"2026-04-15T05:11:24.176462Z","steps":["trace[962971196] 'process raft request' (duration: 1.536471674s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.176677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:22.639313Z","time spent":"1.537328687s","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:11:24.176701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.439785294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-15T05:11:24.176723Z","caller":"traceutil/trace.go:171","msg":"trace[1059669858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4968; }","duration":"2.439823134s","start":"2026-04-15T05:11:21.736894Z","end":"2026-04-15T05:11:24.176717Z","steps":["trace[1059669858] 'agreement among raft nodes before linearized reading' (duration: 2.439774963s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.176737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.736886Z","time spent":"2.439848086s","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-15T05:11:24.176491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:23.522443Z","time spent":"654.008058ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:11:24.176774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:23.513692Z","time spent":"662.95043ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:11:24.17681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"652.284242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hbp7s\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-15T05:11:24.176823Z","caller":"traceutil/trace.go:171","msg":"trace[293175336] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hbp7s; range_end:; response_count:1; response_revision:4968; }","duration":"652.307032ms","start":"2026-04-15T05:11:23.524513Z","end":"2026-04-15T05:11:24.17682Z","steps":["trace[293175336] 'agreement among raft nodes before linearized reading' (duration: 652.256571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.176835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:23.524504Z","time spent":"652.328132ms","remote":"127.0.0.1:37128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6549,"request content":"key:\"/registry/pods/openstack/keepalived-hbp7s\" "} {"level":"warn","ts":"2026-04-15T05:11:24.176937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.010162ms","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-15T05:11:24.176959Z","caller":"traceutil/trace.go:171","msg":"trace[384178162] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4968; }","duration":"656.060434ms","start":"2026-04-15T05:11:23.520895Z","end":"2026-04-15T05:11:24.176955Z","steps":["trace[384178162] 'agreement among raft nodes before linearized reading' (duration: 656.009592ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.176972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:23.52088Z","time spent":"656.088304ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-15T05:11:24.177011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.651824644s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:11:24.177022Z","caller":"traceutil/trace.go:171","msg":"trace[1469660608] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"664.210234ms","start":"2026-04-15T05:11:23.512801Z","end":"2026-04-15T05:11:24.177011Z","steps":["trace[1469660608] 'process raft request' (duration: 663.040533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.17706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.282064619s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T05:11:24.177065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.15012103s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.99\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-15T05:11:24.177081Z","caller":"traceutil/trace.go:171","msg":"trace[1139211482] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:4968; }","duration":"2.28209014s","start":"2026-04-15T05:11:21.894986Z","end":"2026-04-15T05:11:24.177076Z","steps":["trace[1139211482] 'agreement among raft nodes before linearized reading' (duration: 2.282052599s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:23.512778Z","time spent":"664.276595ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:11:24.177098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.894898Z","time spent":"2.282194412s","remote":"127.0.0.1:53234","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-15T05:11:24.177103Z","caller":"traceutil/trace.go:171","msg":"trace[1215881461] range","detail":"{range_begin:/registry/masterleases/199.19.213.99; range_end:; response_count:1; response_revision:4968; }","duration":"2.150211223s","start":"2026-04-15T05:11:22.026879Z","end":"2026-04-15T05:11:24.17709Z","steps":["trace[1215881461] 'agreement among raft nodes before linearized reading' (duration: 2.15009196s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.294786178s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T05:11:24.177136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:22.026855Z","time spent":"2.150273814s","remote":"127.0.0.1:36982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.99\" "} {"level":"warn","ts":"2026-04-15T05:11:24.177204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.375541687s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-04-15T05:11:24.177224Z","caller":"traceutil/trace.go:171","msg":"trace[1470837312] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4968; }","duration":"2.375598339s","start":"2026-04-15T05:11:21.801622Z","end":"2026-04-15T05:11:24.17722Z","steps":["trace[1470837312] 'agreement among raft nodes before linearized reading' (duration: 2.375550708s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.518717784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-15T05:11:24.177238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.801599Z","time spent":"2.37563546s","remote":"127.0.0.1:37026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1843,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-04-15T05:11:24.177252Z","caller":"traceutil/trace.go:171","msg":"trace[17609644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4968; }","duration":"1.518775925s","start":"2026-04-15T05:11:22.658468Z","end":"2026-04-15T05:11:24.177244Z","steps":["trace[17609644] 'agreement among raft nodes before linearized reading' (duration: 1.518692673s)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.177072Z","caller":"traceutil/trace.go:171","msg":"trace[561310050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4968; }","duration":"1.651903436s","start":"2026-04-15T05:11:22.525142Z","end":"2026-04-15T05:11:24.177045Z","steps":["trace[561310050] 'agreement among raft nodes before linearized reading' (duration: 1.651836514s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:22.658459Z","time spent":"1.518813066s","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T05:11:24.177298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:22.525119Z","time spent":"1.652169743s","remote":"127.0.0.1:36938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-15T05:11:24.177321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.392218778s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-hfmqg.18a66fa8e268d405\" ","response":"range_response_count:1 size:832"} {"level":"info","ts":"2026-04-15T05:11:24.177337Z","caller":"traceutil/trace.go:171","msg":"trace[1516815001] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-hfmqg.18a66fa8e268d405; range_end:; response_count:1; response_revision:4968; }","duration":"2.3922834s","start":"2026-04-15T05:11:21.785048Z","end":"2026-04-15T05:11:24.177331Z","steps":["trace[1516815001] 'agreement among raft nodes before linearized reading' (duration: 2.392240189s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.785021Z","time spent":"2.392331481s","remote":"127.0.0.1:37016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":1,"response size":854,"request content":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-hfmqg.18a66fa8e268d405\" "} {"level":"info","ts":"2026-04-15T05:11:24.177145Z","caller":"traceutil/trace.go:171","msg":"trace[211352083] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4968; }","duration":"1.29486143s","start":"2026-04-15T05:11:22.882274Z","end":"2026-04-15T05:11:24.177136Z","steps":["trace[211352083] 'agreement among raft nodes before linearized reading' (duration: 1.294814118s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:22.882255Z","time spent":"1.295190059s","remote":"127.0.0.1:59076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-15T05:11:24.177477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.434138611s","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-15T05:11:24.177516Z","caller":"traceutil/trace.go:171","msg":"trace[1725314147] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4968; }","duration":"2.434192694s","start":"2026-04-15T05:11:21.743313Z","end":"2026-04-15T05:11:24.177506Z","steps":["trace[1725314147] 'agreement among raft nodes before linearized reading' (duration: 2.434013829s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:21.743306Z","time spent":"2.434240585s","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-15T05:11:24.177565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.849065878s","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-15T05:11:24.177584Z","caller":"traceutil/trace.go:171","msg":"trace[523319622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4968; }","duration":"1.84911981s","start":"2026-04-15T05:11:22.328458Z","end":"2026-04-15T05:11:24.177578Z","steps":["trace[523319622] 'agreement among raft nodes before linearized reading' (duration: 1.849071358s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.916746419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-hfmqg\" ","response":"range_response_count:1 size:9712"} {"level":"info","ts":"2026-04-15T05:11:24.177688Z","caller":"traceutil/trace.go:171","msg":"trace[819416281] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-hfmqg; range_end:; response_count:1; response_revision:4968; }","duration":"1.916974405s","start":"2026-04-15T05:11:22.260685Z","end":"2026-04-15T05:11:24.17766Z","steps":["trace[819416281] 'agreement among raft nodes before linearized reading' (duration: 1.916485792s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.177775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:22.260665Z","time spent":"1.917092958s","remote":"127.0.0.1:37128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9734,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-hfmqg\" "} {"level":"warn","ts":"2026-04-15T05:11:24.177604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:22.328439Z","time spent":"1.849162561s","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-15T05:11:24.314967Z","caller":"traceutil/trace.go:171","msg":"trace[1980751986] transaction","detail":"{read_only:false; response_revision:4969; number_of_response:1; }","duration":"134.281751ms","start":"2026-04-15T05:11:24.180652Z","end":"2026-04-15T05:11:24.314933Z","steps":["trace[1980751986] 'process raft request' (duration: 133.685345ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.315045Z","caller":"traceutil/trace.go:171","msg":"trace[558999537] transaction","detail":"{read_only:false; response_revision:4971; number_of_response:1; }","duration":"131.24584ms","start":"2026-04-15T05:11:24.183745Z","end":"2026-04-15T05:11:24.314991Z","steps":["trace[558999537] 'process raft request' (duration: 131.134857ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.315379Z","caller":"traceutil/trace.go:171","msg":"trace[497048971] transaction","detail":"{read_only:false; response_revision:4972; number_of_response:1; }","duration":"131.454715ms","start":"2026-04-15T05:11:24.183907Z","end":"2026-04-15T05:11:24.315362Z","steps":["trace[497048971] 'process raft request' (duration: 131.026223ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.315681Z","caller":"traceutil/trace.go:171","msg":"trace[1223954730] transaction","detail":"{read_only:false; response_revision:4973; number_of_response:1; }","duration":"131.725162ms","start":"2026-04-15T05:11:24.183941Z","end":"2026-04-15T05:11:24.315666Z","steps":["trace[1223954730] 'process raft request' (duration: 131.417714ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.315789Z","caller":"traceutil/trace.go:171","msg":"trace[1115864739] transaction","detail":"{read_only:false; response_revision:4974; number_of_response:1; }","duration":"131.023084ms","start":"2026-04-15T05:11:24.184741Z","end":"2026-04-15T05:11:24.315764Z","steps":["trace[1115864739] 'process raft request' (duration: 130.779907ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.315955Z","caller":"traceutil/trace.go:171","msg":"trace[683161313] transaction","detail":"{read_only:false; response_revision:4975; number_of_response:1; }","duration":"125.846744ms","start":"2026-04-15T05:11:24.190098Z","end":"2026-04-15T05:11:24.315944Z","steps":["trace[683161313] 'process raft request' (duration: 125.499464ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.316044Z","caller":"traceutil/trace.go:171","msg":"trace[381128286] linearizableReadLoop","detail":"{readStateIndex:5167; appliedIndex:5165; }","duration":"132.506874ms","start":"2026-04-15T05:11:24.183516Z","end":"2026-04-15T05:11:24.316023Z","steps":["trace[381128286] 'read index received' (duration: 97.359503ms)","trace[381128286] 'applied index is now lower than readState.Index' (duration: 35.146311ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:24.316152Z","caller":"traceutil/trace.go:171","msg":"trace[2082346753] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"124.006714ms","start":"2026-04-15T05:11:24.192137Z","end":"2026-04-15T05:11:24.316143Z","steps":["trace[2082346753] 'process raft request' (duration: 123.709486ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.316426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.882604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-15T05:11:24.316465Z","caller":"traceutil/trace.go:171","msg":"trace[831582273] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4976; }","duration":"132.975497ms","start":"2026-04-15T05:11:24.18348Z","end":"2026-04-15T05:11:24.316455Z","steps":["trace[831582273] 'agreement among raft nodes before linearized reading' (duration: 132.800092ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.315114Z","caller":"traceutil/trace.go:171","msg":"trace[1550181627] transaction","detail":"{read_only:false; response_revision:4970; number_of_response:1; }","duration":"131.369813ms","start":"2026-04-15T05:11:24.183686Z","end":"2026-04-15T05:11:24.315056Z","steps":["trace[1550181627] 'process raft request' (duration: 131.103516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.317202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.253415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:7 size:62974"} {"level":"info","ts":"2026-04-15T05:11:24.317252Z","caller":"traceutil/trace.go:171","msg":"trace[1711227585] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:7; response_revision:4977; }","duration":"129.321478ms","start":"2026-04-15T05:11:24.18792Z","end":"2026-04-15T05:11:24.317241Z","steps":["trace[1711227585] 'agreement among raft nodes before linearized reading' (duration: 129.100792ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.317495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.82464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-hfmqg-tls\" ","response":"range_response_count:1 size:1966"} {"level":"info","ts":"2026-04-15T05:11:24.317535Z","caller":"traceutil/trace.go:171","msg":"trace[1194023409] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-hfmqg-tls; range_end:; response_count:1; response_revision:4977; }","duration":"126.875712ms","start":"2026-04-15T05:11:24.19065Z","end":"2026-04-15T05:11:24.317526Z","steps":["trace[1194023409] 'agreement among raft nodes before linearized reading' (duration: 126.777389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.317671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.68052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:11:24.317695Z","caller":"traceutil/trace.go:171","msg":"trace[263063687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4977; }","duration":"128.716091ms","start":"2026-04-15T05:11:24.188972Z","end":"2026-04-15T05:11:24.317688Z","steps":["trace[263063687] 'agreement among raft nodes before linearized reading' (duration: 128.67869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.317522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.025256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-15T05:11:24.31775Z","caller":"traceutil/trace.go:171","msg":"trace[1001746533] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4977; }","duration":"110.280723ms","start":"2026-04-15T05:11:24.207452Z","end":"2026-04-15T05:11:24.317733Z","steps":["trace[1001746533] 'agreement among raft nodes before linearized reading' (duration: 109.895173ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.469842Z","caller":"traceutil/trace.go:171","msg":"trace[324352037] linearizableReadLoop","detail":"{readStateIndex:5178; appliedIndex:5177; }","duration":"109.248404ms","start":"2026-04-15T05:11:24.360563Z","end":"2026-04-15T05:11:24.469811Z","steps":["trace[324352037] 'read index received' (duration: 79.350685ms)","trace[324352037] 'applied index is now lower than readState.Index' (duration: 29.896719ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:24.469841Z","caller":"traceutil/trace.go:171","msg":"trace[2045372023] transaction","detail":"{read_only:false; response_revision:4980; number_of_response:1; }","duration":"110.876388ms","start":"2026-04-15T05:11:24.358941Z","end":"2026-04-15T05:11:24.469817Z","steps":["trace[2045372023] 'process raft request' (duration: 80.945429ms)","trace[2045372023] 'compare' (duration: 29.744674ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:11:24.470058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.476531ms","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-15T05:11:24.470094Z","caller":"traceutil/trace.go:171","msg":"trace[704681515] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4980; }","duration":"109.557642ms","start":"2026-04-15T05:11:24.360529Z","end":"2026-04-15T05:11:24.470086Z","steps":["trace[704681515] 'agreement among raft nodes before linearized reading' (duration: 109.375848ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.477732Z","caller":"traceutil/trace.go:171","msg":"trace[1677262411] transaction","detail":"{read_only:false; response_revision:4981; number_of_response:1; }","duration":"116.597574ms","start":"2026-04-15T05:11:24.361118Z","end":"2026-04-15T05:11:24.477716Z","steps":["trace[1677262411] 'process raft request' (duration: 116.325427ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.478037Z","caller":"traceutil/trace.go:171","msg":"trace[1576732878] transaction","detail":"{read_only:false; response_revision:4982; number_of_response:1; }","duration":"116.759267ms","start":"2026-04-15T05:11:24.36127Z","end":"2026-04-15T05:11:24.478029Z","steps":["trace[1576732878] 'process raft request' (duration: 116.249084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.478216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.892602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:11:24.478264Z","caller":"traceutil/trace.go:171","msg":"trace[941231505] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-1; range_end:; response_count:0; response_revision:4983; }","duration":"116.953273ms","start":"2026-04-15T05:11:24.361284Z","end":"2026-04-15T05:11:24.478238Z","steps":["trace[941231505] 'agreement among raft nodes before linearized reading' (duration: 116.874431ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.478265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.773698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-llxqj\" ","response":"range_response_count:1 size:4947"} {"level":"info","ts":"2026-04-15T05:11:24.478274Z","caller":"traceutil/trace.go:171","msg":"trace[1571769378] transaction","detail":"{read_only:false; response_revision:4983; number_of_response:1; }","duration":"114.966839ms","start":"2026-04-15T05:11:24.363281Z","end":"2026-04-15T05:11:24.478248Z","steps":["trace[1571769378] 'process raft request' (duration: 114.2653ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:24.478302Z","caller":"traceutil/trace.go:171","msg":"trace[1202563139] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-llxqj; range_end:; response_count:1; response_revision:4983; }","duration":"116.824369ms","start":"2026-04-15T05:11:24.361467Z","end":"2026-04-15T05:11:24.478292Z","steps":["trace[1202563139] 'agreement among raft nodes before linearized reading' (duration: 116.639434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.47847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.562352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:11:24.478508Z","caller":"traceutil/trace.go:171","msg":"trace[976519277] range","detail":"{range_begin:/registry/poddisruptionbudgets/monitoring/loki-memcached-chunks-cache; range_end:; response_count:0; response_revision:4984; }","duration":"113.635553ms","start":"2026-04-15T05:11:24.364863Z","end":"2026-04-15T05:11:24.478498Z","steps":["trace[976519277] 'agreement among raft nodes before linearized reading' (duration: 113.578022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:24.478865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.152601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4848"} {"level":"info","ts":"2026-04-15T05:11:24.478957Z","caller":"traceutil/trace.go:171","msg":"trace[1652794537] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4984; }","duration":"113.290894ms","start":"2026-04-15T05:11:24.365645Z","end":"2026-04-15T05:11:24.478936Z","steps":["trace[1652794537] 'agreement among raft nodes before linearized reading' (duration: 112.683457ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:25.491873Z","caller":"traceutil/trace.go:171","msg":"trace[691054872] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"170.622164ms","start":"2026-04-15T05:11:25.321222Z","end":"2026-04-15T05:11:25.491844Z","steps":["trace[691054872] 'process raft request' (duration: 135.610137ms)","trace[691054872] 'compare' (duration: 34.871823ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:25.492008Z","caller":"traceutil/trace.go:171","msg":"trace[1235146151] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"107.841187ms","start":"2026-04-15T05:11:25.38415Z","end":"2026-04-15T05:11:25.491991Z","steps":["trace[1235146151] 'process raft request' (duration: 107.663382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:31.0101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.882554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-04-15T05:11:31.010221Z","caller":"traceutil/trace.go:171","msg":"trace[1921668487] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5191; }","duration":"106.046588ms","start":"2026-04-15T05:11:30.904146Z","end":"2026-04-15T05:11:31.010193Z","steps":["trace[1921668487] 'range keys from in-memory index tree' (duration: 105.706099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:46.344247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.371855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2b9c062b-3fc7-41d7-a7f3-af8716310831\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-15T05:11:46.34433Z","caller":"traceutil/trace.go:171","msg":"trace[2023357444] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2b9c062b-3fc7-41d7-a7f3-af8716310831; range_end:; response_count:1; response_revision:5460; }","duration":"164.498559ms","start":"2026-04-15T05:11:46.179816Z","end":"2026-04-15T05:11:46.344315Z","steps":["trace[2023357444] 'range keys from in-memory index tree' (duration: 164.039706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:46.767115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.104838ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T05:11:46.767316Z","caller":"traceutil/trace.go:171","msg":"trace[598465223] linearizableReadLoop","detail":"{readStateIndex:5674; appliedIndex:5672; }","duration":"314.286921ms","start":"2026-04-15T05:11:46.453012Z","end":"2026-04-15T05:11:46.767298Z","steps":["trace[598465223] 'read index received' (duration: 115.901465ms)","trace[598465223] 'applied index is now lower than readState.Index' (duration: 198.384486ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:46.767423Z","caller":"traceutil/trace.go:171","msg":"trace[2046796378] transaction","detail":"{read_only:false; response_revision:5463; number_of_response:1; }","duration":"448.542541ms","start":"2026-04-15T05:11:46.318806Z","end":"2026-04-15T05:11:46.767349Z","steps":["trace[2046796378] 'process raft request' (duration: 250.118975ms)","trace[2046796378] 'compare' (duration: 197.939993ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:11:46.767567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.910013ms","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":"warn","ts":"2026-04-15T05:11:46.767606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:46.318777Z","time spent":"448.730976ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T05:11:46.767641Z","caller":"traceutil/trace.go:171","msg":"trace[1311633161] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5464; }","duration":"313.036137ms","start":"2026-04-15T05:11:46.454587Z","end":"2026-04-15T05:11:46.767623Z","steps":["trace[1311633161] 'agreement among raft nodes before linearized reading' (duration: 312.897463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:46.767641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.618809ms","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-15T05:11:46.767683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.0776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"warn","ts":"2026-04-15T05:11:46.767705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:46.454567Z","time spent":"313.122218ms","remote":"127.0.0.1:37442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":10,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-04-15T05:11:46.767709Z","caller":"traceutil/trace.go:171","msg":"trace[1944278088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5464; }","duration":"314.735282ms","start":"2026-04-15T05:11:46.452959Z","end":"2026-04-15T05:11:46.767694Z","steps":["trace[1944278088] 'agreement among raft nodes before linearized reading' (duration: 314.529747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:46.767716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.034618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hbp7s\" ","response":"range_response_count:1 size:6527"} {"level":"warn","ts":"2026-04-15T05:11:46.767695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.313318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-15T05:11:46.767757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:46.45294Z","time spent":"314.806034ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-15T05:11:46.767754Z","caller":"traceutil/trace.go:171","msg":"trace[1024762256] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5464; }","duration":"160.175741ms","start":"2026-04-15T05:11:46.607557Z","end":"2026-04-15T05:11:46.767732Z","steps":["trace[1024762256] 'agreement among raft nodes before linearized reading' (duration: 159.962146ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:46.767767Z","caller":"traceutil/trace.go:171","msg":"trace[634342850] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hbp7s; range_end:; response_count:1; response_revision:5464; }","duration":"299.085879ms","start":"2026-04-15T05:11:46.468666Z","end":"2026-04-15T05:11:46.767752Z","steps":["trace[634342850] 'agreement among raft nodes before linearized reading' (duration: 298.922345ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:46.767784Z","caller":"traceutil/trace.go:171","msg":"trace[636640604] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5464; }","duration":"288.43076ms","start":"2026-04-15T05:11:46.479335Z","end":"2026-04-15T05:11:46.767766Z","steps":["trace[636640604] 'agreement among raft nodes before linearized reading' (duration: 288.174433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:46.767709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.879857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-15T05:11:46.767851Z","caller":"traceutil/trace.go:171","msg":"trace[2082034891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5464; }","duration":"301.051662ms","start":"2026-04-15T05:11:46.466789Z","end":"2026-04-15T05:11:46.767841Z","steps":["trace[2082034891] 'agreement among raft nodes before linearized reading' (duration: 300.753474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:46.767873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:46.466775Z","time spent":"301.091623ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-15T05:11:46.767868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.320739ms","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-15T05:11:46.767853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.019125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2b9c062b-3fc7-41d7-a7f3-af8716310831\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-04-15T05:11:46.767927Z","caller":"traceutil/trace.go:171","msg":"trace[292074942] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5464; }","duration":"308.410951ms","start":"2026-04-15T05:11:46.459495Z","end":"2026-04-15T05:11:46.767906Z","steps":["trace[292074942] 'agreement among raft nodes before linearized reading' (duration: 308.283698ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:46.767945Z","caller":"traceutil/trace.go:171","msg":"trace[1817618662] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2b9c062b-3fc7-41d7-a7f3-af8716310831; range_end:; response_count:1; response_revision:5464; }","duration":"249.219521ms","start":"2026-04-15T05:11:46.518701Z","end":"2026-04-15T05:11:46.76792Z","steps":["trace[1817618662] 'agreement among raft nodes before linearized reading' (duration: 248.84768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:46.767972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:46.459474Z","time spent":"308.486944ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-15T05:11:46.768012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.60828ms","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-15T05:11:46.768103Z","caller":"traceutil/trace.go:171","msg":"trace[446022897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5464; }","duration":"307.733403ms","start":"2026-04-15T05:11:46.460345Z","end":"2026-04-15T05:11:46.768078Z","steps":["trace[446022897] 'agreement among raft nodes before linearized reading' (duration: 307.346692ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:46.768011Z","caller":"traceutil/trace.go:171","msg":"trace[1991151170] transaction","detail":"{read_only:false; response_revision:5464; number_of_response:1; }","duration":"446.800534ms","start":"2026-04-15T05:11:46.321191Z","end":"2026-04-15T05:11:46.767992Z","steps":["trace[1991151170] 'process raft request' (duration: 446.046194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:46.768159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:46.460335Z","time spent":"307.814075ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-15T05:11:46.768225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:11:46.32118Z","time spent":"446.989669ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:11:46.875211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.539855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18873"} {"level":"warn","ts":"2026-04-15T05:11:46.875253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.13172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:80205"} {"level":"info","ts":"2026-04-15T05:11:46.875352Z","caller":"traceutil/trace.go:171","msg":"trace[1115445840] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5471; }","duration":"102.266664ms","start":"2026-04-15T05:11:46.773073Z","end":"2026-04-15T05:11:46.87534Z","steps":["trace[1115445840] 'agreement among raft nodes before linearized reading' (duration: 93.529858ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:46.875291Z","caller":"traceutil/trace.go:171","msg":"trace[1091816992] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5471; }","duration":"101.72801ms","start":"2026-04-15T05:11:46.773545Z","end":"2026-04-15T05:11:46.875273Z","steps":["trace[1091816992] 'agreement among raft nodes before linearized reading' (duration: 93.038285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:58.908199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.529199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T05:11:58.90852Z","caller":"traceutil/trace.go:171","msg":"trace[8952800] transaction","detail":"{read_only:false; response_revision:5661; number_of_response:1; }","duration":"216.505075ms","start":"2026-04-15T05:11:58.691984Z","end":"2026-04-15T05:11:58.908489Z","steps":["trace[8952800] 'process raft request' (duration: 216.340981ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:58.908533Z","caller":"traceutil/trace.go:171","msg":"trace[1235480510] linearizableReadLoop","detail":"{readStateIndex:5879; appliedIndex:5876; }","duration":"181.885789ms","start":"2026-04-15T05:11:58.726623Z","end":"2026-04-15T05:11:58.908509Z","steps":["trace[1235480510] 'read index received' (duration: 70.809115ms)","trace[1235480510] 'applied index is now lower than readState.Index' (duration: 111.075364ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:58.908553Z","caller":"traceutil/trace.go:171","msg":"trace[414512354] transaction","detail":"{read_only:false; response_revision:5660; number_of_response:1; }","duration":"216.500095ms","start":"2026-04-15T05:11:58.69193Z","end":"2026-04-15T05:11:58.90843Z","steps":["trace[414512354] 'process raft request' (duration: 105.635406ms)","trace[414512354] 'compare' (duration: 110.282333ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:11:58.908644Z","caller":"traceutil/trace.go:171","msg":"trace[233324362] transaction","detail":"{read_only:false; response_revision:5662; number_of_response:1; }","duration":"215.809706ms","start":"2026-04-15T05:11:58.692817Z","end":"2026-04-15T05:11:58.908627Z","steps":["trace[233324362] 'process raft request' (duration: 215.5869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:58.909448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.760442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-15T05:11:58.909493Z","caller":"traceutil/trace.go:171","msg":"trace[669260120] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5662; }","duration":"182.902306ms","start":"2026-04-15T05:11:58.726578Z","end":"2026-04-15T05:11:58.909481Z","steps":["trace[669260120] 'agreement among raft nodes before linearized reading' (duration: 182.011102ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:58.91149Z","caller":"traceutil/trace.go:171","msg":"trace[1573451460] transaction","detail":"{read_only:false; response_revision:5663; number_of_response:1; }","duration":"107.700133ms","start":"2026-04-15T05:11:58.80374Z","end":"2026-04-15T05:11:58.91144Z","steps":["trace[1573451460] 'process raft request' (duration: 107.391805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:11:58.91151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.686618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:11:58.91182Z","caller":"traceutil/trace.go:171","msg":"trace[1035936097] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:5664; }","duration":"157.045487ms","start":"2026-04-15T05:11:58.75474Z","end":"2026-04-15T05:11:58.911786Z","steps":["trace[1035936097] 'agreement among raft nodes before linearized reading' (duration: 156.642356ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:11:58.912127Z","caller":"traceutil/trace.go:171","msg":"trace[463369570] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"106.1084ms","start":"2026-04-15T05:11:58.805393Z","end":"2026-04-15T05:11:58.911502Z","steps":["trace[463369570] 'process raft request' (duration: 105.935585ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:12:09.146084Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2821} {"level":"info","ts":"2026-04-15T05:12:09.216069Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2821,"took":"68.677997ms","hash":3230598548,"current-db-size-bytes":55058432,"current-db-size":"55 MB","current-db-size-in-use-bytes":31727616,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-15T05:12:09.216156Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3230598548,"revision":2821,"compact-revision":-1} {"level":"info","ts":"2026-04-15T05:16:06.547437Z","caller":"traceutil/trace.go:171","msg":"trace[412876784] linearizableReadLoop","detail":"{readStateIndex:7745; appliedIndex:7744; }","duration":"365.56054ms","start":"2026-04-15T05:16:06.181856Z","end":"2026-04-15T05:16:06.547417Z","steps":["trace[412876784] 'read index received' (duration: 365.442567ms)","trace[412876784] 'applied index is now lower than readState.Index' (duration: 117.053µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:16:06.547545Z","caller":"traceutil/trace.go:171","msg":"trace[41739500] transaction","detail":"{read_only:false; response_revision:7470; number_of_response:1; }","duration":"463.604643ms","start":"2026-04-15T05:16:06.083908Z","end":"2026-04-15T05:16:06.547513Z","steps":["trace[41739500] 'process raft request' (duration: 463.384367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:16:06.547651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.793797ms","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-15T05:16:06.547684Z","caller":"traceutil/trace.go:171","msg":"trace[1382177301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7470; }","duration":"365.880989ms","start":"2026-04-15T05:16:06.181793Z","end":"2026-04-15T05:16:06.547674Z","steps":["trace[1382177301] 'agreement among raft nodes before linearized reading' (duration: 365.778756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:16:06.547705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:16:06.181769Z","time spent":"365.929881ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-15T05:16:06.547712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:16:06.083893Z","time spent":"463.728237ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:16:06.547913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.311425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hbp7s\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-15T05:16:06.547942Z","caller":"traceutil/trace.go:171","msg":"trace[2017063221] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hbp7s; range_end:; response_count:1; response_revision:7470; }","duration":"174.343557ms","start":"2026-04-15T05:16:06.373593Z","end":"2026-04-15T05:16:06.547936Z","steps":["trace[2017063221] 'agreement among raft nodes before linearized reading' (duration: 174.237914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:16:06.547946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.968718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-15T05:16:06.548213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.306968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-15T05:16:06.548262Z","caller":"traceutil/trace.go:171","msg":"trace[1222087422] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7470; }","duration":"360.37062ms","start":"2026-04-15T05:16:06.18788Z","end":"2026-04-15T05:16:06.54825Z","steps":["trace[1222087422] 'agreement among raft nodes before linearized reading' (duration: 360.123803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:16:06.548262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.08278ms","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-15T05:16:06.548296Z","caller":"traceutil/trace.go:171","msg":"trace[1058239392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7470; }","duration":"361.148871ms","start":"2026-04-15T05:16:06.187138Z","end":"2026-04-15T05:16:06.548287Z","steps":["trace[1058239392] 'agreement among raft nodes before linearized reading' (duration: 361.071079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:16:06.548326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:16:06.187122Z","time spent":"361.195333ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-15T05:16:06.548332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:16:06.187874Z","time spent":"360.410772ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-15T05:16:06.548324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.349269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:16:06.548336Z","caller":"traceutil/trace.go:171","msg":"trace[1474994733] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7470; }","duration":"364.396649ms","start":"2026-04-15T05:16:06.183765Z","end":"2026-04-15T05:16:06.548161Z","steps":["trace[1474994733] 'agreement among raft nodes before linearized reading' (duration: 363.876815ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:16:06.54842Z","caller":"traceutil/trace.go:171","msg":"trace[258701601] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:7470; }","duration":"292.504384ms","start":"2026-04-15T05:16:06.255895Z","end":"2026-04-15T05:16:06.548399Z","steps":["trace[258701601] 'agreement among raft nodes before linearized reading' (duration: 292.282468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:16:06.548433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:16:06.183751Z","time spent":"364.669156ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-15T05:17:09.151359Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5742} {"level":"info","ts":"2026-04-15T05:17:09.231661Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5742,"took":"78.185804ms","hash":354461207,"current-db-size-bytes":55058432,"current-db-size":"55 MB","current-db-size-in-use-bytes":26038272,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-15T05:17:09.23174Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":354461207,"revision":5742,"compact-revision":2821} {"level":"info","ts":"2026-04-15T05:18:00.055332Z","caller":"traceutil/trace.go:171","msg":"trace[1815953409] transaction","detail":"{read_only:false; response_revision:8374; number_of_response:1; }","duration":"390.503429ms","start":"2026-04-15T05:17:59.6648Z","end":"2026-04-15T05:18:00.055303Z","steps":["trace[1815953409] 'process raft request' (duration: 390.314844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:00.055498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:17:59.664775Z","time spent":"390.642413ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T05:18:00.057924Z","caller":"traceutil/trace.go:171","msg":"trace[336473918] linearizableReadLoop","detail":"{readStateIndex:8678; appliedIndex:8676; }","duration":"263.206157ms","start":"2026-04-15T05:17:59.794693Z","end":"2026-04-15T05:18:00.057899Z","steps":["trace[336473918] 'read index received' (duration: 260.418202ms)","trace[336473918] 'applied index is now lower than readState.Index' (duration: 2.786815ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:18:00.058079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.360681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-15T05:18:00.058114Z","caller":"traceutil/trace.go:171","msg":"trace[218582457] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:8375; }","duration":"263.452463ms","start":"2026-04-15T05:17:59.794652Z","end":"2026-04-15T05:18:00.058105Z","steps":["trace[218582457] 'agreement among raft nodes before linearized reading' (duration: 263.371291ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:00.058075Z","caller":"traceutil/trace.go:171","msg":"trace[851155241] transaction","detail":"{read_only:false; response_revision:8375; number_of_response:1; }","duration":"389.752128ms","start":"2026-04-15T05:17:59.66828Z","end":"2026-04-15T05:18:00.058032Z","steps":["trace[851155241] 'process raft request' (duration: 389.486911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:00.058249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:17:59.668245Z","time spent":"389.922043ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:18:00.058265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.252351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-15T05:18:00.058379Z","caller":"traceutil/trace.go:171","msg":"trace[201996534] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:8375; }","duration":"218.392015ms","start":"2026-04-15T05:17:59.839967Z","end":"2026-04-15T05:18:00.058359Z","steps":["trace[201996534] 'agreement among raft nodes before linearized reading' (duration: 218.126098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:11.46268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.546873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-hbp7s\" ","response":"range_response_count:1 size:6527"} {"level":"info","ts":"2026-04-15T05:18:11.462756Z","caller":"traceutil/trace.go:171","msg":"trace[1389475530] range","detail":"{range_begin:/registry/pods/openstack/keepalived-hbp7s; range_end:; response_count:1; response_revision:8434; }","duration":"149.676957ms","start":"2026-04-15T05:18:11.313062Z","end":"2026-04-15T05:18:11.462739Z","steps":["trace[1389475530] 'range keys from in-memory index tree' (duration: 149.380369ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:12.397869Z","caller":"traceutil/trace.go:171","msg":"trace[1150706002] linearizableReadLoop","detail":"{readStateIndex:8746; appliedIndex:8745; }","duration":"165.719701ms","start":"2026-04-15T05:18:12.232126Z","end":"2026-04-15T05:18:12.397846Z","steps":["trace[1150706002] 'read index received' (duration: 84.33039ms)","trace[1150706002] 'applied index is now lower than readState.Index' (duration: 81.388411ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:18:12.397876Z","caller":"traceutil/trace.go:171","msg":"trace[922241711] transaction","detail":"{read_only:false; response_revision:8440; number_of_response:1; }","duration":"191.672653ms","start":"2026-04-15T05:18:12.206182Z","end":"2026-04-15T05:18:12.397854Z","steps":["trace[922241711] 'process raft request' (duration: 109.923663ms)","trace[922241711] 'compare' (duration: 81.557695ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:18:12.397956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.827873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:18:12.397977Z","caller":"traceutil/trace.go:171","msg":"trace[1475265784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8440; }","duration":"165.895735ms","start":"2026-04-15T05:18:12.232074Z","end":"2026-04-15T05:18:12.39797Z","steps":["trace[1475265784] 'agreement among raft nodes before linearized reading' (duration: 165.844994ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:12.41931Z","caller":"traceutil/trace.go:171","msg":"trace[1360888972] transaction","detail":"{read_only:false; response_revision:8441; number_of_response:1; }","duration":"150.50073ms","start":"2026-04-15T05:18:12.268784Z","end":"2026-04-15T05:18:12.419285Z","steps":["trace[1360888972] 'process raft request' (duration: 150.285044ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:13.813413Z","caller":"traceutil/trace.go:171","msg":"trace[1496500845] transaction","detail":"{read_only:false; response_revision:8448; number_of_response:1; }","duration":"115.535644ms","start":"2026-04-15T05:18:13.69785Z","end":"2026-04-15T05:18:13.813386Z","steps":["trace[1496500845] 'process raft request' (duration: 115.39512ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:18.304296Z","caller":"traceutil/trace.go:171","msg":"trace[818586738] transaction","detail":"{read_only:false; response_revision:8477; number_of_response:1; }","duration":"179.264077ms","start":"2026-04-15T05:18:18.125005Z","end":"2026-04-15T05:18:18.304269Z","steps":["trace[818586738] 'process raft request' (duration: 179.064822ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:18.309853Z","caller":"traceutil/trace.go:171","msg":"trace[1849317194] transaction","detail":"{read_only:false; response_revision:8478; number_of_response:1; }","duration":"179.470763ms","start":"2026-04-15T05:18:18.13036Z","end":"2026-04-15T05:18:18.309831Z","steps":["trace[1849317194] 'process raft request' (duration: 179.33656ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:18.86722Z","caller":"traceutil/trace.go:171","msg":"trace[2043721828] linearizableReadLoop","detail":"{readStateIndex:8787; appliedIndex:8785; }","duration":"340.837256ms","start":"2026-04-15T05:18:18.526368Z","end":"2026-04-15T05:18:18.867205Z","steps":["trace[2043721828] 'read index received' (duration: 337.795054ms)","trace[2043721828] 'applied index is now lower than readState.Index' (duration: 3.041282ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:18:18.867286Z","caller":"traceutil/trace.go:171","msg":"trace[324792796] transaction","detail":"{read_only:false; response_revision:8479; number_of_response:1; }","duration":"448.520957ms","start":"2026-04-15T05:18:18.418755Z","end":"2026-04-15T05:18:18.867276Z","steps":["trace[324792796] 'process raft request' (duration: 445.264559ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:18.867292Z","caller":"traceutil/trace.go:171","msg":"trace[2105180792] transaction","detail":"{read_only:false; response_revision:8480; number_of_response:1; }","duration":"429.157564ms","start":"2026-04-15T05:18:18.438129Z","end":"2026-04-15T05:18:18.867287Z","steps":["trace[2105180792] 'process raft request' (duration: 429.026121ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:18.867361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:18:18.418731Z","time spent":"448.576309ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:18:18.867391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:18:18.438097Z","time spent":"429.268217ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:18:18.867482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.313496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:18:18.867501Z","caller":"traceutil/trace.go:171","msg":"trace[1355486380] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:8480; }","duration":"325.392528ms","start":"2026-04-15T05:18:18.542103Z","end":"2026-04-15T05:18:18.867495Z","steps":["trace[1355486380] 'agreement among raft nodes before linearized reading' (duration: 325.338236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:18.867516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:18:18.542082Z","time spent":"325.430519ms","remote":"127.0.0.1:53154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-15T05:18:18.867611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.252347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:18:18.867628Z","caller":"traceutil/trace.go:171","msg":"trace[909416104] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8480; }","duration":"341.303788ms","start":"2026-04-15T05:18:18.526318Z","end":"2026-04-15T05:18:18.867622Z","steps":["trace[909416104] 'agreement among raft nodes before linearized reading' (duration: 341.279898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:18.86764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:18:18.5263Z","time spent":"341.33688ms","remote":"127.0.0.1:36938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-15T05:18:19.427297Z","caller":"traceutil/trace.go:171","msg":"trace[1228573143] linearizableReadLoop","detail":"{readStateIndex:8788; appliedIndex:8787; }","duration":"136.598684ms","start":"2026-04-15T05:18:19.290674Z","end":"2026-04-15T05:18:19.427273Z","steps":["trace[1228573143] 'read index received' (duration: 136.410229ms)","trace[1228573143] 'applied index is now lower than readState.Index' (duration: 187.425µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:18:19.427613Z","caller":"traceutil/trace.go:171","msg":"trace[1743831349] transaction","detail":"{read_only:false; response_revision:8481; number_of_response:1; }","duration":"171.819556ms","start":"2026-04-15T05:18:19.255757Z","end":"2026-04-15T05:18:19.427577Z","steps":["trace[1743831349] 'process raft request' (duration: 171.317943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:19.427717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.021725ms","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-15T05:18:19.427755Z","caller":"traceutil/trace.go:171","msg":"trace[1778417862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8481; }","duration":"137.094426ms","start":"2026-04-15T05:18:19.290642Z","end":"2026-04-15T05:18:19.427736Z","steps":["trace[1778417862] 'agreement among raft nodes before linearized reading' (duration: 136.925942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:19.428778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.035438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-15T05:18:19.428853Z","caller":"traceutil/trace.go:171","msg":"trace[208977453] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8482; }","duration":"126.153711ms","start":"2026-04-15T05:18:19.302682Z","end":"2026-04-15T05:18:19.428836Z","steps":["trace[208977453] 'agreement among raft nodes before linearized reading' (duration: 125.944066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:19.429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.638738ms","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-15T05:18:19.429056Z","caller":"traceutil/trace.go:171","msg":"trace[1992494025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8482; }","duration":"118.729351ms","start":"2026-04-15T05:18:19.310312Z","end":"2026-04-15T05:18:19.429042Z","steps":["trace[1992494025] 'agreement among raft nodes before linearized reading' (duration: 118.605677ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:44.638408Z","caller":"traceutil/trace.go:171","msg":"trace[55224417] transaction","detail":"{read_only:false; response_revision:8663; number_of_response:1; }","duration":"224.817858ms","start":"2026-04-15T05:18:44.413561Z","end":"2026-04-15T05:18:44.638379Z","steps":["trace[55224417] 'process raft request' (duration: 224.653034ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:44.808938Z","caller":"traceutil/trace.go:171","msg":"trace[832059157] transaction","detail":"{read_only:false; response_revision:8665; number_of_response:1; }","duration":"368.582136ms","start":"2026-04-15T05:18:44.440333Z","end":"2026-04-15T05:18:44.808915Z","steps":["trace[832059157] 'process raft request' (duration: 368.525854ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:44.808966Z","caller":"traceutil/trace.go:171","msg":"trace[1823839558] transaction","detail":"{read_only:false; response_revision:8664; number_of_response:1; }","duration":"388.803223ms","start":"2026-04-15T05:18:44.420131Z","end":"2026-04-15T05:18:44.808934Z","steps":["trace[1823839558] 'process raft request' (duration: 388.576717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:44.809161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:18:44.420116Z","time spent":"388.937886ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T05:18:44.809192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T05:18:44.440311Z","time spent":"368.72098ms","remote":"127.0.0.1:37218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T05:18:44.834541Z","caller":"traceutil/trace.go:171","msg":"trace[1198326432] transaction","detail":"{read_only:false; response_revision:8666; number_of_response:1; }","duration":"144.143568ms","start":"2026-04-15T05:18:44.69037Z","end":"2026-04-15T05:18:44.834513Z","steps":["trace[1198326432] 'process raft request' (duration: 143.979873ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:53.037954Z","caller":"traceutil/trace.go:171","msg":"trace[2126758154] linearizableReadLoop","detail":"{readStateIndex:9069; appliedIndex:9067; }","duration":"122.254715ms","start":"2026-04-15T05:18:52.915681Z","end":"2026-04-15T05:18:53.037936Z","steps":["trace[2126758154] 'read index received' (duration: 74.170135ms)","trace[2126758154] 'applied index is now lower than readState.Index' (duration: 48.08401ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:18:53.03807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.374399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-l276w\" ","response":"range_response_count:1 size:4647"} {"level":"info","ts":"2026-04-15T05:18:53.038096Z","caller":"traceutil/trace.go:171","msg":"trace[1042685996] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-l276w; range_end:; response_count:1; response_revision:8751; }","duration":"122.438391ms","start":"2026-04-15T05:18:52.915649Z","end":"2026-04-15T05:18:53.038088Z","steps":["trace[1042685996] 'agreement among raft nodes before linearized reading' (duration: 122.362958ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:53.038312Z","caller":"traceutil/trace.go:171","msg":"trace[1625192627] transaction","detail":"{read_only:false; response_revision:8748; number_of_response:1; }","duration":"177.977512ms","start":"2026-04-15T05:18:52.860326Z","end":"2026-04-15T05:18:53.038304Z","steps":["trace[1625192627] 'process raft request' (duration: 129.513102ms)","trace[1625192627] 'compare' (duration: 47.738181ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:18:53.038467Z","caller":"traceutil/trace.go:171","msg":"trace[648613476] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8749; }","duration":"176.197414ms","start":"2026-04-15T05:18:52.862264Z","end":"2026-04-15T05:18:53.038461Z","steps":["trace[648613476] 'process raft request' (duration: 175.551936ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:53.038609Z","caller":"traceutil/trace.go:171","msg":"trace[1325083825] transaction","detail":"{read_only:false; response_revision:8750; number_of_response:1; }","duration":"122.611895ms","start":"2026-04-15T05:18:52.915991Z","end":"2026-04-15T05:18:53.038603Z","steps":["trace[1325083825] 'process raft request' (duration: 121.875236ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:53.242154Z","caller":"traceutil/trace.go:171","msg":"trace[2055468271] linearizableReadLoop","detail":"{readStateIndex:9073; appliedIndex:9072; }","duration":"194.114809ms","start":"2026-04-15T05:18:53.04802Z","end":"2026-04-15T05:18:53.242135Z","steps":["trace[2055468271] 'read index received' (duration: 193.938564ms)","trace[2055468271] 'applied index is now lower than readState.Index' (duration: 175.545µs)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:18:53.242249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.215721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-l276w\" ","response":"range_response_count:1 size:4652"} {"level":"info","ts":"2026-04-15T05:18:53.242276Z","caller":"traceutil/trace.go:171","msg":"trace[869327272] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-l276w; range_end:; response_count:1; response_revision:8753; }","duration":"194.274793ms","start":"2026-04-15T05:18:53.047992Z","end":"2026-04-15T05:18:53.242266Z","steps":["trace[869327272] 'agreement among raft nodes before linearized reading' (duration: 194.216042ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:18:53.242366Z","caller":"traceutil/trace.go:171","msg":"trace[1971038565] transaction","detail":"{read_only:false; response_revision:8753; number_of_response:1; }","duration":"196.72909ms","start":"2026-04-15T05:18:53.045512Z","end":"2026-04-15T05:18:53.242241Z","steps":["trace[1971038565] 'process raft request' (duration: 196.505564ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T05:18:53.774959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.57333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T05:18:53.7755Z","caller":"traceutil/trace.go:171","msg":"trace[32845688] transaction","detail":"{read_only:false; response_revision:8758; number_of_response:1; }","duration":"131.812374ms","start":"2026-04-15T05:18:53.643629Z","end":"2026-04-15T05:18:53.775441Z","steps":["trace[32845688] 'process raft request' (duration: 20.685839ms)","trace[32845688] 'compare' (duration: 110.467067ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T05:19:25.896946Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024bf.wal"} {"level":"info","ts":"2026-04-15T05:20:11.58613Z","caller":"traceutil/trace.go:171","msg":"trace[1845476137] transaction","detail":"{read_only:false; response_revision:9510; number_of_response:1; }","duration":"270.072349ms","start":"2026-04-15T05:20:11.31603Z","end":"2026-04-15T05:20:11.586102Z","steps":["trace[1845476137] 'process raft request' (duration: 269.871143ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:20:11.599468Z","caller":"traceutil/trace.go:171","msg":"trace[278001656] linearizableReadLoop","detail":"{readStateIndex:9851; appliedIndex:9849; }","duration":"267.416467ms","start":"2026-04-15T05:20:11.332024Z","end":"2026-04-15T05:20:11.599441Z","steps":["trace[278001656] 'read index received' (duration: 253.830052ms)","trace[278001656] 'applied index is now lower than readState.Index' (duration: 13.585055ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T05:20:11.59966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.610223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T05:20:11.599665Z","caller":"traceutil/trace.go:171","msg":"trace[1886799054] transaction","detail":"{read_only:false; response_revision:9511; number_of_response:1; }","duration":"275.824943ms","start":"2026-04-15T05:20:11.323759Z","end":"2026-04-15T05:20:11.599584Z","steps":["trace[1886799054] 'process raft request' (duration: 275.565096ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:20:11.59971Z","caller":"traceutil/trace.go:171","msg":"trace[803963838] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:9511; }","duration":"267.722866ms","start":"2026-04-15T05:20:11.331971Z","end":"2026-04-15T05:20:11.599694Z","steps":["trace[803963838] 'agreement among raft nodes before linearized reading' (duration: 267.579032ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T05:20:28.219711Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"4da37caf00b87dfe","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-15T05:20:28.226543Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-15T05:20:28.226617Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-15T05:22:09.157419Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7906} {"level":"info","ts":"2026-04-15T05:22:09.217042Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7906,"took":"57.581485ms","hash":479875020,"current-db-size-bytes":55058432,"current-db-size":"55 MB","current-db-size-in-use-bytes":28393472,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-15T05:22:09.217127Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":479875020,"revision":7906,"compact-revision":5742} {"level":"info","ts":"2026-04-15T05:27:09.163497Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10360} {"level":"info","ts":"2026-04-15T05:27:09.250602Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10360,"took":"82.523203ms","hash":1335059596,"current-db-size-bytes":55058432,"current-db-size":"55 MB","current-db-size-in-use-bytes":22020096,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-15T05:27:09.250689Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1335059596,"revision":10360,"compact-revision":7906}