{"level":"warn","ts":"2026-10-13T10:46:17.074855Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T10:46:17.074947Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.176:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.176:2380","--initial-cluster=instance=https://162.253.55.176:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.176:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.176:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-10-13T10:46:17.075031Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-13T10:46:17.075045Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-10-13T10:46:17.075064Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-13T10:46:17.075645Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"]} {"level":"info","ts":"2026-10-13T10:46:17.075856Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.176:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-10-13T10:46:17.080641Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.339337ms"} {"level":"info","ts":"2026-10-13T10:46:17.091206Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"590b810b00f00655","cluster-id":"dcc6923d0deac545"} {"level":"info","ts":"2026-10-13T10:46:17.091287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=()"} {"level":"info","ts":"2026-10-13T10:46:17.091306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 0"} {"level":"info","ts":"2026-10-13T10:46:17.091317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 590b810b00f00655 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-13T10:46:17.091324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became follower at term 1"} {"level":"info","ts":"2026-10-13T10:46:17.091389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"warn","ts":"2026-10-13T10:46:17.098279Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-13T10:46:17.101087Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-13T10:46:17.10226Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-10-13T10:46:17.104125Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"590b810b00f00655","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-13T10:46:17.104278Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"590b810b00f00655","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-13T10:46:17.104368Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-13T10:46:17.104406Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-13T10:46:17.104413Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-10-13T10:46:17.105226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 switched to configuration voters=(6416363978379757141)"} {"level":"info","ts":"2026-10-13T10:46:17.105311Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","added-peer-id":"590b810b00f00655","added-peer-peer-urls":["https://162.253.55.176:2380"]} {"level":"info","ts":"2026-10-13T10:46:17.106361Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-10-13T10:46:17.106422Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-10-13T10:46:17.106443Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.176:2380"} {"level":"info","ts":"2026-10-13T10:46:17.106577Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"590b810b00f00655","initial-advertise-peer-urls":["https://162.253.55.176:2380"],"listen-peer-urls":["https://162.253.55.176:2380"],"advertise-client-urls":["https://162.253.55.176:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.176:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-13T10:46:17.106614Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-13T10:46:18.092412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 is starting a new election at term 1"} {"level":"info","ts":"2026-10-13T10:46:18.09249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-13T10:46:18.092522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgPreVoteResp from 590b810b00f00655 at term 1"} {"level":"info","ts":"2026-10-13T10:46:18.092546Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became candidate at term 2"} {"level":"info","ts":"2026-10-13T10:46:18.092559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 received MsgVoteResp from 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-10-13T10:46:18.092594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"590b810b00f00655 became leader at term 2"} {"level":"info","ts":"2026-10-13T10:46:18.092608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 590b810b00f00655 elected leader 590b810b00f00655 at term 2"} {"level":"info","ts":"2026-10-13T10:46:18.09337Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T10:46:18.094138Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"590b810b00f00655","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.176:2379]}","request-path":"/0/members/590b810b00f00655/attributes","cluster-id":"dcc6923d0deac545","publish-timeout":"7s"} {"level":"info","ts":"2026-10-13T10:46:18.094153Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T10:46:18.094334Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-13T10:46:18.094432Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-13T10:46:18.094582Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dcc6923d0deac545","local-member-id":"590b810b00f00655","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T10:46:18.094717Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-13T10:46:18.094738Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T10:46:18.094779Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-13T10:46:18.096779Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.176:2379"} {"level":"info","ts":"2026-10-13T10:46:18.096788Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-13T10:46:19.540887Z","caller":"traceutil/trace.go:171","msg":"trace[1739111518] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"133.44217ms","start":"2026-10-13T10:46:19.407408Z","end":"2026-10-13T10:46:19.54085Z","steps":["trace[1739111518] 'process raft request' (duration: 133.009603ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.857528Z","caller":"traceutil/trace.go:171","msg":"trace[1898196071] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"446.453667ms","start":"2026-10-13T10:46:19.411034Z","end":"2026-10-13T10:46:19.857488Z","steps":["trace[1898196071] 'process raft request' (duration: 383.274921ms)","trace[1898196071] 'compare' (duration: 62.927452ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:46:19.857806Z","caller":"traceutil/trace.go:171","msg":"trace[374059248] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"381.599375ms","start":"2026-10-13T10:46:19.476193Z","end":"2026-10-13T10:46:19.857793Z","steps":["trace[374059248] 'process raft request' (duration: 381.25471ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.857774Z","caller":"traceutil/trace.go:171","msg":"trace[303772159] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"445.700686ms","start":"2026-10-13T10:46:19.412051Z","end":"2026-10-13T10:46:19.857752Z","steps":["trace[303772159] 'read index received' (duration: 128.411274ms)","trace[303772159] 'applied index is now lower than readState.Index' (duration: 317.288292ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:46:19.857974Z","caller":"traceutil/trace.go:171","msg":"trace[298336408] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"382.007112ms","start":"2026-10-13T10:46:19.475956Z","end":"2026-10-13T10:46:19.857963Z","steps":["trace[298336408] 'process raft request' (duration: 381.463054ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.858073Z","caller":"traceutil/trace.go:171","msg":"trace[908159671] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"381.760117ms","start":"2026-10-13T10:46:19.476308Z","end":"2026-10-13T10:46:19.858068Z","steps":["trace[908159671] 'process raft request' (duration: 381.216299ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.858097Z","caller":"traceutil/trace.go:171","msg":"trace[1459675271] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"381.790838ms","start":"2026-10-13T10:46:19.476302Z","end":"2026-10-13T10:46:19.858093Z","steps":["trace[1459675271] 'process raft request' (duration: 381.207759ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.858118Z","caller":"traceutil/trace.go:171","msg":"trace[933691407] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"362.054116ms","start":"2026-10-13T10:46:19.49606Z","end":"2026-10-13T10:46:19.858114Z","steps":["trace[933691407] 'process raft request' (duration: 361.547029ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.858136Z","caller":"traceutil/trace.go:171","msg":"trace[1707128162] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"381.301051ms","start":"2026-10-13T10:46:19.476831Z","end":"2026-10-13T10:46:19.858132Z","steps":["trace[1707128162] 'process raft request' (duration: 380.716153ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.858131Z","caller":"traceutil/trace.go:171","msg":"trace[1761223133] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"381.730337ms","start":"2026-10-13T10:46:19.476262Z","end":"2026-10-13T10:46:19.857993Z","steps":["trace[1761223133] 'process raft request' (duration: 381.22926ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.858197Z","caller":"traceutil/trace.go:171","msg":"trace[1757822315] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"362.147008ms","start":"2026-10-13T10:46:19.496045Z","end":"2026-10-13T10:46:19.858192Z","steps":["trace[1757822315] 'process raft request' (duration: 361.542639ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:46:19.858306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.527604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T10:46:19.85835Z","caller":"traceutil/trace.go:171","msg":"trace[1262933309] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"398.618536ms","start":"2026-10-13T10:46:19.459726Z","end":"2026-10-13T10:46:19.858344Z","steps":["trace[1262933309] 'agreement among raft nodes before linearized reading' (duration: 398.501134ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:46:19.858366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.459692Z","time spent":"398.669587ms","remote":"127.0.0.1:59602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-13T10:46:19.858404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.451619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.176\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-13T10:46:19.858479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.951393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T10:46:19.858489Z","caller":"traceutil/trace.go:171","msg":"trace[1401132671] range","detail":"{range_begin:/registry/masterleases/162.253.55.176; range_end:; response_count:0; response_revision:11; }","duration":"382.567661ms","start":"2026-10-13T10:46:19.475886Z","end":"2026-10-13T10:46:19.858453Z","steps":["trace[1401132671] 'agreement among raft nodes before linearized reading' (duration: 382.443808ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:46:19.85851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.18461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T10:46:19.858548Z","caller":"traceutil/trace.go:171","msg":"trace[346289452] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"383.239161ms","start":"2026-10-13T10:46:19.475305Z","end":"2026-10-13T10:46:19.858544Z","steps":["trace[346289452] 'agreement among raft nodes before linearized reading' (duration: 383.19312ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.858546Z","caller":"traceutil/trace.go:171","msg":"trace[553658699] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"305.034815ms","start":"2026-10-13T10:46:19.553478Z","end":"2026-10-13T10:46:19.858513Z","steps":["trace[553658699] 'agreement among raft nodes before linearized reading' (duration: 304.948124ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:46:19.858565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.475283Z","time spent":"383.278952ms","remote":"127.0.0.1:59602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-13T10:46:19.858564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.475862Z","time spent":"382.684253ms","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/162.253.55.176\" "} {"level":"warn","ts":"2026-10-13T10:46:19.858578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.553456Z","time spent":"305.113396ms","remote":"127.0.0.1:59602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-13T10:46:19.858578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.253426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-13T10:46:19.858659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.60259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T10:46:19.85879Z","caller":"traceutil/trace.go:171","msg":"trace[1853384225] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"382.299097ms","start":"2026-10-13T10:46:19.476307Z","end":"2026-10-13T10:46:19.858607Z","steps":["trace[1853384225] 'agreement among raft nodes before linearized reading' (duration: 382.133074ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:46:19.858829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.476223Z","time spent":"382.595292ms","remote":"127.0.0.1:59576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-10-13T10:46:19.859065Z","caller":"traceutil/trace.go:171","msg":"trace[856800778] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"446.750992ms","start":"2026-10-13T10:46:19.412032Z","end":"2026-10-13T10:46:19.858783Z","steps":["trace[856800778] 'agreement among raft nodes before linearized reading' (duration: 446.58111ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:46:19.859264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.476181Z","time spent":"381.654656ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T10:46:19.859298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.411015Z","time spent":"446.63195ms","remote":"127.0.0.1:59552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:46:19.859507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.475941Z","time spent":"382.049752ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T10:46:19.859651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.027199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-10-13T10:46:19.858479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.978477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-10-13T10:46:19.859756Z","caller":"traceutil/trace.go:171","msg":"trace[864629194] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"306.160161ms","start":"2026-10-13T10:46:19.55357Z","end":"2026-10-13T10:46:19.85973Z","steps":["trace[864629194] 'agreement among raft nodes before linearized reading' (duration: 305.984429ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:46:19.859772Z","caller":"traceutil/trace.go:171","msg":"trace[103147109] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"333.349877ms","start":"2026-10-13T10:46:19.526385Z","end":"2026-10-13T10:46:19.859734Z","steps":["trace[103147109] 'agreement among raft nodes before linearized reading' (duration: 331.909015ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:46:19.859381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.412024Z","time spent":"447.318971ms","remote":"127.0.0.1:59908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-10-13T10:46:19.859794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.476302Z","time spent":"381.786068ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T10:46:19.859806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.553541Z","time spent":"306.252653ms","remote":"127.0.0.1:59602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-13T10:46:19.859841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.47629Z","time spent":"381.813919ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T10:46:19.859811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.526361Z","time spent":"333.438699ms","remote":"127.0.0.1:59602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-10-13T10:46:19.859876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.496038Z","time spent":"362.090357ms","remote":"127.0.0.1:59684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T10:46:19.859909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.476803Z","time spent":"381.339322ms","remote":"127.0.0.1:49016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T10:46:19.859946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.476249Z","time spent":"381.91289ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-13T10:46:19.860024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:46:19.49602Z","time spent":"362.189289ms","remote":"127.0.0.1:59766","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T10:47:01.362896Z","caller":"traceutil/trace.go:171","msg":"trace[1350868802] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"104.525363ms","start":"2026-10-13T10:47:01.258347Z","end":"2026-10-13T10:47:01.362872Z","steps":["trace[1350868802] 'process raft request' (duration: 101.711905ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:47:01.370006Z","caller":"traceutil/trace.go:171","msg":"trace[8374570] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"110.607719ms","start":"2026-10-13T10:47:01.259357Z","end":"2026-10-13T10:47:01.369965Z","steps":["trace[8374570] 'process raft request' (duration: 110.072711ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:47:02.001848Z","caller":"traceutil/trace.go:171","msg":"trace[109615982] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"129.424038ms","start":"2026-10-13T10:47:01.872401Z","end":"2026-10-13T10:47:02.001825Z","steps":["trace[109615982] 'process raft request' (duration: 77.200337ms)","trace[109615982] 'compare' (duration: 52.095639ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:47:02.015603Z","caller":"traceutil/trace.go:171","msg":"trace[1871802964] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"109.402872ms","start":"2026-10-13T10:47:01.906158Z","end":"2026-10-13T10:47:02.015561Z","steps":["trace[1871802964] 'process raft request' (duration: 109.179469ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:47:02.150498Z","caller":"traceutil/trace.go:171","msg":"trace[383394422] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"102.628216ms","start":"2026-10-13T10:47:02.047844Z","end":"2026-10-13T10:47:02.150472Z","steps":["trace[383394422] 'process raft request' (duration: 78.23466ms)","trace[383394422] 'compare' (duration: 23.851718ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:47:08.313648Z","caller":"traceutil/trace.go:171","msg":"trace[1327968765] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"275.725944ms","start":"2026-10-13T10:47:08.037891Z","end":"2026-10-13T10:47:08.313617Z","steps":["trace[1327968765] 'process raft request' (duration: 275.633993ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:47:08.385509Z","caller":"traceutil/trace.go:171","msg":"trace[364479726] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:638; }","duration":"187.921655ms","start":"2026-10-13T10:47:08.197549Z","end":"2026-10-13T10:47:08.38547Z","steps":["trace[364479726] 'read index received' (duration: 115.911743ms)","trace[364479726] 'applied index is now lower than readState.Index' (duration: 72.008302ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:47:08.385555Z","caller":"traceutil/trace.go:171","msg":"trace[1125621487] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"327.690533ms","start":"2026-10-13T10:47:08.057828Z","end":"2026-10-13T10:47:08.385519Z","steps":["trace[1125621487] 'process raft request' (duration: 326.739551ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:47:08.38572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:47:08.0578Z","time spent":"327.844786ms","remote":"127.0.0.1:59580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:47:08.385866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.27735ms","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-10-13T10:47:08.385913Z","caller":"traceutil/trace.go:171","msg":"trace[1265480998] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"188.403202ms","start":"2026-10-13T10:47:08.197494Z","end":"2026-10-13T10:47:08.385897Z","steps":["trace[1265480998] 'agreement among raft nodes before linearized reading' (duration: 188.192719ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:47:08.386134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.765264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-13T10:47:08.38616Z","caller":"traceutil/trace.go:171","msg":"trace[1658223206] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"119.850716ms","start":"2026-10-13T10:47:08.266301Z","end":"2026-10-13T10:47:08.386151Z","steps":["trace[1658223206] 'agreement among raft nodes before linearized reading' (duration: 119.703884ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:47:09.150499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.33265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T10:47:09.150783Z","caller":"traceutil/trace.go:171","msg":"trace[782849915] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"759.536736ms","start":"2026-10-13T10:47:08.391216Z","end":"2026-10-13T10:47:09.150756Z","steps":["trace[782849915] 'process raft request' (duration: 90.671728ms)","trace[782849915] 'compare' (duration: 668.073307ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:47:09.150854Z","caller":"traceutil/trace.go:171","msg":"trace[1015466677] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"691.099421ms","start":"2026-10-13T10:47:08.459747Z","end":"2026-10-13T10:47:09.150846Z","steps":["trace[1015466677] 'process raft request' (duration: 690.960409ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:47:09.150849Z","caller":"traceutil/trace.go:171","msg":"trace[1329782059] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:640; }","duration":"699.490376ms","start":"2026-10-13T10:47:08.451343Z","end":"2026-10-13T10:47:09.150833Z","steps":["trace[1329782059] 'read index received' (duration: 30.557658ms)","trace[1329782059] 'applied index is now lower than readState.Index' (duration: 668.931728ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:47:09.150891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:47:08.391165Z","time spent":"759.694938ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:47:09.150799Z","caller":"traceutil/trace.go:171","msg":"trace[859791394] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"758.41552ms","start":"2026-10-13T10:47:08.392363Z","end":"2026-10-13T10:47:09.150779Z","steps":["trace[859791394] 'process raft request' (duration: 758.247978ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:47:09.151016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.668699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-10-13T10:47:09.151045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:47:08.392319Z","time spent":"758.702534ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:47:09.151047Z","caller":"traceutil/trace.go:171","msg":"trace[1500619356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:614; }","duration":"699.727249ms","start":"2026-10-13T10:47:08.45131Z","end":"2026-10-13T10:47:09.151037Z","steps":["trace[1500619356] 'agreement among raft nodes before linearized reading' (duration: 699.578796ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:47:09.151169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:47:08.451294Z","time spent":"699.863311ms","remote":"127.0.0.1:59778","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":"warn","ts":"2026-10-13T10:47:09.151701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:47:08.459729Z","time spent":"691.147601ms","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-13T10:47:11.309807Z","caller":"traceutil/trace.go:171","msg":"trace[1705929036] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"107.854445ms","start":"2026-10-13T10:47:11.201919Z","end":"2026-10-13T10:47:11.309773Z","steps":["trace[1705929036] 'process raft request' (duration: 106.266764ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:47:55.645774Z","caller":"traceutil/trace.go:171","msg":"trace[1034975168] transaction","detail":"{read_only:false; response_revision:1177; number_of_response:1; }","duration":"245.374802ms","start":"2026-10-13T10:47:55.400365Z","end":"2026-10-13T10:47:55.64574Z","steps":["trace[1034975168] 'process raft request' (duration: 225.726743ms)","trace[1034975168] 'compare' (duration: 19.551305ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:47:55.650765Z","caller":"traceutil/trace.go:171","msg":"trace[1007141185] linearizableReadLoop","detail":"{readStateIndex:1219; appliedIndex:1216; }","duration":"111.353574ms","start":"2026-10-13T10:47:55.539398Z","end":"2026-10-13T10:47:55.650752Z","steps":["trace[1007141185] 'read index received' (duration: 86.704339ms)","trace[1007141185] 'applied index is now lower than readState.Index' (duration: 24.648575ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:47:55.650975Z","caller":"traceutil/trace.go:171","msg":"trace[182802187] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"248.535372ms","start":"2026-10-13T10:47:55.402404Z","end":"2026-10-13T10:47:55.650939Z","steps":["trace[182802187] 'process raft request' (duration: 248.254081ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:47:55.651024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.609415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-13T10:47:55.65116Z","caller":"traceutil/trace.go:171","msg":"trace[1271075620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1179; }","duration":"111.786892ms","start":"2026-10-13T10:47:55.539365Z","end":"2026-10-13T10:47:55.651152Z","steps":["trace[1271075620] 'agreement among raft nodes before linearized reading' (duration: 111.437657ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:47:55.651477Z","caller":"traceutil/trace.go:171","msg":"trace[918231167] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"140.454583ms","start":"2026-10-13T10:47:55.510669Z","end":"2026-10-13T10:47:55.651123Z","steps":["trace[918231167] 'process raft request' (duration: 140.055426ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:48:43.925008Z","caller":"traceutil/trace.go:171","msg":"trace[1103383379] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"281.117803ms","start":"2026-10-13T10:48:43.643868Z","end":"2026-10-13T10:48:43.924985Z","steps":["trace[1103383379] 'process raft request' (duration: 280.974329ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:48:43.925013Z","caller":"traceutil/trace.go:171","msg":"trace[2093489131] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1931; }","duration":"236.911948ms","start":"2026-10-13T10:48:43.688076Z","end":"2026-10-13T10:48:43.924988Z","steps":["trace[2093489131] 'read index received' (duration: 236.902598ms)","trace[2093489131] 'applied index is now lower than readState.Index' (duration: 8.07µs)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:48:43.925366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.281181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b85096e2-a26e-43d4-a678-53648fdc1745\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-10-13T10:48:43.925403Z","caller":"traceutil/trace.go:171","msg":"trace[594397145] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b85096e2-a26e-43d4-a678-53648fdc1745; range_end:; response_count:1; response_revision:1856; }","duration":"237.334783ms","start":"2026-10-13T10:48:43.688059Z","end":"2026-10-13T10:48:43.925393Z","steps":["trace[594397145] 'agreement among raft nodes before linearized reading' (duration: 236.976191ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:48:43.943916Z","caller":"traceutil/trace.go:171","msg":"trace[19341734] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"179.939971ms","start":"2026-10-13T10:48:43.763952Z","end":"2026-10-13T10:48:43.943892Z","steps":["trace[19341734] 'process raft request' (duration: 179.747575ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:48:43.944288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.992264ms","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-10-13T10:48:43.944346Z","caller":"traceutil/trace.go:171","msg":"trace[1082155592] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1857; }","duration":"254.094018ms","start":"2026-10-13T10:48:43.690244Z","end":"2026-10-13T10:48:43.944338Z","steps":["trace[1082155592] 'agreement among raft nodes before linearized reading' (duration: 253.854929ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:48:44.14651Z","caller":"traceutil/trace.go:171","msg":"trace[1611418974] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"122.422409ms","start":"2026-10-13T10:48:44.024064Z","end":"2026-10-13T10:48:44.146487Z","steps":["trace[1611418974] 'process raft request' (duration: 87.31892ms)","trace[1611418974] 'compare' (duration: 34.83366ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:48:44.443411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.289448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:48:44.4435Z","caller":"traceutil/trace.go:171","msg":"trace[1268132887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1862; }","duration":"133.389271ms","start":"2026-10-13T10:48:44.31009Z","end":"2026-10-13T10:48:44.443479Z","steps":["trace[1268132887] 'range keys from in-memory index tree' (duration: 133.179834ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:48:56.265643Z","caller":"traceutil/trace.go:171","msg":"trace[274670538] transaction","detail":"{read_only:false; response_revision:1958; number_of_response:1; }","duration":"121.818088ms","start":"2026-10-13T10:48:56.143799Z","end":"2026-10-13T10:48:56.265617Z","steps":["trace[274670538] 'process raft request' (duration: 121.683134ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:48:56.270627Z","caller":"traceutil/trace.go:171","msg":"trace[952411922] linearizableReadLoop","detail":"{readStateIndex:2037; appliedIndex:2034; }","duration":"121.717176ms","start":"2026-10-13T10:48:56.148879Z","end":"2026-10-13T10:48:56.270597Z","steps":["trace[952411922] 'read index received' (duration: 116.655857ms)","trace[952411922] 'applied index is now lower than readState.Index' (duration: 5.059799ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:48:56.270706Z","caller":"traceutil/trace.go:171","msg":"trace[837387674] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"126.133494ms","start":"2026-10-13T10:48:56.144552Z","end":"2026-10-13T10:48:56.270686Z","steps":["trace[837387674] 'process raft request' (duration: 126.00908ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:48:56.270708Z","caller":"traceutil/trace.go:171","msg":"trace[2097174549] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"126.661641ms","start":"2026-10-13T10:48:56.144007Z","end":"2026-10-13T10:48:56.270668Z","steps":["trace[2097174549] 'process raft request' (duration: 126.410524ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:48:56.270854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.951273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-10-13T10:48:56.270898Z","caller":"traceutil/trace.go:171","msg":"trace[463001149] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1960; }","duration":"122.044776ms","start":"2026-10-13T10:48:56.148845Z","end":"2026-10-13T10:48:56.270889Z","steps":["trace[463001149] 'agreement among raft nodes before linearized reading' (duration: 121.860231ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:49:12.203409Z","caller":"traceutil/trace.go:171","msg":"trace[529767388] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"103.777117ms","start":"2026-10-13T10:49:12.099602Z","end":"2026-10-13T10:49:12.203379Z","steps":["trace[529767388] 'process raft request' (duration: 103.610862ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:49:12.204334Z","caller":"traceutil/trace.go:171","msg":"trace[1388948016] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"104.199689ms","start":"2026-10-13T10:49:12.100101Z","end":"2026-10-13T10:49:12.204301Z","steps":["trace[1388948016] 'process raft request' (duration: 104.040064ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:49:18.001264Z","caller":"traceutil/trace.go:171","msg":"trace[402243867] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"124.832003ms","start":"2026-10-13T10:49:17.876245Z","end":"2026-10-13T10:49:18.001077Z","steps":["trace[402243867] 'process raft request' (duration: 124.672858ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:49:18.368687Z","caller":"traceutil/trace.go:171","msg":"trace[550946785] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"145.64567ms","start":"2026-10-13T10:49:18.223014Z","end":"2026-10-13T10:49:18.36866Z","steps":["trace[550946785] 'process raft request' (duration: 145.483686ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:49:18.380145Z","caller":"traceutil/trace.go:171","msg":"trace[1156364526] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"156.811763ms","start":"2026-10-13T10:49:18.223305Z","end":"2026-10-13T10:49:18.380116Z","steps":["trace[1156364526] 'process raft request' (duration: 156.714161ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:49:18.493581Z","caller":"traceutil/trace.go:171","msg":"trace[1315229225] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"108.143705ms","start":"2026-10-13T10:49:18.385414Z","end":"2026-10-13T10:49:18.493557Z","steps":["trace[1315229225] 'process raft request' (duration: 88.399894ms)","trace[1315229225] 'compare' (duration: 19.416152ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:49:18.493756Z","caller":"traceutil/trace.go:171","msg":"trace[1149580390] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"108.273941ms","start":"2026-10-13T10:49:18.385475Z","end":"2026-10-13T10:49:18.493749Z","steps":["trace[1149580390] 'process raft request' (duration: 107.849798ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:49:18.493841Z","caller":"traceutil/trace.go:171","msg":"trace[1743074234] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"107.061366ms","start":"2026-10-13T10:49:18.386773Z","end":"2026-10-13T10:49:18.493835Z","steps":["trace[1743074234] 'process raft request' (duration: 106.582041ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:49:18.859307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.208655ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T10:49:18.859432Z","caller":"traceutil/trace.go:171","msg":"trace[933644913] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"288.586873ms","start":"2026-10-13T10:49:18.570824Z","end":"2026-10-13T10:49:18.859411Z","steps":["trace[933644913] 'process raft request' (duration: 95.189222ms)","trace[933644913] 'compare' (duration: 193.01647ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:49:19.148605Z","caller":"traceutil/trace.go:171","msg":"trace[1459207657] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"122.677944ms","start":"2026-10-13T10:49:19.025906Z","end":"2026-10-13T10:49:19.148584Z","steps":["trace[1459207657] 'process raft request' (duration: 122.560221ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:49:19.295723Z","caller":"traceutil/trace.go:171","msg":"trace[1531510920] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"192.534916ms","start":"2026-10-13T10:49:19.10316Z","end":"2026-10-13T10:49:19.295695Z","steps":["trace[1531510920] 'process raft request' (duration: 189.286973ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:50:56.83525Z","caller":"traceutil/trace.go:171","msg":"trace[1401671921] transaction","detail":"{read_only:false; response_revision:2730; number_of_response:1; }","duration":"104.001112ms","start":"2026-10-13T10:50:56.731224Z","end":"2026-10-13T10:50:56.835225Z","steps":["trace[1401671921] 'process raft request' (duration: 103.832488ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:50:57.035763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.983303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-13T10:50:57.035851Z","caller":"traceutil/trace.go:171","msg":"trace[1222060604] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2730; }","duration":"169.142116ms","start":"2026-10-13T10:50:56.866686Z","end":"2026-10-13T10:50:57.035828Z","steps":["trace[1222060604] 'range keys from in-memory index tree' (duration: 168.8359ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:50:57.036553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.483627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18de1138ae887fd4\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-10-13T10:50:57.036615Z","caller":"traceutil/trace.go:171","msg":"trace[1026411672] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18de1138ae887fd4; range_end:; response_count:1; response_revision:2730; }","duration":"149.551779ms","start":"2026-10-13T10:50:56.887051Z","end":"2026-10-13T10:50:57.036603Z","steps":["trace[1026411672] 'range keys from in-memory index tree' (duration: 148.756042ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:11.935922Z","caller":"traceutil/trace.go:171","msg":"trace[1071666920] linearizableReadLoop","detail":"{readStateIndex:5020; appliedIndex:5019; }","duration":"144.540058ms","start":"2026-10-13T10:55:11.791358Z","end":"2026-10-13T10:55:11.935898Z","steps":["trace[1071666920] 'read index received' (duration: 144.359095ms)","trace[1071666920] 'applied index is now lower than readState.Index' (duration: 179.793µs)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:11.935963Z","caller":"traceutil/trace.go:171","msg":"trace[1156062178] transaction","detail":"{read_only:false; response_revision:4833; number_of_response:1; }","duration":"183.593877ms","start":"2026-10-13T10:55:11.752336Z","end":"2026-10-13T10:55:11.935929Z","steps":["trace[1156062178] 'process raft request' (duration: 183.383644ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:11.936118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.744411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-47b3a0ca-221e-4fec-b28f-e07225fe2cc1\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-13T10:55:11.936155Z","caller":"traceutil/trace.go:171","msg":"trace[815695432] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-47b3a0ca-221e-4fec-b28f-e07225fe2cc1; range_end:; response_count:1; response_revision:4833; }","duration":"144.833593ms","start":"2026-10-13T10:55:11.79131Z","end":"2026-10-13T10:55:11.936144Z","steps":["trace[815695432] 'agreement among raft nodes before linearized reading' (duration: 144.68193ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:27.500485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.691379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-k6zss\" ","response":"range_response_count:1 size:9686"} {"level":"warn","ts":"2026-10-13T10:55:27.500544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.108199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T10:55:27.500568Z","caller":"traceutil/trace.go:171","msg":"trace[898949345] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-k6zss; range_end:; response_count:1; response_revision:5034; }","duration":"655.772271ms","start":"2026-10-13T10:55:26.844767Z","end":"2026-10-13T10:55:27.500539Z","steps":["trace[898949345] 'range keys from in-memory index tree' (duration: 655.511157ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:27.500587Z","caller":"traceutil/trace.go:171","msg":"trace[771288469] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5034; }","duration":"496.17982ms","start":"2026-10-13T10:55:27.004399Z","end":"2026-10-13T10:55:27.500579Z","steps":["trace[771288469] 'count revisions from in-memory index tree' (duration: 496.062258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:27.500607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:27.004383Z","time spent":"496.217892ms","remote":"127.0.0.1:59190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:55:27.500607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:26.844743Z","time spent":"655.853942ms","remote":"127.0.0.1:59688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9709,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-k6zss\" "} {"level":"info","ts":"2026-10-13T10:55:27.619276Z","caller":"traceutil/trace.go:171","msg":"trace[968964672] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"109.729437ms","start":"2026-10-13T10:55:27.509523Z","end":"2026-10-13T10:55:27.619252Z","steps":["trace[968964672] 'process raft request' (duration: 109.494023ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.095571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.864056ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T10:55:28.096137Z","caller":"traceutil/trace.go:171","msg":"trace[343274899] transaction","detail":"{read_only:false; response_revision:5039; number_of_response:1; }","duration":"459.97479ms","start":"2026-10-13T10:55:27.636145Z","end":"2026-10-13T10:55:28.09612Z","steps":["trace[343274899] 'process raft request' (duration: 459.889709ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.09614Z","caller":"traceutil/trace.go:171","msg":"trace[1862832309] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"470.811717ms","start":"2026-10-13T10:55:27.625224Z","end":"2026-10-13T10:55:28.096036Z","steps":["trace[1862832309] 'process raft request' (duration: 184.381072ms)","trace[1862832309] 'compare' (duration: 285.621032ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:55:28.096206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:27.63613Z","time spent":"460.042732ms","remote":"127.0.0.1:59688","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11652,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:55:28.096177Z","caller":"traceutil/trace.go:171","msg":"trace[1534396847] linearizableReadLoop","detail":"{readStateIndex:5232; appliedIndex:5229; }","duration":"399.74053ms","start":"2026-10-13T10:55:27.696418Z","end":"2026-10-13T10:55:28.096159Z","steps":["trace[1534396847] 'read index received' (duration: 113.125952ms)","trace[1534396847] 'applied index is now lower than readState.Index' (duration: 286.612588ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.096295Z","caller":"traceutil/trace.go:171","msg":"trace[378468350] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"469.352143ms","start":"2026-10-13T10:55:27.626936Z","end":"2026-10-13T10:55:28.096288Z","steps":["trace[378468350] 'process raft request' (duration: 468.730873ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.096299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:27.625204Z","time spent":"471.015201ms","remote":"127.0.0.1:59780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1951,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:55:28.096331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:27.626928Z","time spent":"469.383283ms","remote":"127.0.0.1:49048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8164,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:55:28.096504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.519956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:28.09653Z","caller":"traceutil/trace.go:171","msg":"trace[1671454995] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:5040; }","duration":"453.573676ms","start":"2026-10-13T10:55:27.642949Z","end":"2026-10-13T10:55:28.096523Z","steps":["trace[1671454995] 'agreement among raft nodes before linearized reading' (duration: 453.326592ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.09655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:27.642938Z","time spent":"453.605397ms","remote":"127.0.0.1:44770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true "} {"level":"info","ts":"2026-10-13T10:55:28.09678Z","caller":"traceutil/trace.go:171","msg":"trace[968580946] transaction","detail":"{read_only:false; response_revision:5041; number_of_response:1; }","duration":"112.237807ms","start":"2026-10-13T10:55:27.984534Z","end":"2026-10-13T10:55:28.096771Z","steps":["trace[968580946] 'process raft request' (duration: 111.908372ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.096857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.7693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-47b3a0ca-221e-4fec-b28f-e07225fe2cc1\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-10-13T10:55:28.096958Z","caller":"traceutil/trace.go:171","msg":"trace[1505959448] range","detail":"{range_begin:/registry/persistentvolumes/pvc-47b3a0ca-221e-4fec-b28f-e07225fe2cc1; range_end:; response_count:1; response_revision:5041; }","duration":"396.905223ms","start":"2026-10-13T10:55:27.700031Z","end":"2026-10-13T10:55:28.096936Z","steps":["trace[1505959448] 'agreement among raft nodes before linearized reading' (duration: 396.511327ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.096993Z","caller":"traceutil/trace.go:171","msg":"trace[1804951246] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"248.956934ms","start":"2026-10-13T10:55:27.848013Z","end":"2026-10-13T10:55:28.096969Z","steps":["trace[1804951246] 'process raft request' (duration: 248.086171ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.097034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:27.700012Z","time spent":"397.009954ms","remote":"127.0.0.1:59652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1345,"request content":"key:\"/registry/persistentvolumes/pvc-47b3a0ca-221e-4fec-b28f-e07225fe2cc1\" "} {"level":"warn","ts":"2026-10-13T10:55:28.097069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.600485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-10-13T10:55:28.097101Z","caller":"traceutil/trace.go:171","msg":"trace[620717451] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5041; }","duration":"281.629975ms","start":"2026-10-13T10:55:27.81546Z","end":"2026-10-13T10:55:28.09709Z","steps":["trace[620717451] 'agreement among raft nodes before linearized reading' (duration: 281.524884ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.536365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.160465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T10:55:28.536461Z","caller":"traceutil/trace.go:171","msg":"trace[1904633347] linearizableReadLoop","detail":"{readStateIndex:5235; appliedIndex:5234; }","duration":"431.946702ms","start":"2026-10-13T10:55:28.104497Z","end":"2026-10-13T10:55:28.536444Z","steps":["trace[1904633347] 'read index received' (duration: 171.624954ms)","trace[1904633347] 'applied index is now lower than readState.Index' (duration: 260.320398ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.536647Z","caller":"traceutil/trace.go:171","msg":"trace[1653431250] transaction","detail":"{read_only:false; response_revision:5042; number_of_response:1; }","duration":"432.453ms","start":"2026-10-13T10:55:28.104171Z","end":"2026-10-13T10:55:28.536624Z","steps":["trace[1653431250] 'process raft request' (duration: 171.934719ms)","trace[1653431250] 'compare' (duration: 259.937142ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:55:28.536808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.104157Z","time spent":"432.600222ms","remote":"127.0.0.1:59780","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1562,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:55:28.536934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.403779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:17152"} {"level":"info","ts":"2026-10-13T10:55:28.537028Z","caller":"traceutil/trace.go:171","msg":"trace[2030694662] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5042; }","duration":"432.544201ms","start":"2026-10-13T10:55:28.104457Z","end":"2026-10-13T10:55:28.537001Z","steps":["trace[2030694662] 'agreement among raft nodes before linearized reading' (duration: 432.282167ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.537083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.104442Z","time spent":"432.626423ms","remote":"127.0.0.1:59688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":17175,"request content":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-10-13T10:55:28.614034Z","caller":"traceutil/trace.go:171","msg":"trace[1033893105] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"505.072202ms","start":"2026-10-13T10:55:28.108944Z","end":"2026-10-13T10:55:28.614016Z","steps":["trace[1033893105] 'process raft request' (duration: 505.020442ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.614098Z","caller":"traceutil/trace.go:171","msg":"trace[300656173] transaction","detail":"{read_only:false; response_revision:5043; number_of_response:1; }","duration":"509.444494ms","start":"2026-10-13T10:55:28.104619Z","end":"2026-10-13T10:55:28.614063Z","steps":["trace[300656173] 'process raft request' (duration: 509.235111ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.614182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.108931Z","time spent":"505.156333ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10497,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:55:28.614262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.104598Z","time spent":"509.583616ms","remote":"127.0.0.1:59676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":991,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:55:28.774841Z","caller":"traceutil/trace.go:171","msg":"trace[987752787] linearizableReadLoop","detail":"{readStateIndex:5238; appliedIndex:5235; }","duration":"238.33365ms","start":"2026-10-13T10:55:28.536483Z","end":"2026-10-13T10:55:28.774817Z","steps":["trace[987752787] 'read index received' (duration: 77.417941ms)","trace[987752787] 'applied index is now lower than readState.Index' (duration: 160.914799ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.774919Z","caller":"traceutil/trace.go:171","msg":"trace[1528150987] transaction","detail":"{read_only:false; response_revision:5045; number_of_response:1; }","duration":"442.164519ms","start":"2026-10-13T10:55:28.332723Z","end":"2026-10-13T10:55:28.774888Z","steps":["trace[1528150987] 'process raft request' (duration: 363.479838ms)","trace[1528150987] 'compare' (duration: 78.365946ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.774992Z","caller":"traceutil/trace.go:171","msg":"trace[686178651] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"220.420107ms","start":"2026-10-13T10:55:28.554552Z","end":"2026-10-13T10:55:28.774973Z","steps":["trace[686178651] 'process raft request' (duration: 220.186664ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.775045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.986251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-10-13T10:55:28.775148Z","caller":"traceutil/trace.go:171","msg":"trace[1216210082] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5046; }","duration":"271.124523ms","start":"2026-10-13T10:55:28.504001Z","end":"2026-10-13T10:55:28.775125Z","steps":["trace[1216210082] 'agreement among raft nodes before linearized reading' (duration: 270.878109ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.775207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.314961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:28.775227Z","caller":"traceutil/trace.go:171","msg":"trace[1334930561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5046; }","duration":"466.375812ms","start":"2026-10-13T10:55:28.308846Z","end":"2026-10-13T10:55:28.775221Z","steps":["trace[1334930561] 'agreement among raft nodes before linearized reading' (duration: 466.330801ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.775245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.308817Z","time spent":"466.424783ms","remote":"127.0.0.1:59464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T10:55:28.775333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.171154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:28.775426Z","caller":"traceutil/trace.go:171","msg":"trace[276628254] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:5046; }","duration":"459.329218ms","start":"2026-10-13T10:55:28.316083Z","end":"2026-10-13T10:55:28.775412Z","steps":["trace[276628254] 'agreement among raft nodes before linearized reading' (duration: 458.843569ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.775551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.316074Z","time spent":"459.45817ms","remote":"127.0.0.1:59806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:55:28.775675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"668.000216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"} {"level":"info","ts":"2026-10-13T10:55:28.776726Z","caller":"traceutil/trace.go:171","msg":"trace[712308002] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:5046; }","duration":"669.003662ms","start":"2026-10-13T10:55:28.10762Z","end":"2026-10-13T10:55:28.776623Z","steps":["trace[712308002] 'agreement among raft nodes before linearized reading' (duration: 667.590768ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.776983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.107609Z","time spent":"669.354807ms","remote":"127.0.0.1:59690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1288,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" "} {"level":"warn","ts":"2026-10-13T10:55:28.776515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.332684Z","time spent":"442.308221ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:55:28.951383Z","caller":"traceutil/trace.go:171","msg":"trace[551115655] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"326.959582ms","start":"2026-10-13T10:55:28.624395Z","end":"2026-10-13T10:55:28.951355Z","steps":["trace[551115655] 'process raft request' (duration: 256.583346ms)","trace[551115655] 'compare' (duration: 70.168142ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.951525Z","caller":"traceutil/trace.go:171","msg":"trace[525791720] linearizableReadLoop","detail":"{readStateIndex:5241; appliedIndex:5239; }","duration":"176.608775ms","start":"2026-10-13T10:55:28.774897Z","end":"2026-10-13T10:55:28.951506Z","steps":["trace[525791720] 'read index received' (duration: 106.002376ms)","trace[525791720] 'applied index is now lower than readState.Index' (duration: 70.605239ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:55:28.951736Z","caller":"traceutil/trace.go:171","msg":"trace[2046222392] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"280.05593ms","start":"2026-10-13T10:55:28.671618Z","end":"2026-10-13T10:55:28.951674Z","steps":["trace[2046222392] 'process raft request' (duration: 279.677364ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.951795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.703727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-13T10:55:28.951866Z","caller":"traceutil/trace.go:171","msg":"trace[820192185] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5048; }","duration":"243.825731ms","start":"2026-10-13T10:55:28.708029Z","end":"2026-10-13T10:55:28.951855Z","steps":["trace[820192185] 'agreement among raft nodes before linearized reading' (duration: 243.604536ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.952268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.773757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-13T10:55:28.952305Z","caller":"traceutil/trace.go:171","msg":"trace[1792011497] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5048; }","duration":"265.856559ms","start":"2026-10-13T10:55:28.68644Z","end":"2026-10-13T10:55:28.952296Z","steps":["trace[1792011497] 'agreement among raft nodes before linearized reading' (duration: 265.761797ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.952545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.347555ms","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-10-13T10:55:28.95261Z","caller":"traceutil/trace.go:171","msg":"trace[853600402] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5048; }","duration":"253.454856ms","start":"2026-10-13T10:55:28.699143Z","end":"2026-10-13T10:55:28.952597Z","steps":["trace[853600402] 'agreement among raft nodes before linearized reading' (duration: 253.238723ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.952624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.37222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-13T10:55:28.952615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.607639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-13T10:55:28.952652Z","caller":"traceutil/trace.go:171","msg":"trace[78989365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5048; }","duration":"276.42648ms","start":"2026-10-13T10:55:28.676217Z","end":"2026-10-13T10:55:28.952643Z","steps":["trace[78989365] 'agreement among raft nodes before linearized reading' (duration: 276.345749ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.953039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:55:28.624369Z","time spent":"327.083644ms","remote":"127.0.0.1:49030","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10926,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:55:28.953097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.623735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:55:28.953131Z","caller":"traceutil/trace.go:171","msg":"trace[1533698309] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5048; }","duration":"176.685206ms","start":"2026-10-13T10:55:28.776436Z","end":"2026-10-13T10:55:28.953121Z","steps":["trace[1533698309] 'agreement among raft nodes before linearized reading' (duration: 176.633315ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.95316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.100259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18de117876601ee5\" ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-10-13T10:55:28.953194Z","caller":"traceutil/trace.go:171","msg":"trace[1935897961] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18de117876601ee5; range_end:; response_count:1; response_revision:5048; }","duration":"170.154281ms","start":"2026-10-13T10:55:28.78303Z","end":"2026-10-13T10:55:28.953184Z","steps":["trace[1935897961] 'agreement among raft nodes before linearized reading' (duration: 170.055469ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:55:28.95269Z","caller":"traceutil/trace.go:171","msg":"trace[322509369] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5048; }","duration":"226.737802ms","start":"2026-10-13T10:55:28.725933Z","end":"2026-10-13T10:55:28.95267Z","steps":["trace[322509369] 'agreement among raft nodes before linearized reading' (duration: 225.846286ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.953391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.523441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-974cca1a-2b34-4d21-a1aa-6582c0fa16d8\" ","response":"range_response_count:1 size:1435"} {"level":"info","ts":"2026-10-13T10:55:28.953427Z","caller":"traceutil/trace.go:171","msg":"trace[495957048] range","detail":"{range_begin:/registry/persistentvolumes/pvc-974cca1a-2b34-4d21-a1aa-6582c0fa16d8; range_end:; response_count:1; response_revision:5048; }","duration":"174.620663ms","start":"2026-10-13T10:55:28.778797Z","end":"2026-10-13T10:55:28.953418Z","steps":["trace[495957048] 'agreement among raft nodes before linearized reading' (duration: 174.46028ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:55:28.953465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.683462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1453"} {"level":"info","ts":"2026-10-13T10:55:28.953567Z","caller":"traceutil/trace.go:171","msg":"trace[832402732] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5048; }","duration":"169.773594ms","start":"2026-10-13T10:55:28.78376Z","end":"2026-10-13T10:55:28.953533Z","steps":["trace[832402732] 'agreement among raft nodes before linearized reading' (duration: 169.593932ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:56:18.134792Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2846} {"level":"info","ts":"2026-10-13T10:56:18.363346Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2846,"took":"227.308687ms","hash":2476384410,"current-db-size-bytes":53301248,"current-db-size":"53 MB","current-db-size-in-use-bytes":28491776,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-13T10:56:18.363463Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2476384410,"revision":2846,"compact-revision":-1} {"level":"info","ts":"2026-10-13T10:59:17.439679Z","caller":"traceutil/trace.go:171","msg":"trace[899105625] transaction","detail":"{read_only:false; response_revision:6673; number_of_response:1; }","duration":"250.188627ms","start":"2026-10-13T10:59:17.18917Z","end":"2026-10-13T10:59:17.439358Z","steps":["trace[899105625] 'process raft request' (duration: 249.897399ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:17.686309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.394167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T10:59:17.686401Z","caller":"traceutil/trace.go:171","msg":"trace[389577505] linearizableReadLoop","detail":"{readStateIndex:6920; appliedIndex:6918; }","duration":"376.753709ms","start":"2026-10-13T10:59:17.309632Z","end":"2026-10-13T10:59:17.686386Z","steps":["trace[389577505] 'read index received' (duration: 129.508388ms)","trace[389577505] 'applied index is now lower than readState.Index' (duration: 247.244011ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:59:17.686514Z","caller":"traceutil/trace.go:171","msg":"trace[942966141] transaction","detail":"{read_only:false; response_revision:6674; number_of_response:1; }","duration":"480.505835ms","start":"2026-10-13T10:59:17.205978Z","end":"2026-10-13T10:59:17.686484Z","steps":["trace[942966141] 'process raft request' (duration: 354.84505ms)","trace[942966141] 'compare' (duration: 125.116939ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:59:17.686529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.900094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:59:17.686584Z","caller":"traceutil/trace.go:171","msg":"trace[1172621439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6674; }","duration":"376.986006ms","start":"2026-10-13T10:59:17.30958Z","end":"2026-10-13T10:59:17.686566Z","steps":["trace[1172621439] 'agreement among raft nodes before linearized reading' (duration: 376.846522ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:17.686606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.205954Z","time spent":"480.608438ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:17.686623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.309561Z","time spent":"377.051518ms","remote":"127.0.0.1:59464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T10:59:18.364504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.817423Z","time spent":"547.072941ms","remote":"127.0.0.1:41944","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-10-13T10:59:18.365555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.559716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T10:59:18.365636Z","caller":"traceutil/trace.go:171","msg":"trace[779050415] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:6674; }","duration":"534.678459ms","start":"2026-10-13T10:59:17.830925Z","end":"2026-10-13T10:59:18.365603Z","steps":["trace[779050415] 'count revisions from in-memory index tree' (duration: 534.481164ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.365676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.830905Z","time spent":"534.761432ms","remote":"127.0.0.1:59844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":42,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:18.414333Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":456448185695813490,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-13T10:59:18.582237Z","caller":"traceutil/trace.go:171","msg":"trace[778875756] transaction","detail":"{read_only:false; response_revision:6675; number_of_response:1; }","duration":"702.66017ms","start":"2026-10-13T10:59:17.879561Z","end":"2026-10-13T10:59:18.582221Z","steps":["trace[778875756] 'process raft request' (duration: 702.557797ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.582338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.879537Z","time spent":"702.747712ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:18.979699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.740175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T10:59:18.979869Z","caller":"traceutil/trace.go:171","msg":"trace[1308123430] transaction","detail":"{read_only:false; response_revision:6676; number_of_response:1; }","duration":"1.055427631s","start":"2026-10-13T10:59:17.924418Z","end":"2026-10-13T10:59:18.979845Z","steps":["trace[1308123430] 'process raft request' (duration: 818.47112ms)","trace[1308123430] 'compare' (duration: 236.483516ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:59:18.979961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.924391Z","time spent":"1.055525674s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:59:18.98005Z","caller":"traceutil/trace.go:171","msg":"trace[1171464879] transaction","detail":"{read_only:false; response_revision:6677; number_of_response:1; }","duration":"983.543145ms","start":"2026-10-13T10:59:17.996487Z","end":"2026-10-13T10:59:18.980031Z","steps":["trace[1171464879] 'process raft request' (duration: 983.303319ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.996463Z","time spent":"983.633178ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:59:18.980153Z","caller":"traceutil/trace.go:171","msg":"trace[1265895451] linearizableReadLoop","detail":"{readStateIndex:6924; appliedIndex:6921; }","duration":"1.066571776s","start":"2026-10-13T10:59:17.913561Z","end":"2026-10-13T10:59:18.980132Z","steps":["trace[1265895451] 'read index received' (duration: 669.103731ms)","trace[1265895451] 'applied index is now lower than readState.Index' (duration: 397.466895ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:59:18.98019Z","caller":"traceutil/trace.go:171","msg":"trace[601823151] transaction","detail":"{read_only:false; response_revision:6678; number_of_response:1; }","duration":"590.991322ms","start":"2026-10-13T10:59:18.389186Z","end":"2026-10-13T10:59:18.980178Z","steps":["trace[601823151] 'process raft request' (duration: 590.785076ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.389167Z","time spent":"591.056114ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:18.980318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.619971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-13T10:59:18.980271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.066731111s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-13T10:59:18.980315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.051053684s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:59:18.980342Z","caller":"traceutil/trace.go:171","msg":"trace[1916417912] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:6678; }","duration":"659.642721ms","start":"2026-10-13T10:59:18.320692Z","end":"2026-10-13T10:59:18.980334Z","steps":["trace[1916417912] 'agreement among raft nodes before linearized reading' (duration: 659.60751ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:18.980347Z","caller":"traceutil/trace.go:171","msg":"trace[501360001] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:6678; }","duration":"1.066854495s","start":"2026-10-13T10:59:17.913486Z","end":"2026-10-13T10:59:18.98034Z","steps":["trace[501360001] 'agreement among raft nodes before linearized reading' (duration: 1.066743572s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.32067Z","time spent":"659.688043ms","remote":"127.0.0.1:59908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:18.980369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.913453Z","time spent":"1.066908847s","remote":"127.0.0.1:49030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":18,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:18.980409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"670.348264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:59:18.980475Z","caller":"traceutil/trace.go:171","msg":"trace[1521662286] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6678; }","duration":"670.434906ms","start":"2026-10-13T10:59:18.310027Z","end":"2026-10-13T10:59:18.980462Z","steps":["trace[1521662286] 'agreement among raft nodes before linearized reading' (duration: 670.355504ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.194321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-13T10:59:18.980518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.310012Z","time spent":"670.495868ms","remote":"127.0.0.1:59464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T10:59:18.980592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.663317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-13T10:59:18.980614Z","caller":"traceutil/trace.go:171","msg":"trace[565809707] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6678; }","duration":"630.716499ms","start":"2026-10-13T10:59:18.349892Z","end":"2026-10-13T10:59:18.980609Z","steps":["trace[565809707] 'agreement among raft nodes before linearized reading' (duration: 630.645937ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.643333ms","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":"warn","ts":"2026-10-13T10:59:18.980631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.349878Z","time spent":"630.7488ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-13T10:59:18.980646Z","caller":"traceutil/trace.go:171","msg":"trace[32669978] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:6678; }","duration":"326.698865ms","start":"2026-10-13T10:59:18.653938Z","end":"2026-10-13T10:59:18.980637Z","steps":["trace[32669978] 'agreement among raft nodes before linearized reading' (duration: 326.667024ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.653919Z","time spent":"326.739207ms","remote":"127.0.0.1:59110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:18.980683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.194555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-10-13T10:59:18.980361Z","caller":"traceutil/trace.go:171","msg":"trace[976464354] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:6678; }","duration":"1.051132377s","start":"2026-10-13T10:59:17.929214Z","end":"2026-10-13T10:59:18.980347Z","steps":["trace[976464354] 'agreement among raft nodes before linearized reading' (duration: 1.051053404s)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:18.980712Z","caller":"traceutil/trace.go:171","msg":"trace[2052393582] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6678; }","duration":"628.280758ms","start":"2026-10-13T10:59:18.352421Z","end":"2026-10-13T10:59:18.980702Z","steps":["trace[2052393582] 'agreement among raft nodes before linearized reading' (duration: 628.214036ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:17.929203Z","time spent":"1.051517938s","remote":"127.0.0.1:44772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:18.980738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.352405Z","time spent":"628.327269ms","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4807,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-10-13T10:59:18.980612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.471813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-13T10:59:18.980767Z","caller":"traceutil/trace.go:171","msg":"trace[1738443699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6678; }","duration":"629.705819ms","start":"2026-10-13T10:59:18.351054Z","end":"2026-10-13T10:59:18.980759Z","steps":["trace[1738443699] 'agreement among raft nodes before linearized reading' (duration: 629.465063ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.350965Z","time spent":"629.817303ms","remote":"127.0.0.1:59778","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":"warn","ts":"2026-10-13T10:59:18.980794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.24437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-10-13T10:59:18.980594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.411745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-10-13T10:59:18.980839Z","caller":"traceutil/trace.go:171","msg":"trace[986674176] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6678; }","duration":"682.322892ms","start":"2026-10-13T10:59:18.298503Z","end":"2026-10-13T10:59:18.980826Z","steps":["trace[986674176] 'agreement among raft nodes before linearized reading' (duration: 682.198879ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:18.980858Z","caller":"traceutil/trace.go:171","msg":"trace[302110609] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6678; }","duration":"568.702843ms","start":"2026-10-13T10:59:18.412148Z","end":"2026-10-13T10:59:18.98085Z","steps":["trace[302110609] 'agreement among raft nodes before linearized reading' (duration: 568.380584ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.980881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.412135Z","time spent":"568.738904ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-13T10:59:18.980881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.298487Z","time spent":"682.383214ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-13T10:59:18.981033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.66842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-13T10:59:18.98107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.380058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-13T10:59:18.980528Z","caller":"traceutil/trace.go:171","msg":"trace[1426226868] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:6678; }","duration":"108.245603ms","start":"2026-10-13T10:59:18.872274Z","end":"2026-10-13T10:59:18.98052Z","steps":["trace[1426226868] 'agreement among raft nodes before linearized reading' (duration: 108.205881ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:18.981134Z","caller":"traceutil/trace.go:171","msg":"trace[295726035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6678; }","duration":"780.488351ms","start":"2026-10-13T10:59:18.200633Z","end":"2026-10-13T10:59:18.981121Z","steps":["trace[295726035] 'agreement among raft nodes before linearized reading' (duration: 780.356457ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.981149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"794.129108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-10-13T10:59:18.981172Z","caller":"traceutil/trace.go:171","msg":"trace[1958562635] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6678; }","duration":"794.168198ms","start":"2026-10-13T10:59:18.186997Z","end":"2026-10-13T10:59:18.981165Z","steps":["trace[1958562635] 'agreement among raft nodes before linearized reading' (duration: 794.097046ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.981173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.200603Z","time spent":"780.558683ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-13T10:59:18.981179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"800.682509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-13T10:59:18.981204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.889344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"warn","ts":"2026-10-13T10:59:18.981204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.186987Z","time spent":"794.210571ms","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4807,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-10-13T10:59:18.981227Z","caller":"traceutil/trace.go:171","msg":"trace[624938883] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6678; }","duration":"835.956206ms","start":"2026-10-13T10:59:18.145264Z","end":"2026-10-13T10:59:18.98122Z","steps":["trace[624938883] 'agreement among raft nodes before linearized reading' (duration: 835.892154ms)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:18.981233Z","caller":"traceutil/trace.go:171","msg":"trace[973102067] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6678; }","duration":"800.765182ms","start":"2026-10-13T10:59:18.18045Z","end":"2026-10-13T10:59:18.981216Z","steps":["trace[973102067] 'agreement among raft nodes before linearized reading' (duration: 800.680119ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.981246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.14524Z","time spent":"836.001687ms","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4807,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-10-13T10:59:18.981073Z","caller":"traceutil/trace.go:171","msg":"trace[276077005] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:6678; }","duration":"809.736542ms","start":"2026-10-13T10:59:18.171324Z","end":"2026-10-13T10:59:18.98106Z","steps":["trace[276077005] 'agreement among raft nodes before linearized reading' (duration: 809.682371ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:18.981286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.180423Z","time spent":"800.849084ms","remote":"127.0.0.1:44926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:18.981318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.171303Z","time spent":"810.00586ms","remote":"127.0.0.1:59024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:19.436018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.692723ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-13T10:59:19.436384Z","caller":"traceutil/trace.go:171","msg":"trace[100781115] transaction","detail":"{read_only:false; response_revision:6679; number_of_response:1; }","duration":"449.78226ms","start":"2026-10-13T10:59:18.986555Z","end":"2026-10-13T10:59:19.436338Z","steps":["trace[100781115] 'process raft request' (duration: 146.697516ms)","trace[100781115] 'compare' (duration: 302.432215ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:59:19.436546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.986527Z","time spent":"449.975447ms","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:20.419562Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":456448185695813497,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-10-13T10:59:20.533503Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.40029016s","expected-duration":"1s"} {"level":"info","ts":"2026-10-13T10:59:20.533986Z","caller":"traceutil/trace.go:171","msg":"trace[356726000] transaction","detail":"{read_only:false; response_revision:6680; number_of_response:1; }","duration":"1.546663717s","start":"2026-10-13T10:59:18.987295Z","end":"2026-10-13T10:59:20.533959Z","steps":["trace[356726000] 'process raft request' (duration: 1.546452041s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:20.534163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.987279Z","time spent":"1.546763969s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:59:20.53423Z","caller":"traceutil/trace.go:171","msg":"trace[1729799421] transaction","detail":"{read_only:false; response_revision:6681; number_of_response:1; }","duration":"1.546825411s","start":"2026-10-13T10:59:18.987382Z","end":"2026-10-13T10:59:20.534208Z","steps":["trace[1729799421] 'process raft request' (duration: 1.546523583s)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:20.534287Z","caller":"traceutil/trace.go:171","msg":"trace[752971340] transaction","detail":"{read_only:false; response_revision:6682; number_of_response:1; }","duration":"1.546519033s","start":"2026-10-13T10:59:18.987742Z","end":"2026-10-13T10:59:20.534261Z","steps":["trace[752971340] 'process raft request' (duration: 1.546388009s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:20.534331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.98737Z","time spent":"1.546905273s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:20.534437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.987725Z","time spent":"1.546635696s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:59:20.534619Z","caller":"traceutil/trace.go:171","msg":"trace[1506819195] transaction","detail":"{read_only:false; response_revision:6683; number_of_response:1; }","duration":"1.546708668s","start":"2026-10-13T10:59:18.987893Z","end":"2026-10-13T10:59:20.534602Z","steps":["trace[1506819195] 'process raft request' (duration: 1.546335657s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:20.534791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:18.987886Z","time spent":"1.546779111s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:22.311508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000325438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-10-13T10:59:22.31158Z","caller":"traceutil/trace.go:171","msg":"trace[1000257864] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000426372s","start":"2026-10-13T10:59:20.311133Z","end":"2026-10-13T10:59:22.31156Z","steps":["trace[1000257864] 'agreement among raft nodes before linearized reading' (duration: 2.000345489s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:22.311631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.311118Z","time spent":"2.000501223s","remote":"127.0.0.1:59464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/10/13 10:59:22 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-10-13T10:59:23.45923Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.925481399s","expected-duration":"1s"} {"level":"info","ts":"2026-10-13T10:59:23.45978Z","caller":"traceutil/trace.go:171","msg":"trace[975436651] linearizableReadLoop","detail":"{readStateIndex:6932; appliedIndex:6925; }","duration":"3.540335037s","start":"2026-10-13T10:59:19.91942Z","end":"2026-10-13T10:59:23.459755Z","steps":["trace[975436651] 'read index received' (duration: 614.330903ms)","trace[975436651] 'applied index is now lower than readState.Index' (duration: 2.926003074s)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:59:23.459852Z","caller":"traceutil/trace.go:171","msg":"trace[1137706470] transaction","detail":"{read_only:false; response_revision:6684; number_of_response:1; }","duration":"4.02046266s","start":"2026-10-13T10:59:19.439373Z","end":"2026-10-13T10:59:23.459835Z","steps":["trace[1137706470] 'process raft request' (duration: 4.020143841s)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:23.459851Z","caller":"traceutil/trace.go:171","msg":"trace[1208164075] transaction","detail":"{read_only:false; response_revision:6685; number_of_response:1; }","duration":"4.015880427s","start":"2026-10-13T10:59:19.443934Z","end":"2026-10-13T10:59:23.459815Z","steps":["trace[1208164075] 'process raft request' (duration: 4.015741323s)"],"step_count":1} {"level":"info","ts":"2026-10-13T10:59:23.459889Z","caller":"traceutil/trace.go:171","msg":"trace[665397619] transaction","detail":"{read_only:false; response_revision:6686; number_of_response:1; }","duration":"3.766814084s","start":"2026-10-13T10:59:19.693063Z","end":"2026-10-13T10:59:23.459877Z","steps":["trace[665397619] 'process raft request' (duration: 3.766655189s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.459945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:19.439347Z","time spent":"4.020540002s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:23.459973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:19.443913Z","time spent":"4.015978679s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:23.460072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:19.693035Z","time spent":"3.766929936s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-13T10:59:23.460098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.540668807s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:59:23.460152Z","caller":"traceutil/trace.go:171","msg":"trace[2052009637] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:6686; }","duration":"3.540741609s","start":"2026-10-13T10:59:19.919386Z","end":"2026-10-13T10:59:23.460128Z","steps":["trace[2052009637] 'agreement among raft nodes before linearized reading' (duration: 3.540668857s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.460184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:19.91934Z","time spent":"3.540834721s","remote":"127.0.0.1:34724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:23.960476Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":456448185695813508,"retry-timeout":"500ms"} {"level":"info","ts":"2026-10-13T10:59:23.997242Z","caller":"traceutil/trace.go:171","msg":"trace[1755825009] linearizableReadLoop","detail":"{readStateIndex:6935; appliedIndex:6932; }","duration":"537.376997ms","start":"2026-10-13T10:59:23.459845Z","end":"2026-10-13T10:59:23.997222Z","steps":["trace[1755825009] 'read index received' (duration: 520.22586ms)","trace[1755825009] 'applied index is now lower than readState.Index' (duration: 17.150387ms)"],"step_count":2} {"level":"info","ts":"2026-10-13T10:59:23.997484Z","caller":"traceutil/trace.go:171","msg":"trace[2008376005] transaction","detail":"{read_only:false; response_revision:6687; number_of_response:1; }","duration":"3.409976271s","start":"2026-10-13T10:59:20.587492Z","end":"2026-10-13T10:59:23.997468Z","steps":["trace[2008376005] 'process raft request' (duration: 3.392447054s)","trace[2008376005] 'compare' (duration: 17.084853ms)"],"step_count":2} {"level":"warn","ts":"2026-10-13T10:59:23.997584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.587462Z","time spent":"3.410056083s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:59:23.99785Z","caller":"traceutil/trace.go:171","msg":"trace[1900460599] transaction","detail":"{read_only:false; response_revision:6689; number_of_response:1; }","duration":"219.542268ms","start":"2026-10-13T10:59:23.778294Z","end":"2026-10-13T10:59:23.997836Z","steps":["trace[1900460599] 'process raft request' (duration: 218.887919ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.997889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.43267452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:59:23.99802Z","caller":"traceutil/trace.go:171","msg":"trace[288341099] transaction","detail":"{read_only:false; response_revision:6688; number_of_response:1; }","duration":"3.01117543s","start":"2026-10-13T10:59:20.986835Z","end":"2026-10-13T10:59:23.998011Z","steps":["trace[288341099] 'process raft request' (duration: 3.010299075s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.998077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.986822Z","time spent":"3.011225031s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-13T10:59:23.998Z","caller":"traceutil/trace.go:171","msg":"trace[1739751754] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:6689; }","duration":"3.434109261s","start":"2026-10-13T10:59:20.563872Z","end":"2026-10-13T10:59:23.997982Z","steps":["trace[1739751754] 'agreement among raft nodes before linearized reading' (duration: 3.433966147s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.998187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.563848Z","time spent":"3.434285876s","remote":"127.0.0.1:59740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:23.998391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.217577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-10-13T10:59:23.99843Z","caller":"traceutil/trace.go:171","msg":"trace[1119989889] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:6689; }","duration":"919.275419ms","start":"2026-10-13T10:59:23.079143Z","end":"2026-10-13T10:59:23.998418Z","steps":["trace[1119989889] 'agreement among raft nodes before linearized reading' (duration: 919.203817ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.99849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:23.079119Z","time spent":"919.362751ms","remote":"127.0.0.1:59690","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2011,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-10-13T10:59:23.998678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.950475038s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-10-13T10:59:23.998723Z","caller":"traceutil/trace.go:171","msg":"trace[769610978] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6689; }","duration":"2.950555661s","start":"2026-10-13T10:59:21.048156Z","end":"2026-10-13T10:59:23.998712Z","steps":["trace[769610978] 'agreement among raft nodes before linearized reading' (duration: 2.950256762s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.998895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.457649154s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-10-13T10:59:23.998903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:21.048139Z","time spent":"2.950751046s","remote":"127.0.0.1:59688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-10-13T10:59:23.998929Z","caller":"traceutil/trace.go:171","msg":"trace[491464235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6689; }","duration":"1.457691685s","start":"2026-10-13T10:59:22.541229Z","end":"2026-10-13T10:59:23.998921Z","steps":["trace[491464235] 'agreement among raft nodes before linearized reading' (duration: 1.457616773s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.998953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:22.541224Z","time spent":"1.457723056s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-10-13T10:59:23.99912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.458464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:59:23.999251Z","caller":"traceutil/trace.go:171","msg":"trace[974495565] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:6689; }","duration":"947.664469ms","start":"2026-10-13T10:59:23.051559Z","end":"2026-10-13T10:59:23.999224Z","steps":["trace[974495565] 'agreement among raft nodes before linearized reading' (duration: 947.145374ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.999373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.509169629s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-10-13T10:59:23.999364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.012344663s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-10-13T10:59:23.999411Z","caller":"traceutil/trace.go:171","msg":"trace[2003964973] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:6689; }","duration":"3.50921297s","start":"2026-10-13T10:59:20.490189Z","end":"2026-10-13T10:59:23.999402Z","steps":["trace[2003964973] 'agreement among raft nodes before linearized reading' (duration: 3.509133518s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.999441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.490167Z","time spent":"3.509265612s","remote":"127.0.0.1:59780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":40,"response size":30,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:23.998828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.45784667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-13T10:59:23.999581Z","caller":"traceutil/trace.go:171","msg":"trace[1561383369] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6689; }","duration":"1.458618992s","start":"2026-10-13T10:59:22.540944Z","end":"2026-10-13T10:59:23.999563Z","steps":["trace[1561383369] 'agreement among raft nodes before linearized reading' (duration: 1.457821029s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.999654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.694415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-13T10:59:23.999653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.013620889s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-10-13T10:59:23.999725Z","caller":"traceutil/trace.go:171","msg":"trace[638297747] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6689; }","duration":"3.013707311s","start":"2026-10-13T10:59:20.986006Z","end":"2026-10-13T10:59:23.999713Z","steps":["trace[638297747] 'agreement among raft nodes before linearized reading' (duration: 3.013426073s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.999736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:22.540925Z","time spent":"1.458736855s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-13T10:59:23.999151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.458127838s","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-10-13T10:59:23.999886Z","caller":"traceutil/trace.go:171","msg":"trace[1620095401] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6689; }","duration":"1.458895651s","start":"2026-10-13T10:59:22.54098Z","end":"2026-10-13T10:59:23.999876Z","steps":["trace[1620095401] 'agreement among raft nodes before linearized reading' (duration: 1.458110928s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.999962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:22.540953Z","time spent":"1.458996973s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-10-13T10:59:24.000141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.014552087s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4784"} {"level":"info","ts":"2026-10-13T10:59:24.000177Z","caller":"traceutil/trace.go:171","msg":"trace[1245866157] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6689; }","duration":"3.014618829s","start":"2026-10-13T10:59:20.98555Z","end":"2026-10-13T10:59:24.000169Z","steps":["trace[1245866157] 'agreement among raft nodes before linearized reading' (duration: 3.014533777s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:24.000201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.985535Z","time spent":"3.014660341s","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4807,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-10-13T10:59:23.999684Z","caller":"traceutil/trace.go:171","msg":"trace[1823677469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6689; }","duration":"124.769167ms","start":"2026-10-13T10:59:23.874906Z","end":"2026-10-13T10:59:23.999676Z","steps":["trace[1823677469] 'agreement among raft nodes before linearized reading' (duration: 124.729246ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.99962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.69447854s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:59:24.000818Z","caller":"traceutil/trace.go:171","msg":"trace[1717110466] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:6689; }","duration":"3.695715207s","start":"2026-10-13T10:59:20.305093Z","end":"2026-10-13T10:59:24.000808Z","steps":["trace[1717110466] 'agreement among raft nodes before linearized reading' (duration: 3.694498501s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:24.000851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.305074Z","time spent":"3.695766839s","remote":"127.0.0.1:59628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:23.999362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:23.051534Z","time spent":"947.806754ms","remote":"127.0.0.1:44754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "} {"level":"warn","ts":"2026-10-13T10:59:23.998379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.456951094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-13T10:59:24.001131Z","caller":"traceutil/trace.go:171","msg":"trace[940398341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6689; }","duration":"1.459764006s","start":"2026-10-13T10:59:22.541358Z","end":"2026-10-13T10:59:24.001122Z","steps":["trace[940398341] 'agreement among raft nodes before linearized reading' (duration: 1.45645643s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:24.001162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:22.541337Z","time spent":"1.459815087s","remote":"127.0.0.1:59778","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":"warn","ts":"2026-10-13T10:59:23.999305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.94603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-13T10:59:24.001505Z","caller":"traceutil/trace.go:171","msg":"trace[1856209542] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:6689; }","duration":"294.141264ms","start":"2026-10-13T10:59:23.707348Z","end":"2026-10-13T10:59:24.00149Z","steps":["trace[1856209542] 'agreement among raft nodes before linearized reading' (duration: 291.9233ms)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:23.999802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.985999Z","time spent":"3.013791665s","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4807,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-10-13T10:59:24.002307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.690207577s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-13T10:59:24.002348Z","caller":"traceutil/trace.go:171","msg":"trace[408643495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6689; }","duration":"1.69030804s","start":"2026-10-13T10:59:22.312028Z","end":"2026-10-13T10:59:24.002336Z","steps":["trace[408643495] 'agreement among raft nodes before linearized reading' (duration: 1.690252589s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:24.002373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:22.312009Z","time spent":"1.690356981s","remote":"127.0.0.1:59460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-10-13T10:59:24.002391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.561039736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-10-13T10:59:24.002419Z","caller":"traceutil/trace.go:171","msg":"trace[321555857] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6689; }","duration":"2.561103108s","start":"2026-10-13T10:59:21.441308Z","end":"2026-10-13T10:59:24.002411Z","steps":["trace[321555857] 'agreement among raft nodes before linearized reading' (duration: 2.561023705s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:24.002441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:21.441288Z","time spent":"2.561146448s","remote":"127.0.0.1:59778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-13T10:59:24.003823Z","caller":"traceutil/trace.go:171","msg":"trace[635276926] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6689; }","duration":"3.012423945s","start":"2026-10-13T10:59:20.986995Z","end":"2026-10-13T10:59:23.999419Z","steps":["trace[635276926] 'agreement among raft nodes before linearized reading' (duration: 3.012176468s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:24.003892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:20.98699Z","time spent":"3.016885704s","remote":"127.0.0.1:59754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4807,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-10-13T10:59:24.005573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.8877581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.176\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-10-13T10:59:24.005631Z","caller":"traceutil/trace.go:171","msg":"trace[915878915] range","detail":"{range_begin:/registry/masterleases/162.253.55.176; range_end:; response_count:1; response_revision:6689; }","duration":"2.895776122s","start":"2026-10-13T10:59:21.109842Z","end":"2026-10-13T10:59:24.005618Z","steps":["trace[915878915] 'agreement among raft nodes before linearized reading' (duration: 2.887696078s)"],"step_count":1} {"level":"warn","ts":"2026-10-13T10:59:24.005666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-13T10:59:21.109824Z","time spent":"2.895827744s","remote":"127.0.0.1:59510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/162.253.55.176\" "} {"level":"info","ts":"2026-10-13T11:01:18.146475Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5446} {"level":"info","ts":"2026-10-13T11:01:18.30581Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5446,"took":"157.521375ms","hash":4021414431,"current-db-size-bytes":53301248,"current-db-size":"53 MB","current-db-size-in-use-bytes":18546688,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-10-13T11:01:18.305877Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4021414431,"revision":5446,"compact-revision":2846}