{"level":"warn","ts":"2026-07-11T03:29:01.793723Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-11T03:29:01.793842Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-07-11T03:29:01.793924Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-11T03:29:01.793936Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-07-11T03:29:01.793955Z","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-07-11T03:29:01.794674Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-07-11T03:29:01.794758Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-07-11T03:29:01.797207Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.210303ms"} {"level":"info","ts":"2026-07-11T03:29:01.804958Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-07-11T03:29:01.805057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-07-11T03:29:01.805084Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-07-11T03:29:01.805104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-11T03:29:01.805121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-07-11T03:29:01.805174Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-07-11T03:29:01.815832Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-11T03:29:01.818067Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-11T03:29:01.819488Z","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-07-11T03:29:01.822417Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-11T03:29:01.824422Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-11T03:29:01.824525Z","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-07-11T03:29:01.826003Z","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-07-11T03:29:01.826081Z","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-07-11T03:29:01.830801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-07-11T03:29:01.831089Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-07-11T03:29:01.833023Z","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-07-11T03:29:01.833104Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-07-11T03:29:01.833163Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-07-11T03:29:01.833635Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-11T03:29:01.83353Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-11T03:29:02.605882Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-07-11T03:29:02.605969Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-07-11T03:29:02.605998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-07-11T03:29:02.606022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-07-11T03:29:02.606035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-07-11T03:29:02.606053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-07-11T03:29:02.606068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-07-11T03:29:02.607362Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-07-11T03:29:02.607437Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-11T03:29:02.607409Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-11T03:29:02.607597Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-11T03:29:02.607835Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-11T03:29:02.607959Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-11T03:29:02.608813Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-07-11T03:29:02.608956Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-11T03:29:02.609019Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-11T03:29:02.610803Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-07-11T03:29:02.611456Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-11T03:29:20.236433Z","caller":"traceutil/trace.go:171","msg":"trace[1623075917] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"232.83535ms","start":"2026-07-11T03:29:20.003579Z","end":"2026-07-11T03:29:20.236414Z","steps":["trace[1623075917] 'read index received' (duration: 232.738297ms)","trace[1623075917] 'applied index is now lower than readState.Index' (duration: 95.993µs)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:29:20.236573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.974244ms","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-07-11T03:29:20.236626Z","caller":"traceutil/trace.go:171","msg":"trace[942987118] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"233.094927ms","start":"2026-07-11T03:29:20.003523Z","end":"2026-07-11T03:29:20.236618Z","steps":["trace[942987118] 'agreement among raft nodes before linearized reading' (duration: 233.000164ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:29:20.236584Z","caller":"traceutil/trace.go:171","msg":"trace[478598536] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"233.811043ms","start":"2026-07-11T03:29:20.00266Z","end":"2026-07-11T03:29:20.236471Z","steps":["trace[478598536] 'process raft request' (duration: 233.648079ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:29:20.23669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.684584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-07-11T03:29:20.236741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.96808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-11T03:29:20.236783Z","caller":"traceutil/trace.go:171","msg":"trace[2100812976] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"105.799147ms","start":"2026-07-11T03:29:20.130964Z","end":"2026-07-11T03:29:20.236764Z","steps":["trace[2100812976] 'agreement among raft nodes before linearized reading' (duration: 105.610393ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:29:20.236807Z","caller":"traceutil/trace.go:171","msg":"trace[866256978] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:419; }","duration":"101.116345ms","start":"2026-07-11T03:29:20.135676Z","end":"2026-07-11T03:29:20.236792Z","steps":["trace[866256978] 'agreement among raft nodes before linearized reading' (duration: 100.978911ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:29:45.786217Z","caller":"traceutil/trace.go:171","msg":"trace[1434376870] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"185.808067ms","start":"2026-07-11T03:29:45.600385Z","end":"2026-07-11T03:29:45.786193Z","steps":["trace[1434376870] 'process raft request' (duration: 185.53502ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:29:46.639991Z","caller":"traceutil/trace.go:171","msg":"trace[163699039] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"279.160737ms","start":"2026-07-11T03:29:46.360806Z","end":"2026-07-11T03:29:46.639967Z","steps":["trace[163699039] 'read index received' (duration: 276.81352ms)","trace[163699039] 'applied index is now lower than readState.Index' (duration: 2.346257ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:29:46.640197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.360221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-11T03:29:46.640285Z","caller":"traceutil/trace.go:171","msg":"trace[727706275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:626; }","duration":"279.504555ms","start":"2026-07-11T03:29:46.360762Z","end":"2026-07-11T03:29:46.640266Z","steps":["trace[727706275] 'agreement among raft nodes before linearized reading' (duration: 279.342441ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:29:46.640327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.937722ms","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-07-11T03:29:46.640098Z","caller":"traceutil/trace.go:171","msg":"trace[1977137830] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"394.591813ms","start":"2026-07-11T03:29:46.245471Z","end":"2026-07-11T03:29:46.640063Z","steps":["trace[1977137830] 'process raft request' (duration: 392.924783ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:29:46.640418Z","caller":"traceutil/trace.go:171","msg":"trace[37502251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"269.059696ms","start":"2026-07-11T03:29:46.371337Z","end":"2026-07-11T03:29:46.640397Z","steps":["trace[37502251] 'agreement among raft nodes before linearized reading' (duration: 268.842431ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:29:46.640432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.425994ms","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-07-11T03:29:46.640485Z","caller":"traceutil/trace.go:171","msg":"trace[1940883823] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"269.534257ms","start":"2026-07-11T03:29:46.370936Z","end":"2026-07-11T03:29:46.64047Z","steps":["trace[1940883823] 'agreement among raft nodes before linearized reading' (duration: 269.325462ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:29:46.640326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.841814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-11T03:29:46.640504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.767689ms","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-07-11T03:29:46.640591Z","caller":"traceutil/trace.go:171","msg":"trace[255975718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:626; }","duration":"250.916323ms","start":"2026-07-11T03:29:46.389654Z","end":"2026-07-11T03:29:46.64057Z","steps":["trace[255975718] 'agreement among raft nodes before linearized reading' (duration: 250.580065ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:29:46.640589Z","caller":"traceutil/trace.go:171","msg":"trace[2063665019] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"270.135271ms","start":"2026-07-11T03:29:46.370418Z","end":"2026-07-11T03:29:46.640554Z","steps":["trace[2063665019] 'agreement among raft nodes before linearized reading' (duration: 269.727042ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:29:46.640864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T03:29:46.24544Z","time spent":"394.977342ms","remote":"127.0.0.1:49092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T03:30:02.123269Z","caller":"traceutil/trace.go:171","msg":"trace[1957005102] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"172.235975ms","start":"2026-07-11T03:30:01.951007Z","end":"2026-07-11T03:30:02.123243Z","steps":["trace[1957005102] 'process raft request' (duration: 172.091421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:31:45.41111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.960916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6bd4a4cb-c2a0-4e80-a868-2c8abbe3e46c\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-11T03:31:45.411211Z","caller":"traceutil/trace.go:171","msg":"trace[1339375670] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6bd4a4cb-c2a0-4e80-a868-2c8abbe3e46c; range_end:; response_count:1; response_revision:1960; }","duration":"295.119999ms","start":"2026-07-11T03:31:45.116072Z","end":"2026-07-11T03:31:45.411192Z","steps":["trace[1339375670] 'range keys from in-memory index tree' (duration: 294.772851ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:31:45.421141Z","caller":"traceutil/trace.go:171","msg":"trace[1174813745] linearizableReadLoop","detail":"{readStateIndex:2036; appliedIndex:2035; }","duration":"110.294988ms","start":"2026-07-11T03:31:45.310831Z","end":"2026-07-11T03:31:45.421126Z","steps":["trace[1174813745] 'read index received' (duration: 110.240847ms)","trace[1174813745] 'applied index is now lower than readState.Index' (duration: 53.331µs)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:31:45.421297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.462252ms","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-07-11T03:31:45.421331Z","caller":"traceutil/trace.go:171","msg":"trace[83040929] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1961; }","duration":"110.529684ms","start":"2026-07-11T03:31:45.310794Z","end":"2026-07-11T03:31:45.421323Z","steps":["trace[83040929] 'agreement among raft nodes before linearized reading' (duration: 110.416121ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:31:45.421279Z","caller":"traceutil/trace.go:171","msg":"trace[759141673] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"125.561913ms","start":"2026-07-11T03:31:45.295655Z","end":"2026-07-11T03:31:45.421217Z","steps":["trace[759141673] 'process raft request' (duration: 125.360159ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:31:45.474508Z","caller":"traceutil/trace.go:171","msg":"trace[244293379] transaction","detail":"{read_only:false; response_revision:1962; number_of_response:1; }","duration":"132.043984ms","start":"2026-07-11T03:31:45.342424Z","end":"2026-07-11T03:31:45.474468Z","steps":["trace[244293379] 'process raft request' (duration: 131.809858ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:31:45.474828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.328308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-11T03:31:45.474855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.314251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-11T03:31:45.474878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.446024ms","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-07-11T03:31:45.475004Z","caller":"traceutil/trace.go:171","msg":"trace[1181373116] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1963; }","duration":"114.601318ms","start":"2026-07-11T03:31:45.360387Z","end":"2026-07-11T03:31:45.474989Z","steps":["trace[1181373116] 'agreement among raft nodes before linearized reading' (duration: 114.363442ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:31:45.4749Z","caller":"traceutil/trace.go:171","msg":"trace[2053091971] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1963; }","duration":"162.445901ms","start":"2026-07-11T03:31:45.312437Z","end":"2026-07-11T03:31:45.474883Z","steps":["trace[2053091971] 'agreement among raft nodes before linearized reading' (duration: 162.206806ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:31:45.474924Z","caller":"traceutil/trace.go:171","msg":"trace[265829009] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1963; }","duration":"114.439244ms","start":"2026-07-11T03:31:45.360468Z","end":"2026-07-11T03:31:45.474907Z","steps":["trace[265829009] 'agreement among raft nodes before linearized reading' (duration: 114.236509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:31:45.475336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.66841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-11T03:31:45.475401Z","caller":"traceutil/trace.go:171","msg":"trace[1818993306] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1963; }","duration":"105.776813ms","start":"2026-07-11T03:31:45.369608Z","end":"2026-07-11T03:31:45.475385Z","steps":["trace[1818993306] 'agreement among raft nodes before linearized reading' (duration: 105.273111ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:31:45.620388Z","caller":"traceutil/trace.go:171","msg":"trace[1549784788] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"140.185893ms","start":"2026-07-11T03:31:45.480174Z","end":"2026-07-11T03:31:45.62036Z","steps":["trace[1549784788] 'process raft request' (duration: 140.112621ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:31:45.620457Z","caller":"traceutil/trace.go:171","msg":"trace[1472948303] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"141.181797ms","start":"2026-07-11T03:31:45.479258Z","end":"2026-07-11T03:31:45.62044Z","steps":["trace[1472948303] 'process raft request' (duration: 50.905015ms)","trace[1472948303] 'compare' (duration: 89.867452ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:31:45.620592Z","caller":"traceutil/trace.go:171","msg":"trace[1263409026] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"140.384567ms","start":"2026-07-11T03:31:45.480169Z","end":"2026-07-11T03:31:45.620554Z","steps":["trace[1263409026] 'process raft request' (duration: 140.05625ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:31:45.711802Z","caller":"traceutil/trace.go:171","msg":"trace[1010486094] linearizableReadLoop","detail":"{readStateIndex:2043; appliedIndex:2039; }","duration":"197.128648ms","start":"2026-07-11T03:31:45.514654Z","end":"2026-07-11T03:31:45.711782Z","steps":["trace[1010486094] 'read index received' (duration: 15.566493ms)","trace[1010486094] 'applied index is now lower than readState.Index' (duration: 181.560785ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:31:45.711881Z","caller":"traceutil/trace.go:171","msg":"trace[198468510] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"214.82237ms","start":"2026-07-11T03:31:45.497017Z","end":"2026-07-11T03:31:45.711839Z","steps":["trace[198468510] 'process raft request' (duration: 214.597895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:31:45.712037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.361845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-11T03:31:45.71208Z","caller":"traceutil/trace.go:171","msg":"trace[1623935449] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:1968; }","duration":"197.456837ms","start":"2026-07-11T03:31:45.514611Z","end":"2026-07-11T03:31:45.712068Z","steps":["trace[1623935449] 'agreement among raft nodes before linearized reading' (duration: 197.297192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:31:45.712215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.777604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-11T03:31:45.712336Z","caller":"traceutil/trace.go:171","msg":"trace[339961064] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1968; }","duration":"139.974448ms","start":"2026-07-11T03:31:45.572333Z","end":"2026-07-11T03:31:45.712308Z","steps":["trace[339961064] 'agreement among raft nodes before linearized reading' (duration: 139.734253ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:32:22.976369Z","caller":"traceutil/trace.go:171","msg":"trace[1336743648] linearizableReadLoop","detail":"{readStateIndex:2308; appliedIndex:2305; }","duration":"158.063531ms","start":"2026-07-11T03:32:22.818274Z","end":"2026-07-11T03:32:22.976338Z","steps":["trace[1336743648] 'read index received' (duration: 43.405128ms)","trace[1336743648] 'applied index is now lower than readState.Index' (duration: 114.657253ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:32:22.976466Z","caller":"traceutil/trace.go:171","msg":"trace[1628606089] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"167.135325ms","start":"2026-07-11T03:32:22.809295Z","end":"2026-07-11T03:32:22.97643Z","steps":["trace[1628606089] 'process raft request' (duration: 166.808438ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:32:22.976513Z","caller":"traceutil/trace.go:171","msg":"trace[1123510209] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"164.517206ms","start":"2026-07-11T03:32:22.81196Z","end":"2026-07-11T03:32:22.976477Z","steps":["trace[1123510209] 'process raft request' (duration: 164.282961ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:32:22.976583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.285526ms","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-07-11T03:32:22.976619Z","caller":"traceutil/trace.go:171","msg":"trace[802975885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2223; }","duration":"158.373538ms","start":"2026-07-11T03:32:22.818234Z","end":"2026-07-11T03:32:22.976608Z","steps":["trace[802975885] 'agreement among raft nodes before linearized reading' (duration: 158.225785ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:32:35.216612Z","caller":"traceutil/trace.go:171","msg":"trace[1839001253] transaction","detail":"{read_only:false; response_revision:2284; number_of_response:1; }","duration":"165.906376ms","start":"2026-07-11T03:32:35.05068Z","end":"2026-07-11T03:32:35.216586Z","steps":["trace[1839001253] 'process raft request' (duration: 165.745723ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:32:35.304124Z","caller":"traceutil/trace.go:171","msg":"trace[989816858] linearizableReadLoop","detail":"{readStateIndex:2372; appliedIndex:2370; }","duration":"223.005282ms","start":"2026-07-11T03:32:35.081097Z","end":"2026-07-11T03:32:35.304102Z","steps":["trace[989816858] 'read index received' (duration: 135.43408ms)","trace[989816858] 'applied index is now lower than readState.Index' (duration: 87.569762ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:32:35.304181Z","caller":"traceutil/trace.go:171","msg":"trace[1273276463] transaction","detail":"{read_only:false; response_revision:2285; number_of_response:1; }","duration":"245.449237ms","start":"2026-07-11T03:32:35.058699Z","end":"2026-07-11T03:32:35.304148Z","steps":["trace[1273276463] 'process raft request' (duration: 227.547495ms)","trace[1273276463] 'compare' (duration: 17.694448ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:32:35.304386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.272408ms","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-07-11T03:32:35.304436Z","caller":"traceutil/trace.go:171","msg":"trace[219288607] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2285; }","duration":"223.384301ms","start":"2026-07-11T03:32:35.081044Z","end":"2026-07-11T03:32:35.304428Z","steps":["trace[219288607] 'agreement among raft nodes before linearized reading' (duration: 223.163696ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:33:56.481008Z","caller":"traceutil/trace.go:171","msg":"trace[990539444] transaction","detail":"{read_only:false; response_revision:2922; number_of_response:1; }","duration":"133.154623ms","start":"2026-07-11T03:33:56.347832Z","end":"2026-07-11T03:33:56.480987Z","steps":["trace[990539444] 'process raft request' (duration: 133.033311ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:33:56.654458Z","caller":"traceutil/trace.go:171","msg":"trace[236446895] linearizableReadLoop","detail":"{readStateIndex:3036; appliedIndex:3033; }","duration":"181.72057ms","start":"2026-07-11T03:33:56.4727Z","end":"2026-07-11T03:33:56.65442Z","steps":["trace[236446895] 'read index received' (duration: 8.103639ms)","trace[236446895] 'applied index is now lower than readState.Index' (duration: 173.615401ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:33:56.654539Z","caller":"traceutil/trace.go:171","msg":"trace[1514807697] transaction","detail":"{read_only:false; response_revision:2923; number_of_response:1; }","duration":"306.060397ms","start":"2026-07-11T03:33:56.34843Z","end":"2026-07-11T03:33:56.65449Z","steps":["trace[1514807697] 'process raft request' (duration: 206.56833ms)","trace[1514807697] 'compare' (duration: 99.17456ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:33:56.654719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T03:33:56.348417Z","time spent":"306.204401ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T03:33:56.654744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.006707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-07-11T03:33:56.654795Z","caller":"traceutil/trace.go:171","msg":"trace[1760128085] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2924; }","duration":"182.13111ms","start":"2026-07-11T03:33:56.472652Z","end":"2026-07-11T03:33:56.654783Z","steps":["trace[1760128085] 'agreement among raft nodes before linearized reading' (duration: 181.912115ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:33:56.654602Z","caller":"traceutil/trace.go:171","msg":"trace[1163526032] transaction","detail":"{read_only:false; response_revision:2924; number_of_response:1; }","duration":"306.000916ms","start":"2026-07-11T03:33:56.348561Z","end":"2026-07-11T03:33:56.654562Z","steps":["trace[1163526032] 'process raft request' (duration: 305.791311ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:33:56.655042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T03:33:56.348552Z","time spent":"306.376115ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T03:36:22.064322Z","caller":"traceutil/trace.go:171","msg":"trace[2093666027] transaction","detail":"{read_only:false; response_revision:3887; number_of_response:1; }","duration":"168.452686ms","start":"2026-07-11T03:36:21.895846Z","end":"2026-07-11T03:36:22.064299Z","steps":["trace[2093666027] 'process raft request' (duration: 168.289102ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:36:22.081105Z","caller":"traceutil/trace.go:171","msg":"trace[229553444] transaction","detail":"{read_only:false; response_revision:3889; number_of_response:1; }","duration":"105.977233ms","start":"2026-07-11T03:36:21.975113Z","end":"2026-07-11T03:36:22.08109Z","steps":["trace[229553444] 'process raft request' (duration: 105.945942ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:36:22.081119Z","caller":"traceutil/trace.go:171","msg":"trace[1803786456] transaction","detail":"{read_only:false; response_revision:3888; number_of_response:1; }","duration":"126.311833ms","start":"2026-07-11T03:36:21.954789Z","end":"2026-07-11T03:36:22.081101Z","steps":["trace[1803786456] 'process raft request' (duration: 126.180131ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:37:44.363224Z","caller":"traceutil/trace.go:171","msg":"trace[801898450] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"136.565062ms","start":"2026-07-11T03:37:44.226629Z","end":"2026-07-11T03:37:44.363194Z","steps":["trace[801898450] 'process raft request' (duration: 136.356096ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:37:44.445768Z","caller":"traceutil/trace.go:171","msg":"trace[2122742429] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"110.395964ms","start":"2026-07-11T03:37:44.335303Z","end":"2026-07-11T03:37:44.445699Z","steps":["trace[2122742429] 'process raft request' (duration: 110.167429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:37:48.529664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.366779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-07-11T03:37:48.529774Z","caller":"traceutil/trace.go:171","msg":"trace[29561554] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:5087; }","duration":"103.506453ms","start":"2026-07-11T03:37:48.426247Z","end":"2026-07-11T03:37:48.529753Z","steps":["trace[29561554] 'range keys from in-memory index tree' (duration: 103.227227ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:37:48.53001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.847153ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-11T03:37:48.530144Z","caller":"traceutil/trace.go:171","msg":"trace[1069396702] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5087; }","duration":"119.996696ms","start":"2026-07-11T03:37:48.410126Z","end":"2026-07-11T03:37:48.530123Z","steps":["trace[1069396702] 'range keys from in-memory index tree' (duration: 119.829632ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:37:48.530145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.579466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2fa93827-76f2-4a68-8b13-ec48ba447f66\" ","response":"range_response_count:1 size:3600"} {"level":"warn","ts":"2026-07-11T03:37:48.53023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.583695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:25 size:787053"} {"level":"info","ts":"2026-07-11T03:37:48.530267Z","caller":"traceutil/trace.go:171","msg":"trace[339664287] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:25; response_revision:5087; }","duration":"108.636326ms","start":"2026-07-11T03:37:48.421622Z","end":"2026-07-11T03:37:48.530259Z","steps":["trace[339664287] 'range keys from in-memory index tree' (duration: 108.307339ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:37:48.530278Z","caller":"traceutil/trace.go:171","msg":"trace[1071344786] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2fa93827-76f2-4a68-8b13-ec48ba447f66; range_end:; response_count:1; response_revision:5087; }","duration":"109.792551ms","start":"2026-07-11T03:37:48.420453Z","end":"2026-07-11T03:37:48.530246Z","steps":["trace[1071344786] 'range keys from in-memory index tree' (duration: 109.342171ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:37:49.065534Z","caller":"traceutil/trace.go:171","msg":"trace[1908303873] transaction","detail":"{read_only:false; response_revision:5093; number_of_response:1; }","duration":"134.597768ms","start":"2026-07-11T03:37:48.930905Z","end":"2026-07-11T03:37:49.065503Z","steps":["trace[1908303873] 'process raft request' (duration: 134.322872ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:38:01.434442Z","caller":"traceutil/trace.go:171","msg":"trace[1869355915] transaction","detail":"{read_only:false; response_revision:5336; number_of_response:1; }","duration":"118.318309ms","start":"2026-07-11T03:38:01.316063Z","end":"2026-07-11T03:38:01.434381Z","steps":["trace[1869355915] 'process raft request' (duration: 117.982532ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:38:02.023951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.344226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-11T03:38:02.024021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.639495ms","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-07-11T03:38:02.024062Z","caller":"traceutil/trace.go:171","msg":"trace[626996368] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5341; }","duration":"165.50823ms","start":"2026-07-11T03:38:01.85853Z","end":"2026-07-11T03:38:02.024038Z","steps":["trace[626996368] 'range keys from in-memory index tree' (duration: 165.128352ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:38:02.024106Z","caller":"traceutil/trace.go:171","msg":"trace[1149486214] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5341; }","duration":"205.773248ms","start":"2026-07-11T03:38:01.818308Z","end":"2026-07-11T03:38:02.024081Z","steps":["trace[1149486214] 'range keys from in-memory index tree' (duration: 205.44537ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:38:09.567742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.141861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-07-11T03:38:09.567843Z","caller":"traceutil/trace.go:171","msg":"trace[1560531389] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:5525; }","duration":"111.298844ms","start":"2026-07-11T03:38:09.456517Z","end":"2026-07-11T03:38:09.567816Z","steps":["trace[1560531389] 'range keys from in-memory index tree' (duration: 110.865934ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:38:09.666857Z","caller":"traceutil/trace.go:171","msg":"trace[795664478] linearizableReadLoop","detail":"{readStateIndex:5732; appliedIndex:5731; }","duration":"117.697435ms","start":"2026-07-11T03:38:09.549129Z","end":"2026-07-11T03:38:09.666826Z","steps":["trace[795664478] 'read index received' (duration: 117.383528ms)","trace[795664478] 'applied index is now lower than readState.Index' (duration: 312.607µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:38:09.66701Z","caller":"traceutil/trace.go:171","msg":"trace[1261494444] transaction","detail":"{read_only:false; response_revision:5526; number_of_response:1; }","duration":"146.380688ms","start":"2026-07-11T03:38:09.520573Z","end":"2026-07-11T03:38:09.666954Z","steps":["trace[1261494444] 'process raft request' (duration: 146.05085ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:38:09.667271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.105663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-696f797f-1007-4185-aa6e-aef3340607a3\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-07-11T03:38:09.667417Z","caller":"traceutil/trace.go:171","msg":"trace[1089354096] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-696f797f-1007-4185-aa6e-aef3340607a3; range_end:; response_count:1; response_revision:5526; }","duration":"118.297588ms","start":"2026-07-11T03:38:09.54908Z","end":"2026-07-11T03:38:09.667378Z","steps":["trace[1089354096] 'agreement among raft nodes before linearized reading' (duration: 117.911939ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:38:09.754276Z","caller":"traceutil/trace.go:171","msg":"trace[2024662801] transaction","detail":"{read_only:false; response_revision:5527; number_of_response:1; }","duration":"181.43464ms","start":"2026-07-11T03:38:09.572788Z","end":"2026-07-11T03:38:09.754222Z","steps":["trace[2024662801] 'process raft request' (duration: 100.752721ms)","trace[2024662801] 'compare' (duration: 80.150307ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:38:09.754291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.541384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"warn","ts":"2026-07-11T03:38:09.754315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.768941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xh9th\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-11T03:38:09.754413Z","caller":"traceutil/trace.go:171","msg":"trace[1636410467] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5527; }","duration":"128.743019ms","start":"2026-07-11T03:38:09.625643Z","end":"2026-07-11T03:38:09.754386Z","steps":["trace[1636410467] 'agreement among raft nodes before linearized reading' (duration: 128.35227ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:38:09.754382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.145466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-8b12b4da-6192-404f-8b59-eed4662a2d28\" ","response":"range_response_count:1 size:1293"} {"level":"info","ts":"2026-07-11T03:38:09.754496Z","caller":"traceutil/trace.go:171","msg":"trace[1328287281] range","detail":"{range_begin:/registry/persistentvolumes/pvc-8b12b4da-6192-404f-8b59-eed4662a2d28; range_end:; response_count:1; response_revision:5527; }","duration":"182.290889ms","start":"2026-07-11T03:38:09.572169Z","end":"2026-07-11T03:38:09.75446Z","steps":["trace[1328287281] 'agreement among raft nodes before linearized reading' (duration: 181.949952ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:38:09.754423Z","caller":"traceutil/trace.go:171","msg":"trace[1928669246] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xh9th; range_end:; response_count:1; response_revision:5527; }","duration":"153.942475ms","start":"2026-07-11T03:38:09.600458Z","end":"2026-07-11T03:38:09.754401Z","steps":["trace[1928669246] 'agreement among raft nodes before linearized reading' (duration: 153.615628ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:38:20.782759Z","caller":"traceutil/trace.go:171","msg":"trace[883051312] transaction","detail":"{read_only:false; response_revision:5653; number_of_response:1; }","duration":"126.50456ms","start":"2026-07-11T03:38:20.656221Z","end":"2026-07-11T03:38:20.782726Z","steps":["trace[883051312] 'process raft request' (duration: 78.812638ms)","trace[883051312] 'compare' (duration: 47.529298ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:39:02.642572Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2955} {"level":"info","ts":"2026-07-11T03:39:02.719402Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2955,"took":"75.683369ms","hash":3233482332,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":33923072,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-11T03:39:02.719488Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3233482332,"revision":2955,"compact-revision":-1} {"level":"info","ts":"2026-07-11T03:44:02.665318Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6007} {"level":"info","ts":"2026-07-11T03:44:02.761692Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6007,"took":"94.040451ms","hash":4202830295,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":21573632,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-07-11T03:44:02.761797Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4202830295,"revision":6007,"compact-revision":2955} {"level":"info","ts":"2026-07-11T03:44:23.75241Z","caller":"traceutil/trace.go:171","msg":"trace[1156639617] linearizableReadLoop","detail":"{readStateIndex:8668; appliedIndex:8667; }","duration":"391.999211ms","start":"2026-07-11T03:44:23.36037Z","end":"2026-07-11T03:44:23.75237Z","steps":["trace[1156639617] 'read index received' (duration: 391.642384ms)","trace[1156639617] 'applied index is now lower than readState.Index' (duration: 355.327µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:44:23.752446Z","caller":"traceutil/trace.go:171","msg":"trace[1933009236] transaction","detail":"{read_only:false; response_revision:8371; number_of_response:1; }","duration":"412.157022ms","start":"2026-07-11T03:44:23.34025Z","end":"2026-07-11T03:44:23.752407Z","steps":["trace[1933009236] 'process raft request' (duration: 411.858296ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:44:23.752651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T03:44:23.340235Z","time spent":"412.315056ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1119,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T03:44:23.752701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.713511ms","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-07-11T03:44:23.75277Z","caller":"traceutil/trace.go:171","msg":"trace[780972321] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:8371; }","duration":"379.818454ms","start":"2026-07-11T03:44:23.372929Z","end":"2026-07-11T03:44:23.752748Z","steps":["trace[780972321] 'agreement among raft nodes before linearized reading' (duration: 379.678981ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:44:23.752596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.193985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-11T03:44:23.752838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T03:44:23.372924Z","time spent":"379.897456ms","remote":"127.0.0.1:49122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":29,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-07-11T03:44:23.752912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.237122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-11T03:44:23.753029Z","caller":"traceutil/trace.go:171","msg":"trace[132399878] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8371; }","duration":"139.404435ms","start":"2026-07-11T03:44:23.613597Z","end":"2026-07-11T03:44:23.753002Z","steps":["trace[132399878] 'agreement among raft nodes before linearized reading' (duration: 139.059927ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:44:23.753053Z","caller":"traceutil/trace.go:171","msg":"trace[477062037] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8371; }","duration":"392.699366ms","start":"2026-07-11T03:44:23.360327Z","end":"2026-07-11T03:44:23.753026Z","steps":["trace[477062037] 'agreement among raft nodes before linearized reading' (duration: 392.167895ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:44:23.753059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.329184ms","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":"warn","ts":"2026-07-11T03:44:23.752961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.751593ms","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-07-11T03:44:23.753208Z","caller":"traceutil/trace.go:171","msg":"trace[1966499591] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:8371; }","duration":"369.513158ms","start":"2026-07-11T03:44:23.383678Z","end":"2026-07-11T03:44:23.753192Z","steps":["trace[1966499591] 'agreement among raft nodes before linearized reading' (duration: 369.295643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:44:23.753258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T03:44:23.383667Z","time spent":"369.580609ms","remote":"127.0.0.1:49174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-07-11T03:44:23.753262Z","caller":"traceutil/trace.go:171","msg":"trace[2073895597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8371; }","duration":"145.08612ms","start":"2026-07-11T03:44:23.608157Z","end":"2026-07-11T03:44:23.753243Z","steps":["trace[2073895597] 'agreement among raft nodes before linearized reading' (duration: 144.471627ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:44:23.75337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T03:44:23.360307Z","time spent":"392.953321ms","remote":"127.0.0.1:49002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-11T03:44:36.067386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.950371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-11T03:44:36.067481Z","caller":"traceutil/trace.go:171","msg":"trace[2128920964] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:8436; }","duration":"147.109704ms","start":"2026-07-11T03:44:35.920348Z","end":"2026-07-11T03:44:36.067458Z","steps":["trace[2128920964] 'agreement among raft nodes before linearized reading' (duration: 62.550211ms)","trace[2128920964] 'count revisions from in-memory index tree' (duration: 84.41041ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:44:36.067858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.976669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-11T03:44:36.067946Z","caller":"traceutil/trace.go:171","msg":"trace[496086436] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8437; }","duration":"120.131553ms","start":"2026-07-11T03:44:35.947794Z","end":"2026-07-11T03:44:36.067926Z","steps":["trace[496086436] 'agreement among raft nodes before linearized reading' (duration: 119.826807ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:44:36.068209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.962921ms","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-07-11T03:44:36.068259Z","caller":"traceutil/trace.go:171","msg":"trace[1315332972] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8437; }","duration":"116.051883ms","start":"2026-07-11T03:44:35.952195Z","end":"2026-07-11T03:44:36.068247Z","steps":["trace[1315332972] 'agreement among raft nodes before linearized reading' (duration: 115.748197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:44:36.068026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.745167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xh9th\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-11T03:44:36.068512Z","caller":"traceutil/trace.go:171","msg":"trace[1890761004] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xh9th; range_end:; response_count:1; response_revision:8437; }","duration":"116.276548ms","start":"2026-07-11T03:44:35.952212Z","end":"2026-07-11T03:44:36.068489Z","steps":["trace[1890761004] 'agreement among raft nodes before linearized reading' (duration: 115.625164ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:44:37.457346Z","caller":"traceutil/trace.go:171","msg":"trace[1986189351] transaction","detail":"{read_only:false; response_revision:8445; number_of_response:1; }","duration":"116.883032ms","start":"2026-07-11T03:44:37.340425Z","end":"2026-07-11T03:44:37.457308Z","steps":["trace[1986189351] 'process raft request' (duration: 116.619956ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:04.426782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.536094ms","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-07-11T03:45:04.426867Z","caller":"traceutil/trace.go:171","msg":"trace[1670853488] transaction","detail":"{read_only:false; response_revision:8642; number_of_response:1; }","duration":"259.573938ms","start":"2026-07-11T03:45:04.167259Z","end":"2026-07-11T03:45:04.426833Z","steps":["trace[1670853488] 'process raft request' (duration: 218.489998ms)","trace[1670853488] 'compare' (duration: 40.586389ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:45:04.426913Z","caller":"traceutil/trace.go:171","msg":"trace[1121442605] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8641; }","duration":"283.732098ms","start":"2026-07-11T03:45:04.143153Z","end":"2026-07-11T03:45:04.426885Z","steps":["trace[1121442605] 'range keys from in-memory index tree' (duration: 283.311729ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:04.42747Z","caller":"traceutil/trace.go:171","msg":"trace[2103169383] transaction","detail":"{read_only:false; response_revision:8643; number_of_response:1; }","duration":"253.471145ms","start":"2026-07-11T03:45:04.173975Z","end":"2026-07-11T03:45:04.427446Z","steps":["trace[2103169383] 'process raft request' (duration: 252.8024ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:04.427532Z","caller":"traceutil/trace.go:171","msg":"trace[1583492599] linearizableReadLoop","detail":"{readStateIndex:8950; appliedIndex:8948; }","duration":"230.4631ms","start":"2026-07-11T03:45:04.197032Z","end":"2026-07-11T03:45:04.427495Z","steps":["trace[1583492599] 'read index received' (duration: 188.740377ms)","trace[1583492599] 'applied index is now lower than readState.Index' (duration: 41.721493ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:45:04.427611Z","caller":"traceutil/trace.go:171","msg":"trace[551586135] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"126.128474ms","start":"2026-07-11T03:45:04.301449Z","end":"2026-07-11T03:45:04.427578Z","steps":["trace[551586135] 'process raft request' (duration: 125.904429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:04.427718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.688836ms","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-07-11T03:45:04.427762Z","caller":"traceutil/trace.go:171","msg":"trace[836198537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8644; }","duration":"230.794798ms","start":"2026-07-11T03:45:04.196955Z","end":"2026-07-11T03:45:04.42775Z","steps":["trace[836198537] 'agreement among raft nodes before linearized reading' (duration: 230.653014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:04.427825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.898903ms","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-07-11T03:45:04.427896Z","caller":"traceutil/trace.go:171","msg":"trace[48326230] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8644; }","duration":"222.006876ms","start":"2026-07-11T03:45:04.205854Z","end":"2026-07-11T03:45:04.427861Z","steps":["trace[48326230] 'agreement among raft nodes before linearized reading' (duration: 221.817001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:04.427962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.437146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xh9th\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-11T03:45:04.428028Z","caller":"traceutil/trace.go:171","msg":"trace[1551122184] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xh9th; range_end:; response_count:1; response_revision:8644; }","duration":"176.503988ms","start":"2026-07-11T03:45:04.251506Z","end":"2026-07-11T03:45:04.42801Z","steps":["trace[1551122184] 'agreement among raft nodes before linearized reading' (duration: 176.324304ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:04.564821Z","caller":"traceutil/trace.go:171","msg":"trace[1067066818] transaction","detail":"{read_only:false; response_revision:8645; number_of_response:1; }","duration":"130.748074ms","start":"2026-07-11T03:45:04.434025Z","end":"2026-07-11T03:45:04.564773Z","steps":["trace[1067066818] 'process raft request' (duration: 118.504257ms)","trace[1067066818] 'compare' (duration: 12.065203ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:45:04.572183Z","caller":"traceutil/trace.go:171","msg":"trace[875095967] transaction","detail":"{read_only:false; response_revision:8646; number_of_response:1; }","duration":"137.773749ms","start":"2026-07-11T03:45:04.434361Z","end":"2026-07-11T03:45:04.572135Z","steps":["trace[875095967] 'process raft request' (duration: 137.628076ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:04.572345Z","caller":"traceutil/trace.go:171","msg":"trace[742201459] linearizableReadLoop","detail":"{readStateIndex:8954; appliedIndex:8951; }","duration":"135.305345ms","start":"2026-07-11T03:45:04.437019Z","end":"2026-07-11T03:45:04.572324Z","steps":["trace[742201459] 'read index received' (duration: 115.503732ms)","trace[742201459] 'applied index is now lower than readState.Index' (duration: 19.800203ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:45:04.572658Z","caller":"traceutil/trace.go:171","msg":"trace[411046360] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"136.862029ms","start":"2026-07-11T03:45:04.435786Z","end":"2026-07-11T03:45:04.572648Z","steps":["trace[411046360] 'process raft request' (duration: 136.294247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:04.572801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.753185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228825"} {"level":"info","ts":"2026-07-11T03:45:04.572891Z","caller":"traceutil/trace.go:171","msg":"trace[1158587706] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8647; }","duration":"135.877687ms","start":"2026-07-11T03:45:04.436995Z","end":"2026-07-11T03:45:04.572872Z","steps":["trace[1158587706] 'agreement among raft nodes before linearized reading' (duration: 135.396317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:08.739866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.693122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-07-11T03:45:08.739888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.60237ms","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-07-11T03:45:08.739965Z","caller":"traceutil/trace.go:171","msg":"trace[1267138784] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8667; }","duration":"150.844796ms","start":"2026-07-11T03:45:08.589095Z","end":"2026-07-11T03:45:08.73994Z","steps":["trace[1267138784] 'range keys from in-memory index tree' (duration: 150.497928ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:08.739977Z","caller":"traceutil/trace.go:171","msg":"trace[414895625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8667; }","duration":"150.754833ms","start":"2026-07-11T03:45:08.589202Z","end":"2026-07-11T03:45:08.739957Z","steps":["trace[414895625] 'range keys from in-memory index tree' (duration: 150.358745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:08.739973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.543526ms","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-07-11T03:45:08.74004Z","caller":"traceutil/trace.go:171","msg":"trace[475233709] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8667; }","duration":"164.646599ms","start":"2026-07-11T03:45:08.575377Z","end":"2026-07-11T03:45:08.740023Z","steps":["trace[475233709] 'range keys from in-memory index tree' (duration: 164.410174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:08.740262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.917086ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-11T03:45:08.740594Z","caller":"traceutil/trace.go:171","msg":"trace[1108132467] linearizableReadLoop","detail":"{readStateIndex:8976; appliedIndex:8975; }","duration":"148.363382ms","start":"2026-07-11T03:45:08.592212Z","end":"2026-07-11T03:45:08.740576Z","steps":["trace[1108132467] 'read index received' (duration: 23.843233ms)","trace[1108132467] 'applied index is now lower than readState.Index' (duration: 124.518739ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:45:08.740683Z","caller":"traceutil/trace.go:171","msg":"trace[1044029774] transaction","detail":"{read_only:false; response_revision:8668; number_of_response:1; }","duration":"150.536169ms","start":"2026-07-11T03:45:08.590113Z","end":"2026-07-11T03:45:08.740649Z","steps":["trace[1044029774] 'process raft request' (duration: 25.99217ms)","trace[1044029774] 'compare' (duration: 123.772293ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:45:08.740749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.541905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xh9th\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-07-11T03:45:08.740798Z","caller":"traceutil/trace.go:171","msg":"trace[190904838] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xh9th; range_end:; response_count:1; response_revision:8668; }","duration":"148.607907ms","start":"2026-07-11T03:45:08.592177Z","end":"2026-07-11T03:45:08.740785Z","steps":["trace[190904838] 'agreement among raft nodes before linearized reading' (duration: 148.474084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:08.740904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.874161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-11T03:45:08.741003Z","caller":"traceutil/trace.go:171","msg":"trace[943848352] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:8668; }","duration":"101.025854ms","start":"2026-07-11T03:45:08.639955Z","end":"2026-07-11T03:45:08.740981Z","steps":["trace[943848352] 'agreement among raft nodes before linearized reading' (duration: 100.820449ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:08.932223Z","caller":"traceutil/trace.go:171","msg":"trace[1530310857] transaction","detail":"{read_only:false; response_revision:8670; number_of_response:1; }","duration":"187.362005ms","start":"2026-07-11T03:45:08.744831Z","end":"2026-07-11T03:45:08.932193Z","steps":["trace[1530310857] 'process raft request' (duration: 105.635874ms)","trace[1530310857] 'compare' (duration: 81.557487ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:45:08.932405Z","caller":"traceutil/trace.go:171","msg":"trace[316837020] linearizableReadLoop","detail":"{readStateIndex:8979; appliedIndex:8976; }","duration":"184.391641ms","start":"2026-07-11T03:45:08.747987Z","end":"2026-07-11T03:45:08.932379Z","steps":["trace[316837020] 'read index received' (duration: 51.898177ms)","trace[316837020] 'applied index is now lower than readState.Index' (duration: 132.492434ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:45:08.93257Z","caller":"traceutil/trace.go:171","msg":"trace[910284674] transaction","detail":"{read_only:false; response_revision:8671; number_of_response:1; }","duration":"187.680643ms","start":"2026-07-11T03:45:08.744875Z","end":"2026-07-11T03:45:08.932556Z","steps":["trace[910284674] 'process raft request' (duration: 187.279763ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:45:08.933124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.130038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228825"} {"level":"info","ts":"2026-07-11T03:45:08.933154Z","caller":"traceutil/trace.go:171","msg":"trace[1671528959] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8671; }","duration":"185.170678ms","start":"2026-07-11T03:45:08.747975Z","end":"2026-07-11T03:45:08.933145Z","steps":["trace[1671528959] 'agreement among raft nodes before linearized reading' (duration: 184.858892ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:16.593691Z","caller":"traceutil/trace.go:171","msg":"trace[631940628] transaction","detail":"{read_only:false; response_revision:8745; number_of_response:1; }","duration":"183.238955ms","start":"2026-07-11T03:45:16.410422Z","end":"2026-07-11T03:45:16.593661Z","steps":["trace[631940628] 'process raft request' (duration: 84.666925ms)","trace[631940628] 'compare' (duration: 98.443287ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:45:16.599459Z","caller":"traceutil/trace.go:171","msg":"trace[1426209509] transaction","detail":"{read_only:false; response_revision:8747; number_of_response:1; }","duration":"125.879739ms","start":"2026-07-11T03:45:16.473564Z","end":"2026-07-11T03:45:16.599444Z","steps":["trace[1426209509] 'process raft request' (duration: 125.822508ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:16.599614Z","caller":"traceutil/trace.go:171","msg":"trace[403494763] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8746; }","duration":"188.165174ms","start":"2026-07-11T03:45:16.411423Z","end":"2026-07-11T03:45:16.599588Z","steps":["trace[403494763] 'process raft request' (duration: 187.879138ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:16.61045Z","caller":"traceutil/trace.go:171","msg":"trace[968556083] transaction","detail":"{read_only:false; response_revision:8748; number_of_response:1; }","duration":"108.729143ms","start":"2026-07-11T03:45:16.501707Z","end":"2026-07-11T03:45:16.610436Z","steps":["trace[968556083] 'process raft request' (duration: 108.496038ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:16.610585Z","caller":"traceutil/trace.go:171","msg":"trace[1339253609] transaction","detail":"{read_only:false; response_revision:8749; number_of_response:1; }","duration":"108.583169ms","start":"2026-07-11T03:45:16.501963Z","end":"2026-07-11T03:45:16.610546Z","steps":["trace[1339253609] 'process raft request' (duration: 108.399145ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:45:18.61157Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002376.wal"} {"level":"info","ts":"2026-07-11T03:46:53.53556Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-11T03:46:53.541493Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-11T03:46:53.54159Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-11T03:49:02.676034Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8088} {"level":"info","ts":"2026-07-11T03:49:02.738643Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8088,"took":"60.277941ms","hash":3380032406,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":29007872,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-11T03:49:02.738772Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3380032406,"revision":8088,"compact-revision":6007} {"level":"info","ts":"2026-07-11T03:52:08.263567Z","caller":"traceutil/trace.go:171","msg":"trace[506699785] transaction","detail":"{read_only:false; response_revision:11912; number_of_response:1; }","duration":"202.018706ms","start":"2026-07-11T03:52:08.061522Z","end":"2026-07-11T03:52:08.263541Z","steps":["trace[506699785] 'process raft request' (duration: 201.884073ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:52:08.272694Z","caller":"traceutil/trace.go:171","msg":"trace[738953505] transaction","detail":"{read_only:false; response_revision:11913; number_of_response:1; }","duration":"189.251936ms","start":"2026-07-11T03:52:08.083414Z","end":"2026-07-11T03:52:08.272665Z","steps":["trace[738953505] 'process raft request' (duration: 189.069622ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:52:08.27302Z","caller":"traceutil/trace.go:171","msg":"trace[1852033726] transaction","detail":"{read_only:false; response_revision:11914; number_of_response:1; }","duration":"184.241826ms","start":"2026-07-11T03:52:08.088738Z","end":"2026-07-11T03:52:08.272979Z","steps":["trace[1852033726] 'process raft request' (duration: 183.887458ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:52:08.273132Z","caller":"traceutil/trace.go:171","msg":"trace[1337030999] transaction","detail":"{read_only:false; response_revision:11915; number_of_response:1; }","duration":"176.211081ms","start":"2026-07-11T03:52:08.096895Z","end":"2026-07-11T03:52:08.273106Z","steps":["trace[1337030999] 'process raft request' (duration: 175.949755ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:52:08.273207Z","caller":"traceutil/trace.go:171","msg":"trace[1924190643] linearizableReadLoop","detail":"{readStateIndex:12328; appliedIndex:12324; }","duration":"138.133385ms","start":"2026-07-11T03:52:08.135049Z","end":"2026-07-11T03:52:08.273182Z","steps":["trace[1924190643] 'read index received' (duration: 128.31435ms)","trace[1924190643] 'applied index is now lower than readState.Index' (duration: 9.817855ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:52:08.273475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.410122ms","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-07-11T03:52:08.273549Z","caller":"traceutil/trace.go:171","msg":"trace[896101740] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11916; }","duration":"138.537546ms","start":"2026-07-11T03:52:08.134992Z","end":"2026-07-11T03:52:08.273529Z","steps":["trace[896101740] 'agreement among raft nodes before linearized reading' (duration: 138.305481ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:52:09.24915Z","caller":"traceutil/trace.go:171","msg":"trace[1102191364] transaction","detail":"{read_only:false; response_revision:11922; number_of_response:1; }","duration":"160.564398ms","start":"2026-07-11T03:52:09.088553Z","end":"2026-07-11T03:52:09.249118Z","steps":["trace[1102191364] 'process raft request' (duration: 160.370914ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:52:09.249865Z","caller":"traceutil/trace.go:171","msg":"trace[1911336970] transaction","detail":"{read_only:false; response_revision:11923; number_of_response:1; }","duration":"158.801148ms","start":"2026-07-11T03:52:09.090523Z","end":"2026-07-11T03:52:09.249324Z","steps":["trace[1911336970] 'process raft request' (duration: 158.549583ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:52:09.511474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.134267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-11T03:52:09.511519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.880559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-11T03:52:09.511559Z","caller":"traceutil/trace.go:171","msg":"trace[549013295] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11923; }","duration":"149.29544ms","start":"2026-07-11T03:52:09.362248Z","end":"2026-07-11T03:52:09.511543Z","steps":["trace[549013295] 'range keys from in-memory index tree' (duration: 149.028555ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:52:09.511601Z","caller":"traceutil/trace.go:171","msg":"trace[934997693] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11923; }","duration":"137.026902ms","start":"2026-07-11T03:52:09.374551Z","end":"2026-07-11T03:52:09.511578Z","steps":["trace[934997693] 'range keys from in-memory index tree' (duration: 136.678274ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:54:02.687778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10491} {"level":"info","ts":"2026-07-11T03:54:02.78447Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10491,"took":"94.432957ms","hash":2446282243,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":26718208,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-07-11T03:54:02.784551Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2446282243,"revision":10491,"compact-revision":8088} {"level":"info","ts":"2026-07-11T03:58:54.794607Z","caller":"traceutil/trace.go:171","msg":"trace[1918895614] transaction","detail":"{read_only:false; response_revision:14619; number_of_response:1; }","duration":"151.361753ms","start":"2026-07-11T03:58:54.643202Z","end":"2026-07-11T03:58:54.794564Z","steps":["trace[1918895614] 'process raft request' (duration: 151.128598ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:59:02.696844Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12680} {"level":"info","ts":"2026-07-11T03:59:02.789391Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12680,"took":"90.074932ms","hash":208935813,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":28565504,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-11T03:59:02.789446Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":208935813,"revision":12680,"compact-revision":10491} {"level":"info","ts":"2026-07-11T03:59:04.078606Z","caller":"traceutil/trace.go:171","msg":"trace[1910119464] transaction","detail":"{read_only:false; response_revision:14787; number_of_response:1; }","duration":"164.768008ms","start":"2026-07-11T03:59:03.91381Z","end":"2026-07-11T03:59:04.078578Z","steps":["trace[1910119464] 'process raft request' (duration: 164.724197ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:59:04.078731Z","caller":"traceutil/trace.go:171","msg":"trace[53540009] linearizableReadLoop","detail":"{readStateIndex:15296; appliedIndex:15295; }","duration":"176.74626ms","start":"2026-07-11T03:59:03.901966Z","end":"2026-07-11T03:59:04.078712Z","steps":["trace[53540009] 'read index received' (duration: 77.15946ms)","trace[53540009] 'applied index is now lower than readState.Index' (duration: 99.584929ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:59:04.078861Z","caller":"traceutil/trace.go:171","msg":"trace[1892887703] transaction","detail":"{read_only:false; response_revision:14785; number_of_response:1; }","duration":"171.068875ms","start":"2026-07-11T03:59:03.907778Z","end":"2026-07-11T03:59:04.078847Z","steps":["trace[1892887703] 'process raft request' (duration: 170.676277ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:59:04.078811Z","caller":"traceutil/trace.go:171","msg":"trace[833562427] transaction","detail":"{read_only:false; response_revision:14784; number_of_response:1; }","duration":"179.456079ms","start":"2026-07-11T03:59:03.899305Z","end":"2026-07-11T03:59:04.078761Z","steps":["trace[833562427] 'process raft request' (duration: 79.793397ms)","trace[833562427] 'compare' (duration: 99.220442ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:59:04.078936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.956254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-07-11T03:59:04.07897Z","caller":"traceutil/trace.go:171","msg":"trace[212877713] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:14787; }","duration":"177.047876ms","start":"2026-07-11T03:59:03.901913Z","end":"2026-07-11T03:59:04.078961Z","steps":["trace[212877713] 'agreement among raft nodes before linearized reading' (duration: 176.916903ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:59:04.078935Z","caller":"traceutil/trace.go:171","msg":"trace[141953748] transaction","detail":"{read_only:false; response_revision:14786; number_of_response:1; }","duration":"166.858822ms","start":"2026-07-11T03:59:03.912036Z","end":"2026-07-11T03:59:04.078895Z","steps":["trace[141953748] 'process raft request' (duration: 166.466794ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T03:59:04.079197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.643141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130128"} {"level":"info","ts":"2026-07-11T03:59:04.079294Z","caller":"traceutil/trace.go:171","msg":"trace[694494557] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:14787; }","duration":"152.800525ms","start":"2026-07-11T03:59:03.926474Z","end":"2026-07-11T03:59:04.079274Z","steps":["trace[694494557] 'agreement among raft nodes before linearized reading' (duration: 152.419526ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T03:59:04.335469Z","caller":"traceutil/trace.go:171","msg":"trace[689906528] linearizableReadLoop","detail":"{readStateIndex:15300; appliedIndex:15299; }","duration":"229.316131ms","start":"2026-07-11T03:59:04.106124Z","end":"2026-07-11T03:59:04.33544Z","steps":["trace[689906528] 'read index received' (duration: 204.126269ms)","trace[689906528] 'applied index is now lower than readState.Index' (duration: 25.188742ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T03:59:04.335551Z","caller":"traceutil/trace.go:171","msg":"trace[2104966352] transaction","detail":"{read_only:false; response_revision:14788; number_of_response:1; }","duration":"240.24294ms","start":"2026-07-11T03:59:04.095259Z","end":"2026-07-11T03:59:04.335501Z","steps":["trace[2104966352] 'process raft request' (duration: 214.946306ms)","trace[2104966352] 'compare' (duration: 25.036608ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T03:59:04.335704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.560526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:130128"} {"level":"info","ts":"2026-07-11T03:59:04.335735Z","caller":"traceutil/trace.go:171","msg":"trace[517254541] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:14788; }","duration":"229.660238ms","start":"2026-07-11T03:59:04.106066Z","end":"2026-07-11T03:59:04.335726Z","steps":["trace[517254541] 'agreement among raft nodes before linearized reading' (duration: 229.490114ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:01:16.836244Z","caller":"traceutil/trace.go:171","msg":"trace[1789047640] transaction","detail":"{read_only:false; response_revision:16071; number_of_response:1; }","duration":"263.236637ms","start":"2026-07-11T04:01:16.572979Z","end":"2026-07-11T04:01:16.836215Z","steps":["trace[1789047640] 'process raft request' (duration: 255.57073ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:01:16.836266Z","caller":"traceutil/trace.go:171","msg":"trace[1427026691] transaction","detail":"{read_only:false; response_revision:16072; number_of_response:1; }","duration":"261.411546ms","start":"2026-07-11T04:01:16.574827Z","end":"2026-07-11T04:01:16.836239Z","steps":["trace[1427026691] 'process raft request' (duration: 261.268973ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:01:16.836402Z","caller":"traceutil/trace.go:171","msg":"trace[1947475878] linearizableReadLoop","detail":"{readStateIndex:16628; appliedIndex:16624; }","duration":"143.634726ms","start":"2026-07-11T04:01:16.692741Z","end":"2026-07-11T04:01:16.836375Z","steps":["trace[1947475878] 'read index received' (duration: 135.828216ms)","trace[1947475878] 'applied index is now lower than readState.Index' (duration: 7.80538ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:01:16.836457Z","caller":"traceutil/trace.go:171","msg":"trace[1804973595] transaction","detail":"{read_only:false; response_revision:16073; number_of_response:1; }","duration":"261.517249ms","start":"2026-07-11T04:01:16.574926Z","end":"2026-07-11T04:01:16.836443Z","steps":["trace[1804973595] 'process raft request' (duration: 261.268373ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:01:16.836539Z","caller":"traceutil/trace.go:171","msg":"trace[1385149671] transaction","detail":"{read_only:false; response_revision:16074; number_of_response:1; }","duration":"259.136846ms","start":"2026-07-11T04:01:16.577389Z","end":"2026-07-11T04:01:16.836526Z","steps":["trace[1385149671] 'process raft request' (duration: 258.900531ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:01:16.837007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.251151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-11T04:01:16.837062Z","caller":"traceutil/trace.go:171","msg":"trace[875123857] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:16074; }","duration":"144.368663ms","start":"2026-07-11T04:01:16.692679Z","end":"2026-07-11T04:01:16.837048Z","steps":["trace[875123857] 'agreement among raft nodes before linearized reading' (duration: 144.269651ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:04:02.706273Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14739} {"level":"info","ts":"2026-07-11T04:04:02.796433Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14739,"took":"86.2471ms","hash":1370234260,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":29208576,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-11T04:04:02.796519Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1370234260,"revision":14739,"compact-revision":12680} {"level":"info","ts":"2026-07-11T04:06:20.328173Z","caller":"traceutil/trace.go:171","msg":"trace[906110426] transaction","detail":"{read_only:false; response_revision:18362; number_of_response:1; }","duration":"108.649209ms","start":"2026-07-11T04:06:20.219497Z","end":"2026-07-11T04:06:20.328146Z","steps":["trace[906110426] 'process raft request' (duration: 108.500886ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:06:27.910205Z","caller":"traceutil/trace.go:171","msg":"trace[693582133] linearizableReadLoop","detail":"{readStateIndex:19027; appliedIndex:19026; }","duration":"162.390067ms","start":"2026-07-11T04:06:27.747779Z","end":"2026-07-11T04:06:27.910169Z","steps":["trace[693582133] 'read index received' (duration: 161.870185ms)","trace[693582133] 'applied index is now lower than readState.Index' (duration: 518.301µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:06:27.910296Z","caller":"traceutil/trace.go:171","msg":"trace[1015788814] transaction","detail":"{read_only:false; response_revision:18399; number_of_response:1; }","duration":"181.814952ms","start":"2026-07-11T04:06:27.728442Z","end":"2026-07-11T04:06:27.910257Z","steps":["trace[1015788814] 'process raft request' (duration: 181.401554ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:27.910829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.38554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-11T04:06:27.910828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.924989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-29729040-bnrgb\" ","response":"range_response_count:1 size:7033"} {"level":"info","ts":"2026-07-11T04:06:27.910918Z","caller":"traceutil/trace.go:171","msg":"trace[1717087137] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:18399; }","duration":"111.512002ms","start":"2026-07-11T04:06:27.799387Z","end":"2026-07-11T04:06:27.9109Z","steps":["trace[1717087137] 'agreement among raft nodes before linearized reading' (duration: 111.331108ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:27.910911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.377953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-11T04:06:27.910951Z","caller":"traceutil/trace.go:171","msg":"trace[1375596402] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-29729040-bnrgb; range_end:; response_count:1; response_revision:18399; }","duration":"163.169864ms","start":"2026-07-11T04:06:27.747753Z","end":"2026-07-11T04:06:27.910923Z","steps":["trace[1375596402] 'agreement among raft nodes before linearized reading' (duration: 162.580661ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:06:27.911005Z","caller":"traceutil/trace.go:171","msg":"trace[450254676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18399; }","duration":"155.533706ms","start":"2026-07-11T04:06:27.75545Z","end":"2026-07-11T04:06:27.910983Z","steps":["trace[450254676] 'agreement among raft nodes before linearized reading' (duration: 155.26624ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:27.911097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.947925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-dg4cl\" ","response":"range_response_count:1 size:9791"} {"level":"info","ts":"2026-07-11T04:06:27.91161Z","caller":"traceutil/trace.go:171","msg":"trace[1676162545] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-dg4cl; range_end:; response_count:1; response_revision:18399; }","duration":"161.67103ms","start":"2026-07-11T04:06:27.749924Z","end":"2026-07-11T04:06:27.911595Z","steps":["trace[1676162545] 'agreement among raft nodes before linearized reading' (duration: 160.770421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:27.911244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.923104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-11T04:06:27.912432Z","caller":"traceutil/trace.go:171","msg":"trace[907358107] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18399; }","duration":"157.06975ms","start":"2026-07-11T04:06:27.755293Z","end":"2026-07-11T04:06:27.912362Z","steps":["trace[907358107] 'agreement among raft nodes before linearized reading' (duration: 155.817602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:27.911354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.870255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-11T04:06:27.91288Z","caller":"traceutil/trace.go:171","msg":"trace[1985316681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18399; }","duration":"137.413749ms","start":"2026-07-11T04:06:27.775448Z","end":"2026-07-11T04:06:27.912862Z","steps":["trace[1985316681] 'agreement among raft nodes before linearized reading' (duration: 135.658391ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:27.911524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.720046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-07-11T04:06:27.913019Z","caller":"traceutil/trace.go:171","msg":"trace[936908643] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:18399; }","duration":"160.26319ms","start":"2026-07-11T04:06:27.752735Z","end":"2026-07-11T04:06:27.912998Z","steps":["trace[936908643] 'agreement among raft nodes before linearized reading' (duration: 158.45625ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:06:28.250214Z","caller":"traceutil/trace.go:171","msg":"trace[377989427] transaction","detail":"{read_only:false; response_revision:18403; number_of_response:1; }","duration":"235.262282ms","start":"2026-07-11T04:06:28.014927Z","end":"2026-07-11T04:06:28.25019Z","steps":["trace[377989427] 'process raft request' (duration: 235.109799ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:06:28.491927Z","caller":"traceutil/trace.go:171","msg":"trace[350654379] linearizableReadLoop","detail":"{readStateIndex:19034; appliedIndex:19031; }","duration":"126.561202ms","start":"2026-07-11T04:06:28.365344Z","end":"2026-07-11T04:06:28.491905Z","steps":["trace[350654379] 'read index received' (duration: 126.280596ms)","trace[350654379] 'applied index is now lower than readState.Index' (duration: 279.666µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:06:28.492252Z","caller":"traceutil/trace.go:171","msg":"trace[1806307565] transaction","detail":"{read_only:false; response_revision:18404; number_of_response:1; }","duration":"473.270725ms","start":"2026-07-11T04:06:28.018935Z","end":"2026-07-11T04:06:28.492205Z","steps":["trace[1806307565] 'process raft request' (duration: 472.756313ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:28.49236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:06:28.01891Z","time spent":"473.371978ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:06:28.49247Z","caller":"traceutil/trace.go:171","msg":"trace[222411240] transaction","detail":"{read_only:false; response_revision:18405; number_of_response:1; }","duration":"472.962819ms","start":"2026-07-11T04:06:28.019498Z","end":"2026-07-11T04:06:28.492461Z","steps":["trace[222411240] 'process raft request' (duration: 472.334144ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:28.492513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:06:28.019487Z","time spent":"473.001779ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:06:28.49258Z","caller":"traceutil/trace.go:171","msg":"trace[1127376463] transaction","detail":"{read_only:false; response_revision:18406; number_of_response:1; }","duration":"472.428227ms","start":"2026-07-11T04:06:28.020144Z","end":"2026-07-11T04:06:28.492572Z","steps":["trace[1127376463] 'process raft request' (duration: 471.729731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:06:28.49262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:06:28.020134Z","time spent":"472.463428ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:06:28.492865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.502403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-11T04:06:28.492933Z","caller":"traceutil/trace.go:171","msg":"trace[1562483696] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18406; }","duration":"127.617046ms","start":"2026-07-11T04:06:28.365297Z","end":"2026-07-11T04:06:28.492914Z","steps":["trace[1562483696] 'agreement among raft nodes before linearized reading' (duration: 127.436532ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:08:00.593431Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-11T04:08:00.59975Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-11T04:08:00.59988Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-11T04:09:02.713635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17273} {"level":"info","ts":"2026-07-11T04:09:02.820469Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17273,"took":"102.579317ms","hash":882901691,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":34426880,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-11T04:09:02.820557Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":882901691,"revision":17273,"compact-revision":14739} {"level":"info","ts":"2026-07-11T04:13:12.242957Z","caller":"traceutil/trace.go:171","msg":"trace[1000951347] transaction","detail":"{read_only:false; response_revision:21490; number_of_response:1; }","duration":"221.257006ms","start":"2026-07-11T04:13:12.021668Z","end":"2026-07-11T04:13:12.242925Z","steps":["trace[1000951347] 'process raft request' (duration: 201.118925ms)","trace[1000951347] 'compare' (duration: 19.996478ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:13:12.261807Z","caller":"traceutil/trace.go:171","msg":"trace[2013236847] linearizableReadLoop","detail":"{readStateIndex:22223; appliedIndex:22220; }","duration":"233.636707ms","start":"2026-07-11T04:13:12.028142Z","end":"2026-07-11T04:13:12.261778Z","steps":["trace[2013236847] 'read index received' (duration: 194.724985ms)","trace[2013236847] 'applied index is now lower than readState.Index' (duration: 38.910592ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:13:12.261883Z","caller":"traceutil/trace.go:171","msg":"trace[1089290950] transaction","detail":"{read_only:false; response_revision:21491; number_of_response:1; }","duration":"240.050707ms","start":"2026-07-11T04:13:12.021793Z","end":"2026-07-11T04:13:12.261844Z","steps":["trace[1089290950] 'process raft request' (duration: 239.761181ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:13:12.261946Z","caller":"traceutil/trace.go:171","msg":"trace[1108307243] transaction","detail":"{read_only:false; response_revision:21492; number_of_response:1; }","duration":"240.103799ms","start":"2026-07-11T04:13:12.021831Z","end":"2026-07-11T04:13:12.261935Z","steps":["trace[1108307243] 'process raft request' (duration: 239.859663ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:13:12.26234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.09284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-07-11T04:13:12.262324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.378783ms","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-07-11T04:13:12.262391Z","caller":"traceutil/trace.go:171","msg":"trace[1286440411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21492; }","duration":"225.218864ms","start":"2026-07-11T04:13:12.037159Z","end":"2026-07-11T04:13:12.262378Z","steps":["trace[1286440411] 'agreement among raft nodes before linearized reading' (duration: 224.938517ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:13:12.262412Z","caller":"traceutil/trace.go:171","msg":"trace[482807200] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21492; }","duration":"228.500055ms","start":"2026-07-11T04:13:12.033893Z","end":"2026-07-11T04:13:12.262393Z","steps":["trace[482807200] 'agreement among raft nodes before linearized reading' (duration: 228.159788ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:13:12.262324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.161329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-11T04:13:12.262491Z","caller":"traceutil/trace.go:171","msg":"trace[1078670416] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21492; }","duration":"234.365014ms","start":"2026-07-11T04:13:12.02811Z","end":"2026-07-11T04:13:12.262475Z","steps":["trace[1078670416] 'agreement among raft nodes before linearized reading' (duration: 233.965865ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:13:28.50025Z","caller":"traceutil/trace.go:171","msg":"trace[1559697550] linearizableReadLoop","detail":"{readStateIndex:22308; appliedIndex:22305; }","duration":"149.273329ms","start":"2026-07-11T04:13:28.350956Z","end":"2026-07-11T04:13:28.500229Z","steps":["trace[1559697550] 'read index received' (duration: 3.462846ms)","trace[1559697550] 'applied index is now lower than readState.Index' (duration: 145.809443ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:13:28.500296Z","caller":"traceutil/trace.go:171","msg":"trace[1406805885] transaction","detail":"{read_only:false; response_revision:21573; number_of_response:1; }","duration":"182.880986ms","start":"2026-07-11T04:13:28.317376Z","end":"2026-07-11T04:13:28.500257Z","steps":["trace[1406805885] 'process raft request' (duration: 182.702212ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:13:28.500343Z","caller":"traceutil/trace.go:171","msg":"trace[92698498] transaction","detail":"{read_only:false; response_revision:21574; number_of_response:1; }","duration":"173.721405ms","start":"2026-07-11T04:13:28.326614Z","end":"2026-07-11T04:13:28.500335Z","steps":["trace[92698498] 'process raft request' (duration: 173.585612ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:13:28.500511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.953548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-11T04:13:28.500576Z","caller":"traceutil/trace.go:171","msg":"trace[1758538935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21574; }","duration":"147.04224ms","start":"2026-07-11T04:13:28.35352Z","end":"2026-07-11T04:13:28.500562Z","steps":["trace[1758538935] 'agreement among raft nodes before linearized reading' (duration: 146.876727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:13:28.500511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.589236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-11T04:13:28.500645Z","caller":"traceutil/trace.go:171","msg":"trace[1237929693] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21574; }","duration":"149.76404ms","start":"2026-07-11T04:13:28.350873Z","end":"2026-07-11T04:13:28.500637Z","steps":["trace[1237929693] 'agreement among raft nodes before linearized reading' (duration: 149.523315ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:13:28.500532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.798839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-11T04:13:28.500749Z","caller":"traceutil/trace.go:171","msg":"trace[1186374741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21574; }","duration":"144.030594ms","start":"2026-07-11T04:13:28.356699Z","end":"2026-07-11T04:13:28.50073Z","steps":["trace[1186374741] 'agreement among raft nodes before linearized reading' (duration: 143.715957ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:13:28.671663Z","caller":"traceutil/trace.go:171","msg":"trace[1195016728] transaction","detail":"{read_only:false; response_revision:21575; number_of_response:1; }","duration":"167.222952ms","start":"2026-07-11T04:13:28.504408Z","end":"2026-07-11T04:13:28.671631Z","steps":["trace[1195016728] 'process raft request' (duration: 123.036624ms)","trace[1195016728] 'compare' (duration: 43.729598ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:13:28.671695Z","caller":"traceutil/trace.go:171","msg":"trace[2047033783] linearizableReadLoop","detail":"{readStateIndex:22311; appliedIndex:22308; }","duration":"150.24544ms","start":"2026-07-11T04:13:28.521429Z","end":"2026-07-11T04:13:28.671675Z","steps":["trace[2047033783] 'read index received' (duration: 106.018191ms)","trace[2047033783] 'applied index is now lower than readState.Index' (duration: 44.225509ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:13:28.671711Z","caller":"traceutil/trace.go:171","msg":"trace[1920927911] transaction","detail":"{read_only:false; response_revision:21576; number_of_response:1; }","duration":"167.263723ms","start":"2026-07-11T04:13:28.504415Z","end":"2026-07-11T04:13:28.671679Z","steps":["trace[1920927911] 'process raft request' (duration: 167.12978ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:13:28.671885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.439604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-07-11T04:13:28.671929Z","caller":"traceutil/trace.go:171","msg":"trace[881181880] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:21577; }","duration":"150.523436ms","start":"2026-07-11T04:13:28.521387Z","end":"2026-07-11T04:13:28.671911Z","steps":["trace[881181880] 'agreement among raft nodes before linearized reading' (duration: 150.351932ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:13:28.671898Z","caller":"traceutil/trace.go:171","msg":"trace[1083081292] transaction","detail":"{read_only:false; response_revision:21577; number_of_response:1; }","duration":"167.429387ms","start":"2026-07-11T04:13:28.504416Z","end":"2026-07-11T04:13:28.671846Z","steps":["trace[1083081292] 'process raft request' (duration: 167.200642ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:13:28.870291Z","caller":"traceutil/trace.go:171","msg":"trace[792028249] transaction","detail":"{read_only:false; response_revision:21578; number_of_response:1; }","duration":"116.377629ms","start":"2026-07-11T04:13:28.753757Z","end":"2026-07-11T04:13:28.870135Z","steps":["trace[792028249] 'process raft request' (duration: 66.433915ms)","trace[792028249] 'compare' (duration: 49.722829ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:13:28.87034Z","caller":"traceutil/trace.go:171","msg":"trace[388219692] transaction","detail":"{read_only:false; response_revision:21579; number_of_response:1; }","duration":"112.648357ms","start":"2026-07-11T04:13:28.757659Z","end":"2026-07-11T04:13:28.870307Z","steps":["trace[388219692] 'process raft request' (duration: 112.413812ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:14:02.721107Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19820} {"level":"info","ts":"2026-07-11T04:14:02.826021Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19820,"took":"101.713288ms","hash":724963745,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":30056448,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-11T04:14:02.826088Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":724963745,"revision":19820,"compact-revision":17273} {"level":"info","ts":"2026-07-11T04:17:33.681763Z","caller":"traceutil/trace.go:171","msg":"trace[1145876635] transaction","detail":"{read_only:false; response_revision:24092; number_of_response:1; }","duration":"245.421432ms","start":"2026-07-11T04:17:33.436302Z","end":"2026-07-11T04:17:33.681724Z","steps":["trace[1145876635] 'process raft request' (duration: 240.815581ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:17:33.699466Z","caller":"traceutil/trace.go:171","msg":"trace[1397495239] transaction","detail":"{read_only:false; response_revision:24093; number_of_response:1; }","duration":"260.236137ms","start":"2026-07-11T04:17:33.439203Z","end":"2026-07-11T04:17:33.699439Z","steps":["trace[1397495239] 'process raft request' (duration: 259.94912ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:19:02.727059Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21980} {"level":"info","ts":"2026-07-11T04:19:02.83533Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21980,"took":"104.870415ms","hash":3976992477,"current-db-size-bytes":58929152,"current-db-size":"59 MB","current-db-size-in-use-bytes":43708416,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-07-11T04:19:02.835408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3976992477,"revision":21980,"compact-revision":19820} {"level":"info","ts":"2026-07-11T04:19:52.419246Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000066d6.wal"} {"level":"info","ts":"2026-07-11T04:21:11.61247Z","caller":"traceutil/trace.go:171","msg":"trace[1247011854] transaction","detail":"{read_only:false; response_revision:26270; number_of_response:1; }","duration":"127.219825ms","start":"2026-07-11T04:21:11.485194Z","end":"2026-07-11T04:21:11.612414Z","steps":["trace[1247011854] 'process raft request' (duration: 102.043053ms)","trace[1247011854] 'compare' (duration: 24.894465ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:11.754966Z","caller":"traceutil/trace.go:171","msg":"trace[1008111625] transaction","detail":"{read_only:false; response_revision:26272; number_of_response:1; }","duration":"167.342622ms","start":"2026-07-11T04:21:11.587588Z","end":"2026-07-11T04:21:11.754931Z","steps":["trace[1008111625] 'process raft request' (duration: 166.609876ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:11.941682Z","caller":"traceutil/trace.go:171","msg":"trace[919473684] transaction","detail":"{read_only:false; response_revision:26273; number_of_response:1; }","duration":"180.093181ms","start":"2026-07-11T04:21:11.76151Z","end":"2026-07-11T04:21:11.941604Z","steps":["trace[919473684] 'process raft request' (duration: 179.924008ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:13.281648Z","caller":"traceutil/trace.go:171","msg":"trace[1169578342] transaction","detail":"{read_only:false; response_revision:26285; number_of_response:1; }","duration":"161.121126ms","start":"2026-07-11T04:21:13.120476Z","end":"2026-07-11T04:21:13.281597Z","steps":["trace[1169578342] 'process raft request' (duration: 137.397508ms)","trace[1169578342] 'compare' (duration: 23.118915ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:13.281732Z","caller":"traceutil/trace.go:171","msg":"trace[971308906] transaction","detail":"{read_only:false; response_revision:26286; number_of_response:1; }","duration":"160.292199ms","start":"2026-07-11T04:21:13.121381Z","end":"2026-07-11T04:21:13.281673Z","steps":["trace[971308906] 'process raft request' (duration: 160.042983ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:17.899397Z","caller":"traceutil/trace.go:171","msg":"trace[1022791146] transaction","detail":"{read_only:false; response_revision:26332; number_of_response:1; }","duration":"121.810977ms","start":"2026-07-11T04:21:17.777567Z","end":"2026-07-11T04:21:17.899378Z","steps":["trace[1022791146] 'process raft request' (duration: 121.680014ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:17.899749Z","caller":"traceutil/trace.go:171","msg":"trace[847986170] linearizableReadLoop","detail":"{readStateIndex:27201; appliedIndex:27201; }","duration":"122.042391ms","start":"2026-07-11T04:21:17.777695Z","end":"2026-07-11T04:21:17.899738Z","steps":["trace[847986170] 'read index received' (duration: 122.021481ms)","trace[847986170] 'applied index is now lower than readState.Index' (duration: 19.7µs)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:17.899891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.180135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18431"} {"level":"info","ts":"2026-07-11T04:21:17.899922Z","caller":"traceutil/trace.go:171","msg":"trace[2035335317] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26332; }","duration":"122.253476ms","start":"2026-07-11T04:21:17.777659Z","end":"2026-07-11T04:21:17.899912Z","steps":["trace[2035335317] 'agreement among raft nodes before linearized reading' (duration: 122.126673ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:18.430252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.885189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:18.43035Z","caller":"traceutil/trace.go:171","msg":"trace[820145599] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26332; }","duration":"472.016952ms","start":"2026-07-11T04:21:17.95831Z","end":"2026-07-11T04:21:18.430327Z","steps":["trace[820145599] 'range keys from in-memory index tree' (duration: 471.741265ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:18.430396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:17.958292Z","time spent":"472.092843ms","remote":"127.0.0.1:49474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-07-11T04:21:18.430757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.147238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-11T04:21:18.430915Z","caller":"traceutil/trace.go:171","msg":"trace[209455445] transaction","detail":"{read_only:false; response_revision:26333; number_of_response:1; }","duration":"468.75203ms","start":"2026-07-11T04:21:17.962139Z","end":"2026-07-11T04:21:18.430891Z","steps":["trace[209455445] 'process raft request' (duration: 190.319876ms)","trace[209455445] 'compare' (duration: 277.997395ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:18.430995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:17.962118Z","time spent":"468.841742ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:18.432962Z","caller":"traceutil/trace.go:171","msg":"trace[1484000664] transaction","detail":"{read_only:false; response_revision:26334; number_of_response:1; }","duration":"122.942381ms","start":"2026-07-11T04:21:18.309999Z","end":"2026-07-11T04:21:18.432941Z","steps":["trace[1484000664] 'process raft request' (duration: 122.812308ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:18.748558Z","caller":"traceutil/trace.go:171","msg":"trace[1984237717] linearizableReadLoop","detail":"{readStateIndex:27206; appliedIndex:27204; }","duration":"146.000795ms","start":"2026-07-11T04:21:18.602531Z","end":"2026-07-11T04:21:18.748532Z","steps":["trace[1984237717] 'read index received' (duration: 123.491963ms)","trace[1984237717] 'applied index is now lower than readState.Index' (duration: 22.507742ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:18.748722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.171959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:18.748836Z","caller":"traceutil/trace.go:171","msg":"trace[569288941] transaction","detail":"{read_only:false; response_revision:26337; number_of_response:1; }","duration":"175.162014ms","start":"2026-07-11T04:21:18.573639Z","end":"2026-07-11T04:21:18.748801Z","steps":["trace[569288941] 'process raft request' (duration: 174.818847ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:18.748895Z","caller":"traceutil/trace.go:171","msg":"trace[80223906] transaction","detail":"{read_only:false; response_revision:26336; number_of_response:1; }","duration":"230.596547ms","start":"2026-07-11T04:21:18.518216Z","end":"2026-07-11T04:21:18.748813Z","steps":["trace[80223906] 'process raft request' (duration: 207.897911ms)","trace[80223906] 'compare' (duration: 22.110314ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:18.749034Z","caller":"traceutil/trace.go:171","msg":"trace[2135153050] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:26337; }","duration":"146.480026ms","start":"2026-07-11T04:21:18.602451Z","end":"2026-07-11T04:21:18.748931Z","steps":["trace[2135153050] 'agreement among raft nodes before linearized reading' (duration: 146.174899ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:19.436109Z","caller":"traceutil/trace.go:171","msg":"trace[1762098109] linearizableReadLoop","detail":"{readStateIndex:27207; appliedIndex:27206; }","duration":"196.495941ms","start":"2026-07-11T04:21:19.239588Z","end":"2026-07-11T04:21:19.436084Z","steps":["trace[1762098109] 'read index received' (duration: 196.243255ms)","trace[1762098109] 'applied index is now lower than readState.Index' (duration: 251.896µs)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:19.436377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.581176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-11T04:21:19.436407Z","caller":"traceutil/trace.go:171","msg":"trace[46557111] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26338; }","duration":"129.685769ms","start":"2026-07-11T04:21:19.306713Z","end":"2026-07-11T04:21:19.436399Z","steps":["trace[46557111] 'agreement among raft nodes before linearized reading' (duration: 129.501165ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:19.436435Z","caller":"traceutil/trace.go:171","msg":"trace[376559732] transaction","detail":"{read_only:false; response_revision:26338; number_of_response:1; }","duration":"323.47163ms","start":"2026-07-11T04:21:19.112937Z","end":"2026-07-11T04:21:19.436409Z","steps":["trace[376559732] 'process raft request' (duration: 322.975849ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:19.436566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:19.112918Z","time spent":"323.574673ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:19.436335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.724176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-11T04:21:19.436634Z","caller":"traceutil/trace.go:171","msg":"trace[783132534] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:26338; }","duration":"197.108014ms","start":"2026-07-11T04:21:19.239512Z","end":"2026-07-11T04:21:19.43662Z","steps":["trace[783132534] 'agreement among raft nodes before linearized reading' (duration: 196.697366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:19.436773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.733248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-11T04:21:19.436862Z","caller":"traceutil/trace.go:171","msg":"trace[2040835288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26338; }","duration":"128.880931ms","start":"2026-07-11T04:21:19.30796Z","end":"2026-07-11T04:21:19.436841Z","steps":["trace[2040835288] 'agreement among raft nodes before linearized reading' (duration: 128.542524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:19.605243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.073924ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-11T04:21:19.605456Z","caller":"traceutil/trace.go:171","msg":"trace[1819832109] transaction","detail":"{read_only:false; response_revision:26339; number_of_response:1; }","duration":"164.276197ms","start":"2026-07-11T04:21:19.441158Z","end":"2026-07-11T04:21:19.605434Z","steps":["trace[1819832109] 'process raft request' (duration: 24.879055ms)","trace[1819832109] 'compare' (duration: 138.847269ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:19.6059Z","caller":"traceutil/trace.go:171","msg":"trace[1059096011] transaction","detail":"{read_only:false; response_revision:26342; number_of_response:1; }","duration":"163.439219ms","start":"2026-07-11T04:21:19.442422Z","end":"2026-07-11T04:21:19.605861Z","steps":["trace[1059096011] 'process raft request' (duration: 163.387238ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:19.60593Z","caller":"traceutil/trace.go:171","msg":"trace[279484178] transaction","detail":"{read_only:false; response_revision:26340; number_of_response:1; }","duration":"164.306347ms","start":"2026-07-11T04:21:19.441588Z","end":"2026-07-11T04:21:19.605895Z","steps":["trace[279484178] 'process raft request' (duration: 163.783606ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:19.606032Z","caller":"traceutil/trace.go:171","msg":"trace[1835965265] transaction","detail":"{read_only:false; response_revision:26341; number_of_response:1; }","duration":"164.153354ms","start":"2026-07-11T04:21:19.441866Z","end":"2026-07-11T04:21:19.606019Z","steps":["trace[1835965265] 'process raft request' (duration: 163.832487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:19.884685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.235565ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-11T04:21:19.884799Z","caller":"traceutil/trace.go:171","msg":"trace[1394193591] transaction","detail":"{read_only:false; response_revision:26343; number_of_response:1; }","duration":"245.524683ms","start":"2026-07-11T04:21:19.639253Z","end":"2026-07-11T04:21:19.884778Z","steps":["trace[1394193591] 'process raft request' (duration: 107.086783ms)","trace[1394193591] 'compare' (duration: 138.083302ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:19.885565Z","caller":"traceutil/trace.go:171","msg":"trace[489402261] linearizableReadLoop","detail":"{readStateIndex:27213; appliedIndex:27211; }","duration":"221.520689ms","start":"2026-07-11T04:21:19.664009Z","end":"2026-07-11T04:21:19.88553Z","steps":["trace[489402261] 'read index received' (duration: 82.346023ms)","trace[489402261] 'applied index is now lower than readState.Index' (duration: 139.173396ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:19.885785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.729133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectrealms/\" range_end:\"/registry/ceph.rook.io/cephobjectrealms0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:19.88582Z","caller":"traceutil/trace.go:171","msg":"trace[1565879652] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectrealms/; range_end:/registry/ceph.rook.io/cephobjectrealms0; response_count:0; response_revision:26344; }","duration":"221.808205ms","start":"2026-07-11T04:21:19.664001Z","end":"2026-07-11T04:21:19.885809Z","steps":["trace[1565879652] 'agreement among raft nodes before linearized reading' (duration: 221.642662ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:19.886157Z","caller":"traceutil/trace.go:171","msg":"trace[1111162335] transaction","detail":"{read_only:false; response_revision:26344; number_of_response:1; }","duration":"238.646973ms","start":"2026-07-11T04:21:19.6475Z","end":"2026-07-11T04:21:19.886147Z","steps":["trace[1111162335] 'process raft request' (duration: 237.863487ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:20.65945Z","caller":"traceutil/trace.go:171","msg":"trace[1605592699] linearizableReadLoop","detail":"{readStateIndex:27218; appliedIndex:27216; }","duration":"109.211341ms","start":"2026-07-11T04:21:20.550214Z","end":"2026-07-11T04:21:20.659426Z","steps":["trace[1605592699] 'read index received' (duration: 108.935935ms)","trace[1605592699] 'applied index is now lower than readState.Index' (duration: 274.686µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:20.659708Z","caller":"traceutil/trace.go:171","msg":"trace[1864881068] transaction","detail":"{read_only:false; response_revision:26348; number_of_response:1; }","duration":"219.830883ms","start":"2026-07-11T04:21:20.439855Z","end":"2026-07-11T04:21:20.659686Z","steps":["trace[1864881068] 'process raft request' (duration: 219.364753ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:20.659731Z","caller":"traceutil/trace.go:171","msg":"trace[289567135] transaction","detail":"{read_only:false; response_revision:26349; number_of_response:1; }","duration":"216.490919ms","start":"2026-07-11T04:21:20.44321Z","end":"2026-07-11T04:21:20.659701Z","steps":["trace[289567135] 'process raft request' (duration: 216.162432ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:20.659769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.371654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusters/\" range_end:\"/registry/cluster.x-k8s.io/clusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:20.659835Z","caller":"traceutil/trace.go:171","msg":"trace[82037172] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusters/; range_end:/registry/cluster.x-k8s.io/clusters0; response_count:0; response_revision:26349; }","duration":"109.6659ms","start":"2026-07-11T04:21:20.550149Z","end":"2026-07-11T04:21:20.659815Z","steps":["trace[82037172] 'agreement among raft nodes before linearized reading' (duration: 109.378354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:20.940542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.430513ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-07-11T04:21:20.940786Z","caller":"traceutil/trace.go:171","msg":"trace[344850403] linearizableReadLoop","detail":"{readStateIndex:27219; appliedIndex:27218; }","duration":"218.139165ms","start":"2026-07-11T04:21:20.722623Z","end":"2026-07-11T04:21:20.940763Z","steps":["trace[344850403] 'read index received' (duration: 3.415695ms)","trace[344850403] 'applied index is now lower than readState.Index' (duration: 214.72232ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:20.941417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.784109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-11T04:21:20.941467Z","caller":"traceutil/trace.go:171","msg":"trace[1082157089] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:26349; }","duration":"218.881311ms","start":"2026-07-11T04:21:20.722573Z","end":"2026-07-11T04:21:20.941454Z","steps":["trace[1082157089] 'agreement among raft nodes before linearized reading' (duration: 218.731547ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:20.942002Z","caller":"traceutil/trace.go:171","msg":"trace[1938974639] transaction","detail":"{read_only:false; response_revision:26350; number_of_response:1; }","duration":"187.004973ms","start":"2026-07-11T04:21:20.754989Z","end":"2026-07-11T04:21:20.941994Z","steps":["trace[1938974639] 'process raft request' (duration: 185.663243ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:21.008133Z","caller":"traceutil/trace.go:171","msg":"trace[1176502124] transaction","detail":"{read_only:false; response_revision:26351; number_of_response:1; }","duration":"250.935493ms","start":"2026-07-11T04:21:20.757173Z","end":"2026-07-11T04:21:21.008108Z","steps":["trace[1176502124] 'process raft request' (duration: 248.930379ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:21.008216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.309957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:21.008273Z","caller":"traceutil/trace.go:171","msg":"trace[773025473] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:26351; }","duration":"106.386959ms","start":"2026-07-11T04:21:20.901869Z","end":"2026-07-11T04:21:21.008256Z","steps":["trace[773025473] 'agreement among raft nodes before linearized reading' (duration: 106.259716ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:27.159837Z","caller":"traceutil/trace.go:171","msg":"trace[2081954709] transaction","detail":"{read_only:false; response_revision:26411; number_of_response:1; }","duration":"135.177468ms","start":"2026-07-11T04:21:27.024496Z","end":"2026-07-11T04:21:27.159674Z","steps":["trace[2081954709] 'process raft request' (duration: 135.043795ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:27.445415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.986004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:27.445488Z","caller":"traceutil/trace.go:171","msg":"trace[1202200290] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:26411; }","duration":"145.092626ms","start":"2026-07-11T04:21:27.300375Z","end":"2026-07-11T04:21:27.445468Z","steps":["trace[1202200290] 'count revisions from in-memory index tree' (duration: 144.888001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:27.44561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.462686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:27.445694Z","caller":"traceutil/trace.go:171","msg":"trace[2069461496] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:26411; }","duration":"157.635201ms","start":"2026-07-11T04:21:27.288041Z","end":"2026-07-11T04:21:27.445676Z","steps":["trace[2069461496] 'count revisions from in-memory index tree' (duration: 157.332624ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:27.605292Z","caller":"traceutil/trace.go:171","msg":"trace[498838437] transaction","detail":"{read_only:false; response_revision:26412; number_of_response:1; }","duration":"136.783684ms","start":"2026-07-11T04:21:27.468488Z","end":"2026-07-11T04:21:27.605271Z","steps":["trace[498838437] 'process raft request' (duration: 136.59108ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:27.770319Z","caller":"traceutil/trace.go:171","msg":"trace[1098953286] linearizableReadLoop","detail":"{readStateIndex:27284; appliedIndex:27283; }","duration":"135.124297ms","start":"2026-07-11T04:21:27.635177Z","end":"2026-07-11T04:21:27.770301Z","steps":["trace[1098953286] 'read index received' (duration: 135.098017ms)","trace[1098953286] 'applied index is now lower than readState.Index' (duration: 25.51µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:27.770407Z","caller":"traceutil/trace.go:171","msg":"trace[1889249338] transaction","detail":"{read_only:false; response_revision:26413; number_of_response:1; }","duration":"255.591514ms","start":"2026-07-11T04:21:27.514808Z","end":"2026-07-11T04:21:27.7704Z","steps":["trace[1889249338] 'process raft request' (duration: 255.37614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:27.770658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.468124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-11T04:21:27.770685Z","caller":"traceutil/trace.go:171","msg":"trace[1357202225] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26413; }","duration":"135.562016ms","start":"2026-07-11T04:21:27.635117Z","end":"2026-07-11T04:21:27.770679Z","steps":["trace[1357202225] 'agreement among raft nodes before linearized reading' (duration: 135.449004ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:27.787051Z","caller":"traceutil/trace.go:171","msg":"trace[729635046] transaction","detail":"{read_only:false; response_revision:26414; number_of_response:1; }","duration":"149.517272ms","start":"2026-07-11T04:21:27.637501Z","end":"2026-07-11T04:21:27.787018Z","steps":["trace[729635046] 'process raft request' (duration: 149.231266ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:27.787353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.631542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-11T04:21:27.787407Z","caller":"traceutil/trace.go:171","msg":"trace[346384508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26414; }","duration":"142.715475ms","start":"2026-07-11T04:21:27.644679Z","end":"2026-07-11T04:21:27.787394Z","steps":["trace[346384508] 'agreement among raft nodes before linearized reading' (duration: 142.560231ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:27.787457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.924048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-11T04:21:27.787569Z","caller":"traceutil/trace.go:171","msg":"trace[1761655104] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26414; }","duration":"143.044501ms","start":"2026-07-11T04:21:27.644498Z","end":"2026-07-11T04:21:27.787542Z","steps":["trace[1761655104] 'agreement among raft nodes before linearized reading' (duration: 142.846186ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:27.787846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.210615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-11T04:21:27.787915Z","caller":"traceutil/trace.go:171","msg":"trace[1722136822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26414; }","duration":"143.91204ms","start":"2026-07-11T04:21:27.643975Z","end":"2026-07-11T04:21:27.787887Z","steps":["trace[1722136822] 'agreement among raft nodes before linearized reading' (duration: 142.98173ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:27.966637Z","caller":"traceutil/trace.go:171","msg":"trace[1838085942] transaction","detail":"{read_only:false; response_revision:26415; number_of_response:1; }","duration":"191.937771ms","start":"2026-07-11T04:21:27.774661Z","end":"2026-07-11T04:21:27.966599Z","steps":["trace[1838085942] 'process raft request' (duration: 164.092532ms)","trace[1838085942] 'compare' (duration: 27.595064ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:28.138667Z","caller":"traceutil/trace.go:171","msg":"trace[1264515515] transaction","detail":"{read_only:false; response_revision:26416; number_of_response:1; }","duration":"346.718759ms","start":"2026-07-11T04:21:27.79191Z","end":"2026-07-11T04:21:28.138629Z","steps":["trace[1264515515] 'process raft request' (duration: 297.102143ms)","trace[1264515515] 'compare' (duration: 49.470413ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:28.138845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:27.791882Z","time spent":"346.858483ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:28.138926Z","caller":"traceutil/trace.go:171","msg":"trace[1540645488] transaction","detail":"{read_only:false; response_revision:26417; number_of_response:1; }","duration":"346.909473ms","start":"2026-07-11T04:21:27.791994Z","end":"2026-07-11T04:21:28.138903Z","steps":["trace[1540645488] 'process raft request' (duration: 346.595756ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:28.139084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:27.791966Z","time spent":"347.030346ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:28.139365Z","caller":"traceutil/trace.go:171","msg":"trace[43219702] transaction","detail":"{read_only:false; response_revision:26418; number_of_response:1; }","duration":"346.484635ms","start":"2026-07-11T04:21:27.792866Z","end":"2026-07-11T04:21:28.13935Z","steps":["trace[43219702] 'process raft request' (duration: 345.937753ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:28.139436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:27.792853Z","time spent":"346.549006ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:28.139521Z","caller":"traceutil/trace.go:171","msg":"trace[891571185] linearizableReadLoop","detail":"{readStateIndex:27291; appliedIndex:27285; }","duration":"207.42541ms","start":"2026-07-11T04:21:27.932082Z","end":"2026-07-11T04:21:28.139507Z","steps":["trace[891571185] 'read index received' (duration: 6.686566ms)","trace[891571185] 'applied index is now lower than readState.Index' (duration: 200.737854ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:28.139477Z","caller":"traceutil/trace.go:171","msg":"trace[914732891] transaction","detail":"{read_only:false; response_revision:26419; number_of_response:1; }","duration":"223.236977ms","start":"2026-07-11T04:21:27.916198Z","end":"2026-07-11T04:21:28.139435Z","steps":["trace[914732891] 'process raft request' (duration: 223.005522ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:28.139608Z","caller":"traceutil/trace.go:171","msg":"trace[143079970] transaction","detail":"{read_only:false; response_revision:26420; number_of_response:1; }","duration":"218.293899ms","start":"2026-07-11T04:21:27.92128Z","end":"2026-07-11T04:21:28.139574Z","steps":["trace[143079970] 'process raft request' (duration: 218.092584ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:28.139654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.567593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:28.139697Z","caller":"traceutil/trace.go:171","msg":"trace[1391005423] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:26420; }","duration":"207.678326ms","start":"2026-07-11T04:21:27.932005Z","end":"2026-07-11T04:21:28.139683Z","steps":["trace[1391005423] 'agreement among raft nodes before linearized reading' (duration: 207.612575ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:28.139987Z","caller":"traceutil/trace.go:171","msg":"trace[130120149] transaction","detail":"{read_only:false; response_revision:26421; number_of_response:1; }","duration":"130.635119ms","start":"2026-07-11T04:21:28.009318Z","end":"2026-07-11T04:21:28.139953Z","steps":["trace[130120149] 'process raft request' (duration: 130.365643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:28.14004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.929926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:28.140195Z","caller":"traceutil/trace.go:171","msg":"trace[1483733269] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:26421; }","duration":"200.158451ms","start":"2026-07-11T04:21:27.94001Z","end":"2026-07-11T04:21:28.140168Z","steps":["trace[1483733269] 'agreement among raft nodes before linearized reading' (duration: 199.865055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:28.140286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.41046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephnfses/\" range_end:\"/registry/ceph.rook.io/cephnfses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:28.140367Z","caller":"traceutil/trace.go:171","msg":"trace[610546701] range","detail":"{range_begin:/registry/ceph.rook.io/cephnfses/; range_end:/registry/ceph.rook.io/cephnfses0; response_count:0; response_revision:26421; }","duration":"117.556473ms","start":"2026-07-11T04:21:28.022787Z","end":"2026-07-11T04:21:28.140343Z","steps":["trace[610546701] 'agreement among raft nodes before linearized reading' (duration: 117.382609ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:28.569927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.512024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"warn","ts":"2026-07-11T04:21:28.569894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.055882ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:28.569993Z","caller":"traceutil/trace.go:171","msg":"trace[4862126] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:26421; }","duration":"229.662297ms","start":"2026-07-11T04:21:28.340317Z","end":"2026-07-11T04:21:28.569979Z","steps":["trace[4862126] 'count revisions from in-memory index tree' (duration: 229.367811ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:28.570012Z","caller":"traceutil/trace.go:171","msg":"trace[932358181] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:26421; }","duration":"159.191564ms","start":"2026-07-11T04:21:28.410802Z","end":"2026-07-11T04:21:28.569994Z","steps":["trace[932358181] 'range keys from in-memory index tree' (duration: 159.036251ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:28.793746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.112537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-07-11T04:21:28.793837Z","caller":"traceutil/trace.go:171","msg":"trace[1040409585] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26422; }","duration":"124.299092ms","start":"2026-07-11T04:21:28.669514Z","end":"2026-07-11T04:21:28.793813Z","steps":["trace[1040409585] 'range keys from in-memory index tree' (duration: 123.792599ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:28.7941Z","caller":"traceutil/trace.go:171","msg":"trace[623855919] transaction","detail":"{read_only:false; response_revision:26423; number_of_response:1; }","duration":"106.226695ms","start":"2026-07-11T04:21:28.687841Z","end":"2026-07-11T04:21:28.794068Z","steps":["trace[623855919] 'process raft request' (duration: 79.849527ms)","trace[623855919] 'compare' (duration: 25.850746ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:29.05603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.271294ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-11T04:21:29.056192Z","caller":"traceutil/trace.go:171","msg":"trace[1700217634] transaction","detail":"{read_only:false; response_revision:26424; number_of_response:1; }","duration":"368.263381ms","start":"2026-07-11T04:21:28.687898Z","end":"2026-07-11T04:21:29.056161Z","steps":["trace[1700217634] 'process raft request' (duration: 262.722551ms)","trace[1700217634] 'compare' (duration: 105.118531ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:29.056268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:28.687872Z","time spent":"368.362042ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:29.661988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.800053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:29.662118Z","caller":"traceutil/trace.go:171","msg":"trace[1283627853] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:26426; }","duration":"321.982358ms","start":"2026-07-11T04:21:29.340109Z","end":"2026-07-11T04:21:29.662091Z","steps":["trace[1283627853] 'count revisions from in-memory index tree' (duration: 321.723682ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:29.66217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:29.340091Z","time spent":"322.06873ms","remote":"127.0.0.1:48400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":30,"request content":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true "} {"level":"warn","ts":"2026-07-11T04:21:29.662042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.884338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:29.662314Z","caller":"traceutil/trace.go:171","msg":"trace[1093645316] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26426; }","duration":"302.201725ms","start":"2026-07-11T04:21:29.360087Z","end":"2026-07-11T04:21:29.662289Z","steps":["trace[1093645316] 'range keys from in-memory index tree' (duration: 301.768434ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:29.662386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:29.360068Z","time spent":"302.291677ms","remote":"127.0.0.1:49002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-11T04:21:29.787641Z","caller":"traceutil/trace.go:171","msg":"trace[374269553] transaction","detail":"{read_only:false; response_revision:26427; number_of_response:1; }","duration":"120.890966ms","start":"2026-07-11T04:21:29.666725Z","end":"2026-07-11T04:21:29.787616Z","steps":["trace[374269553] 'process raft request' (duration: 120.733463ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:36.099673Z","caller":"traceutil/trace.go:171","msg":"trace[1631775833] linearizableReadLoop","detail":"{readStateIndex:27352; appliedIndex:27351; }","duration":"290.228523ms","start":"2026-07-11T04:21:35.809417Z","end":"2026-07-11T04:21:36.099645Z","steps":["trace[1631775833] 'read index received' (duration: 269.506119ms)","trace[1631775833] 'applied index is now lower than readState.Index' (duration: 20.719344ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:36.099682Z","caller":"traceutil/trace.go:171","msg":"trace[760845122] transaction","detail":"{read_only:false; response_revision:26479; number_of_response:1; }","duration":"311.971869ms","start":"2026-07-11T04:21:35.787678Z","end":"2026-07-11T04:21:36.09965Z","steps":["trace[760845122] 'process raft request' (duration: 291.287876ms)","trace[760845122] 'compare' (duration: 20.351795ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:36.099854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:35.787661Z","time spent":"312.101972ms","remote":"127.0.0.1:49050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":119,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:36.100055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.618861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-11T04:21:36.100095Z","caller":"traceutil/trace.go:171","msg":"trace[1879390201] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26479; }","duration":"290.698353ms","start":"2026-07-11T04:21:35.809385Z","end":"2026-07-11T04:21:36.100084Z","steps":["trace[1879390201] 'agreement among raft nodes before linearized reading' (duration: 290.360176ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:36.415966Z","caller":"traceutil/trace.go:171","msg":"trace[760612755] transaction","detail":"{read_only:false; response_revision:26481; number_of_response:1; }","duration":"306.58655ms","start":"2026-07-11T04:21:36.109358Z","end":"2026-07-11T04:21:36.415945Z","steps":["trace[760612755] 'process raft request' (duration: 306.476598ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:36.416018Z","caller":"traceutil/trace.go:171","msg":"trace[98312693] transaction","detail":"{read_only:false; response_revision:26482; number_of_response:1; }","duration":"238.881179ms","start":"2026-07-11T04:21:36.177131Z","end":"2026-07-11T04:21:36.416012Z","steps":["trace[98312693] 'process raft request' (duration: 238.762466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.416097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.109342Z","time spent":"306.687992ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:36.416127Z","caller":"traceutil/trace.go:171","msg":"trace[134322243] linearizableReadLoop","detail":"{readStateIndex:27354; appliedIndex:27352; }","duration":"306.718354ms","start":"2026-07-11T04:21:36.109401Z","end":"2026-07-11T04:21:36.416119Z","steps":["trace[134322243] 'read index received' (duration: 230.373862ms)","trace[134322243] 'applied index is now lower than readState.Index' (duration: 76.343742ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:36.415986Z","caller":"traceutil/trace.go:171","msg":"trace[1056902875] transaction","detail":"{read_only:false; response_revision:26483; number_of_response:1; }","duration":"238.542771ms","start":"2026-07-11T04:21:36.177432Z","end":"2026-07-11T04:21:36.415975Z","steps":["trace[1056902875] 'process raft request' (duration: 238.48813ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:36.41619Z","caller":"traceutil/trace.go:171","msg":"trace[1534323677] transaction","detail":"{read_only:false; response_revision:26480; number_of_response:1; }","duration":"311.138532ms","start":"2026-07-11T04:21:36.105044Z","end":"2026-07-11T04:21:36.416183Z","steps":["trace[1534323677] 'process raft request' (duration: 234.713988ms)","trace[1534323677] 'compare' (duration: 75.85408ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:36.416231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.10502Z","time spent":"311.183772ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:36.416292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.888258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-11T04:21:36.416316Z","caller":"traceutil/trace.go:171","msg":"trace[218541045] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:26484; }","duration":"306.913488ms","start":"2026-07-11T04:21:36.109396Z","end":"2026-07-11T04:21:36.416309Z","steps":["trace[218541045] 'agreement among raft nodes before linearized reading' (duration: 306.803346ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.41634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.109346Z","time spent":"306.98903ms","remote":"127.0.0.1:49236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-07-11T04:21:36.416409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.243156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-07-11T04:21:36.41643Z","caller":"traceutil/trace.go:171","msg":"trace[529334988] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26484; }","duration":"233.295028ms","start":"2026-07-11T04:21:36.183127Z","end":"2026-07-11T04:21:36.416422Z","steps":["trace[529334988] 'agreement among raft nodes before linearized reading' (duration: 233.235206ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:36.416482Z","caller":"traceutil/trace.go:171","msg":"trace[1848859371] transaction","detail":"{read_only:false; response_revision:26484; number_of_response:1; }","duration":"234.204777ms","start":"2026-07-11T04:21:36.182238Z","end":"2026-07-11T04:21:36.416443Z","steps":["trace[1848859371] 'process raft request' (duration: 233.712096ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.416587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.099986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-11T04:21:36.416612Z","caller":"traceutil/trace.go:171","msg":"trace[2025831260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26484; }","duration":"230.141538ms","start":"2026-07-11T04:21:36.186463Z","end":"2026-07-11T04:21:36.416605Z","steps":["trace[2025831260] 'agreement among raft nodes before linearized reading' (duration: 230.082536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.41674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.571137ms","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-07-11T04:21:36.416757Z","caller":"traceutil/trace.go:171","msg":"trace[1568784495] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26484; }","duration":"230.606118ms","start":"2026-07-11T04:21:36.186146Z","end":"2026-07-11T04:21:36.416752Z","steps":["trace[1568784495] 'agreement among raft nodes before linearized reading' (duration: 230.555987ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.416559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.956743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:36.41686Z","caller":"traceutil/trace.go:171","msg":"trace[1619156398] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:26484; }","duration":"219.274851ms","start":"2026-07-11T04:21:36.197567Z","end":"2026-07-11T04:21:36.416841Z","steps":["trace[1619156398] 'agreement among raft nodes before linearized reading' (duration: 218.966804ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:36.73544Z","caller":"traceutil/trace.go:171","msg":"trace[986371102] transaction","detail":"{read_only:false; response_revision:26485; number_of_response:1; }","duration":"309.567855ms","start":"2026-07-11T04:21:36.425846Z","end":"2026-07-11T04:21:36.735413Z","steps":["trace[986371102] 'process raft request' (duration: 309.163477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.735597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.425816Z","time spent":"309.70396ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:36.749522Z","caller":"traceutil/trace.go:171","msg":"trace[1884806215] linearizableReadLoop","detail":"{readStateIndex:27360; appliedIndex:27357; }","duration":"316.739584ms","start":"2026-07-11T04:21:36.432755Z","end":"2026-07-11T04:21:36.749495Z","steps":["trace[1884806215] 'read index received' (duration: 302.42028ms)","trace[1884806215] 'applied index is now lower than readState.Index' (duration: 14.318454ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:36.74966Z","caller":"traceutil/trace.go:171","msg":"trace[1223373573] transaction","detail":"{read_only:false; response_revision:26487; number_of_response:1; }","duration":"323.258336ms","start":"2026-07-11T04:21:36.426392Z","end":"2026-07-11T04:21:36.74965Z","steps":["trace[1223373573] 'process raft request' (duration: 323.0221ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:36.749675Z","caller":"traceutil/trace.go:171","msg":"trace[519172923] transaction","detail":"{read_only:false; response_revision:26486; number_of_response:1; }","duration":"323.678935ms","start":"2026-07-11T04:21:36.425957Z","end":"2026-07-11T04:21:36.749636Z","steps":["trace[519172923] 'process raft request' (duration: 323.294856ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.749815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.426364Z","time spent":"323.326608ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:36.749896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.425852Z","time spent":"323.932961ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:36.749958Z","caller":"traceutil/trace.go:171","msg":"trace[1788927990] transaction","detail":"{read_only:false; response_revision:26488; number_of_response:1; }","duration":"127.341778ms","start":"2026-07-11T04:21:36.622609Z","end":"2026-07-11T04:21:36.74995Z","steps":["trace[1788927990] 'process raft request' (duration: 126.847676ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.750148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.391848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-api-d7df5f7fc-ltvjg\" ","response":"range_response_count:1 size:8857"} {"level":"info","ts":"2026-07-11T04:21:36.750178Z","caller":"traceutil/trace.go:171","msg":"trace[1155911243] range","detail":"{range_begin:/registry/pods/openstack/magnum-api-d7df5f7fc-ltvjg; range_end:; response_count:1; response_revision:26488; }","duration":"317.452779ms","start":"2026-07-11T04:21:36.432717Z","end":"2026-07-11T04:21:36.75017Z","steps":["trace[1155911243] 'agreement among raft nodes before linearized reading' (duration: 317.302776ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.750198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.4327Z","time spent":"317.49444ms","remote":"127.0.0.1:49150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":8881,"request content":"key:\"/registry/pods/openstack/magnum-api-d7df5f7fc-ltvjg\" "} {"level":"warn","ts":"2026-07-11T04:21:36.750235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.132036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/magnum-api-d7df5f7fc-ltvjg.18c1216a2be78f4b\" ","response":"range_response_count:1 size:887"} {"level":"info","ts":"2026-07-11T04:21:36.750295Z","caller":"traceutil/trace.go:171","msg":"trace[540053852] range","detail":"{range_begin:/registry/events/openstack/magnum-api-d7df5f7fc-ltvjg.18c1216a2be78f4b; range_end:; response_count:1; response_revision:26488; }","duration":"314.221858ms","start":"2026-07-11T04:21:36.43606Z","end":"2026-07-11T04:21:36.750281Z","steps":["trace[540053852] 'agreement among raft nodes before linearized reading' (duration: 314.029094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:36.750334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.436047Z","time spent":"314.278379ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":911,"request content":"key:\"/registry/events/openstack/magnum-api-d7df5f7fc-ltvjg.18c1216a2be78f4b\" "} {"level":"info","ts":"2026-07-11T04:21:37.123801Z","caller":"traceutil/trace.go:171","msg":"trace[2039802048] transaction","detail":"{read_only:false; response_revision:26489; number_of_response:1; }","duration":"364.728763ms","start":"2026-07-11T04:21:36.75904Z","end":"2026-07-11T04:21:37.123769Z","steps":["trace[2039802048] 'process raft request' (duration: 301.671204ms)","trace[2039802048] 'compare' (duration: 62.908776ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:37.123971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.759017Z","time spent":"364.873356ms","remote":"127.0.0.1:49150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8880,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:37.173697Z","caller":"traceutil/trace.go:171","msg":"trace[1827963621] transaction","detail":"{read_only:false; response_revision:26490; number_of_response:1; }","duration":"412.763695ms","start":"2026-07-11T04:21:36.760898Z","end":"2026-07-11T04:21:37.173661Z","steps":["trace[1827963621] 'process raft request' (duration: 412.510199ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:37.173875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.76088Z","time spent":"412.905777ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":869,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:37.173872Z","caller":"traceutil/trace.go:171","msg":"trace[10840000] transaction","detail":"{read_only:false; response_revision:26491; number_of_response:1; }","duration":"339.022561ms","start":"2026-07-11T04:21:36.834816Z","end":"2026-07-11T04:21:37.173839Z","steps":["trace[10840000] 'process raft request' (duration: 338.759775ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:37.174094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:36.834795Z","time spent":"339.165644ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:37.493585Z","caller":"traceutil/trace.go:171","msg":"trace[1829320146] transaction","detail":"{read_only:false; response_revision:26492; number_of_response:1; }","duration":"407.996961ms","start":"2026-07-11T04:21:37.085564Z","end":"2026-07-11T04:21:37.493561Z","steps":["trace[1829320146] 'process raft request' (duration: 388.077855ms)","trace[1829320146] 'compare' (duration: 19.18458ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:37.493765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:37.085519Z","time spent":"408.136374ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:37.493953Z","caller":"traceutil/trace.go:171","msg":"trace[1901640222] linearizableReadLoop","detail":"{readStateIndex:27367; appliedIndex:27363; }","duration":"363.424695ms","start":"2026-07-11T04:21:37.130503Z","end":"2026-07-11T04:21:37.493928Z","steps":["trace[1901640222] 'read index received' (duration: 42.892509ms)","trace[1901640222] 'applied index is now lower than readState.Index' (duration: 320.530996ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:37.494168Z","caller":"traceutil/trace.go:171","msg":"trace[197946644] transaction","detail":"{read_only:false; response_revision:26493; number_of_response:1; }","duration":"407.155442ms","start":"2026-07-11T04:21:37.087001Z","end":"2026-07-11T04:21:37.494157Z","steps":["trace[197946644] 'process raft request' (duration: 406.507458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:37.494273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:37.086972Z","time spent":"407.224623ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:37.494301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.789132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:37.494363Z","caller":"traceutil/trace.go:171","msg":"trace[1451913487] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:26493; }","duration":"363.879034ms","start":"2026-07-11T04:21:37.130466Z","end":"2026-07-11T04:21:37.494345Z","steps":["trace[1451913487] 'agreement among raft nodes before linearized reading' (duration: 363.791062ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:37.494398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:37.13045Z","time spent":"363.937856ms","remote":"127.0.0.1:60324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true "} {"level":"info","ts":"2026-07-11T04:21:37.494714Z","caller":"traceutil/trace.go:171","msg":"trace[1483839930] transaction","detail":"{read_only:false; response_revision:26494; number_of_response:1; }","duration":"286.946511ms","start":"2026-07-11T04:21:37.207747Z","end":"2026-07-11T04:21:37.494694Z","steps":["trace[1483839930] 'process raft request' (duration: 286.704705ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:37.494825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.46395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/magnum-api-d7df5f7fc-ltvjg.18c1216a3014db08\" ","response":"range_response_count:1 size:748"} {"level":"info","ts":"2026-07-11T04:21:37.49491Z","caller":"traceutil/trace.go:171","msg":"trace[654154817] range","detail":"{range_begin:/registry/events/openstack/magnum-api-d7df5f7fc-ltvjg.18c1216a3014db08; range_end:; response_count:1; response_revision:26494; }","duration":"312.598443ms","start":"2026-07-11T04:21:37.182289Z","end":"2026-07-11T04:21:37.494887Z","steps":["trace[654154817] 'agreement among raft nodes before linearized reading' (duration: 312.326936ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:37.494965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:37.18227Z","time spent":"312.678135ms","remote":"127.0.0.1:49074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":772,"request content":"key:\"/registry/events/openstack/magnum-api-d7df5f7fc-ltvjg.18c1216a3014db08\" "} {"level":"info","ts":"2026-07-11T04:21:37.604954Z","caller":"traceutil/trace.go:171","msg":"trace[968661287] transaction","detail":"{read_only:false; response_revision:26495; number_of_response:1; }","duration":"107.111944ms","start":"2026-07-11T04:21:37.497821Z","end":"2026-07-11T04:21:37.604933Z","steps":["trace[968661287] 'process raft request' (duration: 106.9511ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:42.570937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.379661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-11T04:21:42.571005Z","caller":"traceutil/trace.go:171","msg":"trace[285941566] transaction","detail":"{read_only:false; response_revision:26585; number_of_response:1; }","duration":"129.142578ms","start":"2026-07-11T04:21:42.441825Z","end":"2026-07-11T04:21:42.570967Z","steps":["trace[285941566] 'process raft request' (duration: 128.82645ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:42.57104Z","caller":"traceutil/trace.go:171","msg":"trace[1152597884] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26586; }","duration":"134.545635ms","start":"2026-07-11T04:21:42.436476Z","end":"2026-07-11T04:21:42.571021Z","steps":["trace[1152597884] 'agreement among raft nodes before linearized reading' (duration: 134.294979ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:42.57156Z","caller":"traceutil/trace.go:171","msg":"trace[1870040379] transaction","detail":"{read_only:false; response_revision:26583; number_of_response:1; }","duration":"134.721938ms","start":"2026-07-11T04:21:42.436747Z","end":"2026-07-11T04:21:42.571468Z","steps":["trace[1870040379] 'process raft request' (duration: 133.722516ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:42.57176Z","caller":"traceutil/trace.go:171","msg":"trace[1541663826] transaction","detail":"{read_only:false; response_revision:26584; number_of_response:1; }","duration":"133.39756ms","start":"2026-07-11T04:21:42.43835Z","end":"2026-07-11T04:21:42.571748Z","steps":["trace[1541663826] 'process raft request' (duration: 132.254355ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:42.572452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.542586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-11T04:21:42.57249Z","caller":"traceutil/trace.go:171","msg":"trace[1203132259] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26586; }","duration":"135.604628ms","start":"2026-07-11T04:21:42.436873Z","end":"2026-07-11T04:21:42.572478Z","steps":["trace[1203132259] 'agreement among raft nodes before linearized reading' (duration: 135.455435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:42.809588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.786804ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-11T04:21:42.809769Z","caller":"traceutil/trace.go:171","msg":"trace[1258818499] transaction","detail":"{read_only:false; response_revision:26589; number_of_response:1; }","duration":"229.3116ms","start":"2026-07-11T04:21:42.580444Z","end":"2026-07-11T04:21:42.809755Z","steps":["trace[1258818499] 'process raft request' (duration: 229.282909ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:42.809746Z","caller":"traceutil/trace.go:171","msg":"trace[1931740302] transaction","detail":"{read_only:false; response_revision:26587; number_of_response:1; }","duration":"273.139089ms","start":"2026-07-11T04:21:42.536532Z","end":"2026-07-11T04:21:42.809671Z","steps":["trace[1931740302] 'process raft request' (duration: 131.203972ms)","trace[1931740302] 'compare' (duration: 141.700922ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:42.809854Z","caller":"traceutil/trace.go:171","msg":"trace[1947694981] transaction","detail":"{read_only:false; response_revision:26588; number_of_response:1; }","duration":"231.656131ms","start":"2026-07-11T04:21:42.578142Z","end":"2026-07-11T04:21:42.809798Z","steps":["trace[1947694981] 'process raft request' (duration: 231.521798ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:42.809865Z","caller":"traceutil/trace.go:171","msg":"trace[199378456] linearizableReadLoop","detail":"{readStateIndex:27462; appliedIndex:27461; }","duration":"232.933348ms","start":"2026-07-11T04:21:42.576831Z","end":"2026-07-11T04:21:42.809765Z","steps":["trace[199378456] 'read index received' (duration: 90.92406ms)","trace[199378456] 'applied index is now lower than readState.Index' (duration: 141.998568ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:42.809962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.132422ms","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:6"} {"level":"info","ts":"2026-07-11T04:21:42.810167Z","caller":"traceutil/trace.go:171","msg":"trace[133737858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:26589; }","duration":"233.356127ms","start":"2026-07-11T04:21:42.576781Z","end":"2026-07-11T04:21:42.810137Z","steps":["trace[133737858] 'agreement among raft nodes before linearized reading' (duration: 233.151373ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:42.938448Z","caller":"traceutil/trace.go:171","msg":"trace[1172326949] transaction","detail":"{read_only:false; response_revision:26590; number_of_response:1; }","duration":"170.175065ms","start":"2026-07-11T04:21:42.768227Z","end":"2026-07-11T04:21:42.938402Z","steps":["trace[1172326949] 'process raft request' (duration: 169.894629ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:43.136325Z","caller":"traceutil/trace.go:171","msg":"trace[833806000] linearizableReadLoop","detail":"{readStateIndex:27467; appliedIndex:27464; }","duration":"326.275381ms","start":"2026-07-11T04:21:42.810026Z","end":"2026-07-11T04:21:43.136301Z","steps":["trace[833806000] 'read index received' (duration: 127.999442ms)","trace[833806000] 'applied index is now lower than readState.Index' (duration: 198.274929ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:43.136391Z","caller":"traceutil/trace.go:171","msg":"trace[1192998168] transaction","detail":"{read_only:false; response_revision:26591; number_of_response:1; }","duration":"339.676575ms","start":"2026-07-11T04:21:42.796641Z","end":"2026-07-11T04:21:43.136318Z","steps":["trace[1192998168] 'process raft request' (duration: 280.691704ms)","trace[1192998168] 'compare' (duration: 58.750436ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:21:43.136471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.96104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-07-11T04:21:43.13648Z","caller":"traceutil/trace.go:171","msg":"trace[1967807913] transaction","detail":"{read_only:false; response_revision:26592; number_of_response:1; }","duration":"337.362905ms","start":"2026-07-11T04:21:42.799088Z","end":"2026-07-11T04:21:43.13645Z","steps":["trace[1967807913] 'process raft request' (duration: 337.14361ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:43.1365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.940155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-11T04:21:43.136558Z","caller":"traceutil/trace.go:171","msg":"trace[1825450863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26592; }","duration":"364.037628ms","start":"2026-07-11T04:21:42.772507Z","end":"2026-07-11T04:21:43.136545Z","steps":["trace[1825450863] 'agreement among raft nodes before linearized reading' (duration: 363.826253ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:43.136588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:42.772495Z","time spent":"364.086318ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-11T04:21:43.136591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:42.799075Z","time spent":"337.457506ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:43.136587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:42.796627Z","time spent":"339.857429ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:43.136618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.659084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3d8ec6e0-a370-4168-a2cd-ee43d71a550e\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-07-11T04:21:43.136663Z","caller":"traceutil/trace.go:171","msg":"trace[1000339923] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3d8ec6e0-a370-4168-a2cd-ee43d71a550e; range_end:; response_count:1; response_revision:26592; }","duration":"116.722506ms","start":"2026-07-11T04:21:43.019927Z","end":"2026-07-11T04:21:43.136649Z","steps":["trace[1000339923] 'agreement among raft nodes before linearized reading' (duration: 116.538151ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:43.136506Z","caller":"traceutil/trace.go:171","msg":"trace[1391063932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26592; }","duration":"376.040141ms","start":"2026-07-11T04:21:42.760458Z","end":"2026-07-11T04:21:43.136499Z","steps":["trace[1391063932] 'agreement among raft nodes before linearized reading' (duration: 375.888437ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:43.136592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.563218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-11T04:21:43.136727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:42.760424Z","time spent":"376.293667ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-11T04:21:43.136748Z","caller":"traceutil/trace.go:171","msg":"trace[1579540224] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:26592; }","duration":"559.763883ms","start":"2026-07-11T04:21:42.576972Z","end":"2026-07-11T04:21:43.136736Z","steps":["trace[1579540224] 'agreement among raft nodes before linearized reading' (duration: 559.486216ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:43.136769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.826941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1822"} {"level":"warn","ts":"2026-07-11T04:21:43.136806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:42.576965Z","time spent":"559.829314ms","remote":"127.0.0.1:49188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":30,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-07-11T04:21:43.136765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.673701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-11T04:21:43.136819Z","caller":"traceutil/trace.go:171","msg":"trace[277558946] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:26592; }","duration":"536.905272ms","start":"2026-07-11T04:21:42.599895Z","end":"2026-07-11T04:21:43.1368Z","steps":["trace[277558946] 'agreement among raft nodes before linearized reading' (duration: 536.750489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:43.136872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:42.599876Z","time spent":"536.987675ms","remote":"127.0.0.1:49092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1846,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-07-11T04:21:43.136884Z","caller":"traceutil/trace.go:171","msg":"trace[744957735] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26592; }","duration":"363.857714ms","start":"2026-07-11T04:21:42.772995Z","end":"2026-07-11T04:21:43.136853Z","steps":["trace[744957735] 'agreement among raft nodes before linearized reading' (duration: 363.451545ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:43.136963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:42.772985Z","time spent":"363.963786ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-11T04:21:45.501977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.03666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:45.502032Z","caller":"traceutil/trace.go:171","msg":"trace[678418344] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26620; }","duration":"142.132671ms","start":"2026-07-11T04:21:45.359886Z","end":"2026-07-11T04:21:45.502019Z","steps":["trace[678418344] 'range keys from in-memory index tree' (duration: 141.963728ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:50.477291Z","caller":"traceutil/trace.go:171","msg":"trace[1042172139] linearizableReadLoop","detail":"{readStateIndex:27547; appliedIndex:27546; }","duration":"117.768218ms","start":"2026-07-11T04:21:50.359501Z","end":"2026-07-11T04:21:50.477269Z","steps":["trace[1042172139] 'read index received' (duration: 117.559574ms)","trace[1042172139] 'applied index is now lower than readState.Index' (duration: 207.754µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:50.477411Z","caller":"traceutil/trace.go:171","msg":"trace[1671786473] transaction","detail":"{read_only:false; response_revision:26671; number_of_response:1; }","duration":"133.449621ms","start":"2026-07-11T04:21:50.343949Z","end":"2026-07-11T04:21:50.477399Z","steps":["trace[1671786473] 'process raft request' (duration: 133.162975ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:50.477593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.077515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:50.477636Z","caller":"traceutil/trace.go:171","msg":"trace[2040301574] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26671; }","duration":"118.179957ms","start":"2026-07-11T04:21:50.359447Z","end":"2026-07-11T04:21:50.477626Z","steps":["trace[2040301574] 'agreement among raft nodes before linearized reading' (duration: 118.090485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:50.817821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.397768ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-07-11T04:21:50.818149Z","caller":"traceutil/trace.go:171","msg":"trace[1100985825] transaction","detail":"{read_only:false; response_revision:26673; number_of_response:1; }","duration":"331.893236ms","start":"2026-07-11T04:21:50.486225Z","end":"2026-07-11T04:21:50.818119Z","steps":["trace[1100985825] 'process raft request' (duration: 162.047397ms)","trace[1100985825] 'compare' (duration: 169.02014ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:50.818194Z","caller":"traceutil/trace.go:171","msg":"trace[1791300343] transaction","detail":"{read_only:false; response_revision:26675; number_of_response:1; }","duration":"330.679359ms","start":"2026-07-11T04:21:50.487494Z","end":"2026-07-11T04:21:50.818173Z","steps":["trace[1791300343] 'process raft request' (duration: 330.594147ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:50.818216Z","caller":"traceutil/trace.go:171","msg":"trace[1573238164] transaction","detail":"{read_only:false; response_revision:26674; number_of_response:1; }","duration":"331.67475ms","start":"2026-07-11T04:21:50.486517Z","end":"2026-07-11T04:21:50.818192Z","steps":["trace[1573238164] 'process raft request' (duration: 331.434234ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:50.818326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:50.487483Z","time spent":"330.75466ms","remote":"127.0.0.1:49140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":940,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:50.818358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:50.486508Z","time spent":"331.785383ms","remote":"127.0.0.1:49140","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":884,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:50.818333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:50.486204Z","time spent":"332.019618ms","remote":"127.0.0.1:49236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1489,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:50.902118Z","caller":"traceutil/trace.go:171","msg":"trace[1730807572] transaction","detail":"{read_only:false; response_revision:26676; number_of_response:1; }","duration":"339.372929ms","start":"2026-07-11T04:21:50.562711Z","end":"2026-07-11T04:21:50.902084Z","steps":["trace[1730807572] 'process raft request' (duration: 339.059672ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:50.902326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:50.562686Z","time spent":"339.534633ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-11T04:21:50.902363Z","caller":"traceutil/trace.go:171","msg":"trace[286875416] linearizableReadLoop","detail":"{readStateIndex:27555; appliedIndex:27551; }","duration":"248.953049ms","start":"2026-07-11T04:21:50.653397Z","end":"2026-07-11T04:21:50.90235Z","steps":["trace[286875416] 'read index received' (duration: 248.209112ms)","trace[286875416] 'applied index is now lower than readState.Index' (duration: 743.477µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:50.902442Z","caller":"traceutil/trace.go:171","msg":"trace[1374631759] transaction","detail":"{read_only:false; response_revision:26678; number_of_response:1; }","duration":"298.662188ms","start":"2026-07-11T04:21:50.603772Z","end":"2026-07-11T04:21:50.902434Z","steps":["trace[1374631759] 'process raft request' (duration: 298.459944ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:50.902419Z","caller":"traceutil/trace.go:171","msg":"trace[215938536] transaction","detail":"{read_only:false; response_revision:26677; number_of_response:1; }","duration":"299.859254ms","start":"2026-07-11T04:21:50.602523Z","end":"2026-07-11T04:21:50.902382Z","steps":["trace[215938536] 'process raft request' (duration: 299.480035ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:50.902532Z","caller":"traceutil/trace.go:171","msg":"trace[61051226] transaction","detail":"{read_only:false; response_revision:26679; number_of_response:1; }","duration":"259.585592ms","start":"2026-07-11T04:21:50.642941Z","end":"2026-07-11T04:21:50.902527Z","steps":["trace[61051226] 'process raft request' (duration: 259.370147ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:50.902612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-11T04:21:50.602507Z","time spent":"300.011647ms","remote":"127.0.0.1:49220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-11T04:21:50.902757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.353169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:50.902784Z","caller":"traceutil/trace.go:171","msg":"trace[247624634] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:26679; }","duration":"249.430189ms","start":"2026-07-11T04:21:50.653347Z","end":"2026-07-11T04:21:50.902777Z","steps":["trace[247624634] 'agreement among raft nodes before linearized reading' (duration: 249.380468ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:51.013289Z","caller":"traceutil/trace.go:171","msg":"trace[525675845] transaction","detail":"{read_only:false; response_revision:26681; number_of_response:1; }","duration":"105.002548ms","start":"2026-07-11T04:21:50.908186Z","end":"2026-07-11T04:21:51.013189Z","steps":["trace[525675845] 'process raft request' (duration: 102.224707ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:57.060003Z","caller":"traceutil/trace.go:171","msg":"trace[783614406] transaction","detail":"{read_only:false; response_revision:26735; number_of_response:1; }","duration":"130.871015ms","start":"2026-07-11T04:21:56.929107Z","end":"2026-07-11T04:21:57.059978Z","steps":["trace[783614406] 'process raft request' (duration: 130.580469ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:57.085567Z","caller":"traceutil/trace.go:171","msg":"trace[161278478] transaction","detail":"{read_only:false; response_revision:26737; number_of_response:1; }","duration":"156.20373ms","start":"2026-07-11T04:21:56.92934Z","end":"2026-07-11T04:21:57.085544Z","steps":["trace[161278478] 'process raft request' (duration: 156.117068ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:57.085828Z","caller":"traceutil/trace.go:171","msg":"trace[1307693963] linearizableReadLoop","detail":"{readStateIndex:27615; appliedIndex:27612; }","duration":"151.189759ms","start":"2026-07-11T04:21:56.934615Z","end":"2026-07-11T04:21:57.085805Z","steps":["trace[1307693963] 'read index received' (duration: 125.104059ms)","trace[1307693963] 'applied index is now lower than readState.Index' (duration: 26.08459ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:57.085935Z","caller":"traceutil/trace.go:171","msg":"trace[157516183] transaction","detail":"{read_only:false; response_revision:26736; number_of_response:1; }","duration":"156.69858ms","start":"2026-07-11T04:21:56.929229Z","end":"2026-07-11T04:21:57.085927Z","steps":["trace[157516183] 'process raft request' (duration: 156.109877ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:57.086245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.610678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-11T04:21:57.086274Z","caller":"traceutil/trace.go:171","msg":"trace[1447289109] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26738; }","duration":"151.67974ms","start":"2026-07-11T04:21:56.934586Z","end":"2026-07-11T04:21:57.086265Z","steps":["trace[1447289109] 'agreement among raft nodes before linearized reading' (duration: 151.554368ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:57.279307Z","caller":"traceutil/trace.go:171","msg":"trace[1169402496] transaction","detail":"{read_only:false; response_revision:26739; number_of_response:1; }","duration":"185.270955ms","start":"2026-07-11T04:21:57.094013Z","end":"2026-07-11T04:21:57.279284Z","steps":["trace[1169402496] 'process raft request' (duration: 184.622251ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:57.27958Z","caller":"traceutil/trace.go:171","msg":"trace[1603656621] transaction","detail":"{read_only:false; response_revision:26740; number_of_response:1; }","duration":"185.51705ms","start":"2026-07-11T04:21:57.094048Z","end":"2026-07-11T04:21:57.279565Z","steps":["trace[1603656621] 'process raft request' (duration: 184.742224ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:59.167003Z","caller":"traceutil/trace.go:171","msg":"trace[86028946] linearizableReadLoop","detail":"{readStateIndex:27633; appliedIndex:27632; }","duration":"112.699306ms","start":"2026-07-11T04:21:59.054278Z","end":"2026-07-11T04:21:59.166978Z","steps":["trace[86028946] 'read index received' (duration: 112.611104ms)","trace[86028946] 'applied index is now lower than readState.Index' (duration: 86.642µs)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:59.167122Z","caller":"traceutil/trace.go:171","msg":"trace[1771677232] transaction","detail":"{read_only:false; response_revision:26755; number_of_response:1; }","duration":"113.116236ms","start":"2026-07-11T04:21:59.053968Z","end":"2026-07-11T04:21:59.167084Z","steps":["trace[1771677232] 'process raft request' (duration: 112.81971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:59.167288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.989663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:1448"} {"level":"info","ts":"2026-07-11T04:21:59.167366Z","caller":"traceutil/trace.go:171","msg":"trace[1868590960] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26755; }","duration":"113.101085ms","start":"2026-07-11T04:21:59.054251Z","end":"2026-07-11T04:21:59.167352Z","steps":["trace[1868590960] 'agreement among raft nodes before linearized reading' (duration: 112.86737ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:59.283286Z","caller":"traceutil/trace.go:171","msg":"trace[1691349322] transaction","detail":"{read_only:false; response_revision:26756; number_of_response:1; }","duration":"218.326419ms","start":"2026-07-11T04:21:59.064942Z","end":"2026-07-11T04:21:59.283269Z","steps":["trace[1691349322] 'process raft request' (duration: 158.141952ms)","trace[1691349322] 'compare' (duration: 60.070615ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:59.283544Z","caller":"traceutil/trace.go:171","msg":"trace[2023811501] transaction","detail":"{read_only:false; response_revision:26757; number_of_response:1; }","duration":"191.87254ms","start":"2026-07-11T04:21:59.09165Z","end":"2026-07-11T04:21:59.283523Z","steps":["trace[2023811501] 'process raft request' (duration: 191.592594ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:59.283614Z","caller":"traceutil/trace.go:171","msg":"trace[408107189] transaction","detail":"{read_only:false; response_revision:26759; number_of_response:1; }","duration":"191.018861ms","start":"2026-07-11T04:21:59.092586Z","end":"2026-07-11T04:21:59.283604Z","steps":["trace[408107189] 'process raft request' (duration: 190.94402ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:59.283599Z","caller":"traceutil/trace.go:171","msg":"trace[851992699] linearizableReadLoop","detail":"{readStateIndex:27637; appliedIndex:27633; }","duration":"116.49314ms","start":"2026-07-11T04:21:59.167084Z","end":"2026-07-11T04:21:59.283577Z","steps":["trace[851992699] 'read index received' (duration: 55.943325ms)","trace[851992699] 'applied index is now lower than readState.Index' (duration: 60.548905ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:21:59.283625Z","caller":"traceutil/trace.go:171","msg":"trace[1592339266] transaction","detail":"{read_only:false; response_revision:26758; number_of_response:1; }","duration":"191.847729ms","start":"2026-07-11T04:21:59.091745Z","end":"2026-07-11T04:21:59.283593Z","steps":["trace[1592339266] 'process raft request' (duration: 191.681076ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:59.283709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.743709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:21:59.283754Z","caller":"traceutil/trace.go:171","msg":"trace[1801080368] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:26759; }","duration":"187.828562ms","start":"2026-07-11T04:21:59.095913Z","end":"2026-07-11T04:21:59.283741Z","steps":["trace[1801080368] 'agreement among raft nodes before linearized reading' (duration: 187.739699ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:21:59.283794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.608056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18c121724949b97a\" ","response":"range_response_count:1 size:736"} {"level":"warn","ts":"2026-07-11T04:21:59.283845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.064841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"} {"level":"info","ts":"2026-07-11T04:21:59.283866Z","caller":"traceutil/trace.go:171","msg":"trace[1216323166] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18c121724949b97a; range_end:; response_count:1; response_revision:26759; }","duration":"112.693688ms","start":"2026-07-11T04:21:59.171156Z","end":"2026-07-11T04:21:59.28385Z","steps":["trace[1216323166] 'agreement among raft nodes before linearized reading' (duration: 112.556785ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:21:59.283881Z","caller":"traceutil/trace.go:171","msg":"trace[249624104] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:26759; }","duration":"111.159453ms","start":"2026-07-11T04:21:59.172711Z","end":"2026-07-11T04:21:59.28387Z","steps":["trace[249624104] 'agreement among raft nodes before linearized reading' (duration: 111.00494ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:11.538659Z","caller":"traceutil/trace.go:171","msg":"trace[1311894379] transaction","detail":"{read_only:false; response_revision:26868; number_of_response:1; }","duration":"180.557961ms","start":"2026-07-11T04:22:11.358049Z","end":"2026-07-11T04:22:11.538607Z","steps":["trace[1311894379] 'process raft request' (duration: 114.544517ms)","trace[1311894379] 'compare' (duration: 65.707148ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:22:11.538754Z","caller":"traceutil/trace.go:171","msg":"trace[1613295558] transaction","detail":"{read_only:false; response_revision:26870; number_of_response:1; }","duration":"178.815514ms","start":"2026-07-11T04:22:11.359908Z","end":"2026-07-11T04:22:11.538723Z","steps":["trace[1613295558] 'process raft request' (duration: 178.716612ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:11.538791Z","caller":"traceutil/trace.go:171","msg":"trace[1825657497] transaction","detail":"{read_only:false; response_revision:26871; number_of_response:1; }","duration":"177.25811ms","start":"2026-07-11T04:22:11.361509Z","end":"2026-07-11T04:22:11.538767Z","steps":["trace[1825657497] 'process raft request' (duration: 177.161928ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:11.538882Z","caller":"traceutil/trace.go:171","msg":"trace[1545375445] transaction","detail":"{read_only:false; response_revision:26869; number_of_response:1; }","duration":"179.854037ms","start":"2026-07-11T04:22:11.359Z","end":"2026-07-11T04:22:11.538854Z","steps":["trace[1545375445] 'process raft request' (duration: 179.522719ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:11.53874Z","caller":"traceutil/trace.go:171","msg":"trace[1813412533] linearizableReadLoop","detail":"{readStateIndex:27752; appliedIndex:27748; }","duration":"127.440259ms","start":"2026-07-11T04:22:11.41127Z","end":"2026-07-11T04:22:11.538711Z","steps":["trace[1813412533] 'read index received' (duration: 61.362874ms)","trace[1813412533] 'applied index is now lower than readState.Index' (duration: 66.076405ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:22:11.539399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.111314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-11T04:22:11.539438Z","caller":"traceutil/trace.go:171","msg":"trace[1734030375] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26871; }","duration":"128.215606ms","start":"2026-07-11T04:22:11.411211Z","end":"2026-07-11T04:22:11.539427Z","steps":["trace[1734030375] 'agreement among raft nodes before linearized reading' (duration: 127.94106ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.714846Z","caller":"traceutil/trace.go:171","msg":"trace[1003040607] transaction","detail":"{read_only:false; response_revision:26887; number_of_response:1; }","duration":"171.626417ms","start":"2026-07-11T04:22:13.543182Z","end":"2026-07-11T04:22:13.714808Z","steps":["trace[1003040607] 'process raft request' (duration: 120.242382ms)","trace[1003040607] 'compare' (duration: 51.117399ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:22:13.71531Z","caller":"traceutil/trace.go:171","msg":"trace[550398249] transaction","detail":"{read_only:false; response_revision:26888; number_of_response:1; }","duration":"171.647097ms","start":"2026-07-11T04:22:13.543647Z","end":"2026-07-11T04:22:13.715294Z","steps":["trace[550398249] 'process raft request' (duration: 171.017663ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.715247Z","caller":"traceutil/trace.go:171","msg":"trace[1554615376] linearizableReadLoop","detail":"{readStateIndex:27770; appliedIndex:27767; }","duration":"113.563795ms","start":"2026-07-11T04:22:13.601648Z","end":"2026-07-11T04:22:13.715211Z","steps":["trace[1554615376] 'read index received' (duration: 61.825343ms)","trace[1554615376] 'applied index is now lower than readState.Index' (duration: 51.737032ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:22:13.715595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.906903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-11T04:22:13.715752Z","caller":"traceutil/trace.go:171","msg":"trace[2144420415] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26889; }","duration":"114.116287ms","start":"2026-07-11T04:22:13.601617Z","end":"2026-07-11T04:22:13.715734Z","steps":["trace[2144420415] 'agreement among raft nodes before linearized reading' (duration: 113.728029ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.71608Z","caller":"traceutil/trace.go:171","msg":"trace[593692208] transaction","detail":"{read_only:false; response_revision:26889; number_of_response:1; }","duration":"168.171992ms","start":"2026-07-11T04:22:13.547893Z","end":"2026-07-11T04:22:13.716065Z","steps":["trace[593692208] 'process raft request' (duration: 167.201651ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.880308Z","caller":"traceutil/trace.go:171","msg":"trace[1187411942] transaction","detail":"{read_only:false; response_revision:26892; number_of_response:1; }","duration":"157.523098ms","start":"2026-07-11T04:22:13.722767Z","end":"2026-07-11T04:22:13.88029Z","steps":["trace[1187411942] 'process raft request' (duration: 157.455156ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.880309Z","caller":"traceutil/trace.go:171","msg":"trace[523646509] transaction","detail":"{read_only:false; response_revision:26891; number_of_response:1; }","duration":"158.163271ms","start":"2026-07-11T04:22:13.722111Z","end":"2026-07-11T04:22:13.880274Z","steps":["trace[523646509] 'process raft request' (duration: 157.979647ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.880532Z","caller":"traceutil/trace.go:171","msg":"trace[1464650927] transaction","detail":"{read_only:false; response_revision:26893; number_of_response:1; }","duration":"157.739463ms","start":"2026-07-11T04:22:13.722783Z","end":"2026-07-11T04:22:13.880522Z","steps":["trace[1464650927] 'process raft request' (duration: 157.472507ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.880711Z","caller":"traceutil/trace.go:171","msg":"trace[840218067] transaction","detail":"{read_only:false; response_revision:26894; number_of_response:1; }","duration":"153.95905ms","start":"2026-07-11T04:22:13.726743Z","end":"2026-07-11T04:22:13.880702Z","steps":["trace[840218067] 'process raft request' (duration: 153.721395ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.880787Z","caller":"traceutil/trace.go:171","msg":"trace[1738489373] transaction","detail":"{read_only:false; response_revision:26897; number_of_response:1; }","duration":"145.084036ms","start":"2026-07-11T04:22:13.735696Z","end":"2026-07-11T04:22:13.88078Z","steps":["trace[1738489373] 'process raft request' (duration: 145.060016ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.880845Z","caller":"traceutil/trace.go:171","msg":"trace[528828588] transaction","detail":"{read_only:false; response_revision:26896; number_of_response:1; }","duration":"148.677984ms","start":"2026-07-11T04:22:13.732162Z","end":"2026-07-11T04:22:13.88084Z","steps":["trace[528828588] 'process raft request' (duration: 148.567482ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:13.880842Z","caller":"traceutil/trace.go:171","msg":"trace[447740036] transaction","detail":"{read_only:false; response_revision:26895; number_of_response:1; }","duration":"150.885583ms","start":"2026-07-11T04:22:13.729915Z","end":"2026-07-11T04:22:13.880801Z","steps":["trace[447740036] 'process raft request' (duration: 150.74903ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:15.936298Z","caller":"traceutil/trace.go:171","msg":"trace[1574204352] linearizableReadLoop","detail":"{readStateIndex:27785; appliedIndex:27784; }","duration":"139.394332ms","start":"2026-07-11T04:22:15.796869Z","end":"2026-07-11T04:22:15.936263Z","steps":["trace[1574204352] 'read index received' (duration: 110.757825ms)","trace[1574204352] 'applied index is now lower than readState.Index' (duration: 28.634707ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:22:15.936597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.322525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-11T04:22:15.936648Z","caller":"traceutil/trace.go:171","msg":"trace[394218474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26903; }","duration":"147.431808ms","start":"2026-07-11T04:22:15.789203Z","end":"2026-07-11T04:22:15.936634Z","steps":["trace[394218474] 'agreement among raft nodes before linearized reading' (duration: 147.202343ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:15.987431Z","caller":"traceutil/trace.go:171","msg":"trace[1520319404] transaction","detail":"{read_only:false; response_revision:26904; number_of_response:1; }","duration":"171.169507ms","start":"2026-07-11T04:22:15.816231Z","end":"2026-07-11T04:22:15.9874Z","steps":["trace[1520319404] 'process raft request' (duration: 170.898701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:22:15.987718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.556694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-07-11T04:22:15.987778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.368079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-07-11T04:22:15.987753Z","caller":"traceutil/trace.go:171","msg":"trace[178836428] transaction","detail":"{read_only:false; response_revision:26905; number_of_response:1; }","duration":"100.635532ms","start":"2026-07-11T04:22:15.887072Z","end":"2026-07-11T04:22:15.987707Z","steps":["trace[178836428] 'process raft request' (duration: 100.234404ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:15.987821Z","caller":"traceutil/trace.go:171","msg":"trace[368008725] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26907; }","duration":"101.43769ms","start":"2026-07-11T04:22:15.88637Z","end":"2026-07-11T04:22:15.987808Z","steps":["trace[368008725] 'agreement among raft nodes before linearized reading' (duration: 101.325487ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:22:15.98782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.45776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-11T04:22:15.987859Z","caller":"traceutil/trace.go:171","msg":"trace[230086031] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26907; }","duration":"101.628115ms","start":"2026-07-11T04:22:15.886221Z","end":"2026-07-11T04:22:15.987849Z","steps":["trace[230086031] 'agreement among raft nodes before linearized reading' (duration: 101.448791ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:15.987793Z","caller":"traceutil/trace.go:171","msg":"trace[1421646419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26907; }","duration":"102.676007ms","start":"2026-07-11T04:22:15.885098Z","end":"2026-07-11T04:22:15.987774Z","steps":["trace[1421646419] 'agreement among raft nodes before linearized reading' (duration: 102.33705ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:22:15.987883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.541162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-07-11T04:22:15.987913Z","caller":"traceutil/trace.go:171","msg":"trace[1917147012] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26907; }","duration":"101.586533ms","start":"2026-07-11T04:22:15.886318Z","end":"2026-07-11T04:22:15.987905Z","steps":["trace[1917147012] 'agreement among raft nodes before linearized reading' (duration: 101.503131ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:15.987924Z","caller":"traceutil/trace.go:171","msg":"trace[1383331778] transaction","detail":"{read_only:false; response_revision:26906; number_of_response:1; }","duration":"100.574821ms","start":"2026-07-11T04:22:15.887313Z","end":"2026-07-11T04:22:15.987888Z","steps":["trace[1383331778] 'process raft request' (duration: 100.0491ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:16.045035Z","caller":"traceutil/trace.go:171","msg":"trace[1819371693] transaction","detail":"{read_only:false; response_revision:26909; number_of_response:1; }","duration":"103.793793ms","start":"2026-07-11T04:22:15.941219Z","end":"2026-07-11T04:22:16.045013Z","steps":["trace[1819371693] 'process raft request' (duration: 103.733291ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:16.04535Z","caller":"traceutil/trace.go:171","msg":"trace[1813865849] transaction","detail":"{read_only:false; response_revision:26908; number_of_response:1; }","duration":"108.263951ms","start":"2026-07-11T04:22:15.937076Z","end":"2026-07-11T04:22:16.04534Z","steps":["trace[1813865849] 'process raft request' (duration: 107.744379ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:22:18.47639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.589462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-07-11T04:22:18.476509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.219694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-07-11T04:22:18.47656Z","caller":"traceutil/trace.go:171","msg":"trace[1007477424] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:26930; }","duration":"132.334437ms","start":"2026-07-11T04:22:18.344212Z","end":"2026-07-11T04:22:18.476547Z","steps":["trace[1007477424] 'count revisions from in-memory index tree' (duration: 132.083621ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:18.476786Z","caller":"traceutil/trace.go:171","msg":"trace[1891346887] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26930; }","duration":"116.710105ms","start":"2026-07-11T04:22:18.359758Z","end":"2026-07-11T04:22:18.476468Z","steps":["trace[1891346887] 'range keys from in-memory index tree' (duration: 116.48865ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:22:21.047924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.600079ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-07-11T04:22:21.048388Z","caller":"traceutil/trace.go:171","msg":"trace[291445724] transaction","detail":"{read_only:false; response_revision:26944; number_of_response:1; }","duration":"122.591984ms","start":"2026-07-11T04:22:20.925776Z","end":"2026-07-11T04:22:21.048368Z","steps":["trace[291445724] 'process raft request' (duration: 122.272267ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:24.192052Z","caller":"traceutil/trace.go:171","msg":"trace[2064435337] transaction","detail":"{read_only:false; response_revision:26969; number_of_response:1; }","duration":"101.943131ms","start":"2026-07-11T04:22:24.090078Z","end":"2026-07-11T04:22:24.192021Z","steps":["trace[2064435337] 'process raft request' (duration: 72.059046ms)","trace[2064435337] 'compare' (duration: 29.591649ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:22:24.192476Z","caller":"traceutil/trace.go:171","msg":"trace[2103193332] transaction","detail":"{read_only:false; response_revision:26970; number_of_response:1; }","duration":"101.728786ms","start":"2026-07-11T04:22:24.090709Z","end":"2026-07-11T04:22:24.192438Z","steps":["trace[2103193332] 'process raft request' (duration: 101.207335ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:24.192882Z","caller":"traceutil/trace.go:171","msg":"trace[1124900257] transaction","detail":"{read_only:false; response_revision:26971; number_of_response:1; }","duration":"101.308868ms","start":"2026-07-11T04:22:24.091544Z","end":"2026-07-11T04:22:24.192852Z","steps":["trace[1124900257] 'process raft request' (duration: 100.772746ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:24.193183Z","caller":"traceutil/trace.go:171","msg":"trace[1982364739] transaction","detail":"{read_only:false; response_revision:26972; number_of_response:1; }","duration":"101.308258ms","start":"2026-07-11T04:22:24.091863Z","end":"2026-07-11T04:22:24.193171Z","steps":["trace[1982364739] 'process raft request' (duration: 100.94328ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:24.193159Z","caller":"traceutil/trace.go:171","msg":"trace[614923553] transaction","detail":"{read_only:false; response_revision:26973; number_of_response:1; }","duration":"100.691694ms","start":"2026-07-11T04:22:24.092436Z","end":"2026-07-11T04:22:24.193127Z","steps":["trace[614923553] 'process raft request' (duration: 100.622102ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:25.897708Z","caller":"traceutil/trace.go:171","msg":"trace[1697519120] linearizableReadLoop","detail":"{readStateIndex:27860; appliedIndex:27859; }","duration":"206.125213ms","start":"2026-07-11T04:22:25.691554Z","end":"2026-07-11T04:22:25.897679Z","steps":["trace[1697519120] 'read index received' (duration: 132.649084ms)","trace[1697519120] 'applied index is now lower than readState.Index' (duration: 73.474998ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:22:25.897776Z","caller":"traceutil/trace.go:171","msg":"trace[1696619061] transaction","detail":"{read_only:false; response_revision:26977; number_of_response:1; }","duration":"221.970549ms","start":"2026-07-11T04:22:25.675772Z","end":"2026-07-11T04:22:25.897742Z","steps":["trace[1696619061] 'process raft request' (duration: 148.498631ms)","trace[1696619061] 'compare' (duration: 73.229563ms)"],"step_count":2} {"level":"warn","ts":"2026-07-11T04:22:25.897934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.359777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-07-11T04:22:25.897982Z","caller":"traceutil/trace.go:171","msg":"trace[127483569] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:26977; }","duration":"206.44758ms","start":"2026-07-11T04:22:25.691525Z","end":"2026-07-11T04:22:25.897972Z","steps":["trace[127483569] 'agreement among raft nodes before linearized reading' (duration: 206.270036ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:25.955413Z","caller":"traceutil/trace.go:171","msg":"trace[910610820] transaction","detail":"{read_only:false; response_revision:26978; number_of_response:1; }","duration":"126.5524ms","start":"2026-07-11T04:22:25.828833Z","end":"2026-07-11T04:22:25.955385Z","steps":["trace[910610820] 'process raft request' (duration: 126.383586ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:26.056626Z","caller":"traceutil/trace.go:171","msg":"trace[2076364856] transaction","detail":"{read_only:false; response_revision:26980; number_of_response:1; }","duration":"220.117358ms","start":"2026-07-11T04:22:25.83649Z","end":"2026-07-11T04:22:26.056608Z","steps":["trace[2076364856] 'process raft request' (duration: 219.842542ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:26.05658Z","caller":"traceutil/trace.go:171","msg":"trace[1921875236] transaction","detail":"{read_only:false; response_revision:26979; number_of_response:1; }","duration":"223.940502ms","start":"2026-07-11T04:22:25.832602Z","end":"2026-07-11T04:22:26.056542Z","steps":["trace[1921875236] 'process raft request' (duration: 223.588913ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:26.36712Z","caller":"traceutil/trace.go:171","msg":"trace[557436966] transaction","detail":"{read_only:false; response_revision:26985; number_of_response:1; }","duration":"164.683684ms","start":"2026-07-11T04:22:26.202387Z","end":"2026-07-11T04:22:26.367071Z","steps":["trace[557436966] 'process raft request' (duration: 164.547851ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:26.379638Z","caller":"traceutil/trace.go:171","msg":"trace[1713090707] transaction","detail":"{read_only:false; response_revision:26986; number_of_response:1; }","duration":"175.260427ms","start":"2026-07-11T04:22:26.20428Z","end":"2026-07-11T04:22:26.379541Z","steps":["trace[1713090707] 'process raft request' (duration: 175.003211ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:26.37987Z","caller":"traceutil/trace.go:171","msg":"trace[1918899556] linearizableReadLoop","detail":"{readStateIndex:27870; appliedIndex:27869; }","duration":"175.476671ms","start":"2026-07-11T04:22:26.204367Z","end":"2026-07-11T04:22:26.379844Z","steps":["trace[1918899556] 'read index received' (duration: 163.230264ms)","trace[1918899556] 'applied index is now lower than readState.Index' (duration: 12.245147ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:22:26.38003Z","caller":"traceutil/trace.go:171","msg":"trace[56707296] transaction","detail":"{read_only:false; response_revision:26987; number_of_response:1; }","duration":"171.271969ms","start":"2026-07-11T04:22:26.20875Z","end":"2026-07-11T04:22:26.380022Z","steps":["trace[56707296] 'process raft request' (duration: 170.733117ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:22:26.380265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.859759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-11T04:22:26.38032Z","caller":"traceutil/trace.go:171","msg":"trace[666465078] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:26987; }","duration":"175.989512ms","start":"2026-07-11T04:22:26.204314Z","end":"2026-07-11T04:22:26.380303Z","steps":["trace[666465078] 'agreement among raft nodes before linearized reading' (duration: 175.857429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:22:26.380307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.105917ms","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-07-11T04:22:26.38038Z","caller":"traceutil/trace.go:171","msg":"trace[856803128] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26987; }","duration":"172.2503ms","start":"2026-07-11T04:22:26.208108Z","end":"2026-07-11T04:22:26.380359Z","steps":["trace[856803128] 'agreement among raft nodes before linearized reading' (duration: 172.035066ms)"],"step_count":1} {"level":"warn","ts":"2026-07-11T04:22:26.380419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.017355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-11T04:22:26.380451Z","caller":"traceutil/trace.go:171","msg":"trace[874272633] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26987; }","duration":"172.072286ms","start":"2026-07-11T04:22:26.208369Z","end":"2026-07-11T04:22:26.380441Z","steps":["trace[874272633] 'agreement among raft nodes before linearized reading' (duration: 171.949623ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:27.671909Z","caller":"traceutil/trace.go:171","msg":"trace[389864588] transaction","detail":"{read_only:false; response_revision:26993; number_of_response:1; }","duration":"130.018696ms","start":"2026-07-11T04:22:27.541866Z","end":"2026-07-11T04:22:27.671885Z","steps":["trace[389864588] 'process raft request' (duration: 129.785211ms)"],"step_count":1} {"level":"info","ts":"2026-07-11T04:22:52.222354Z","caller":"traceutil/trace.go:171","msg":"trace[1238634233] transaction","detail":"{read_only:false; response_revision:27191; number_of_response:1; }","duration":"175.106519ms","start":"2026-07-11T04:22:52.0472Z","end":"2026-07-11T04:22:52.222306Z","steps":["trace[1238634233] 'process raft request' (duration: 138.768183ms)","trace[1238634233] 'compare' (duration: 35.653112ms)"],"step_count":2} {"level":"info","ts":"2026-07-11T04:24:02.73376Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25028} {"level":"info","ts":"2026-07-11T04:24:02.873965Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25028,"took":"134.367346ms","hash":2398808048,"current-db-size-bytes":59781120,"current-db-size":"60 MB","current-db-size-in-use-bytes":36737024,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-07-11T04:24:02.874023Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2398808048,"revision":25028,"compact-revision":21980} {"level":"info","ts":"2026-07-11T04:25:51.68209Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-11T04:25:51.688476Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-07-11T04:25:51.688622Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-07-11T04:29:02.740802Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27964} {"level":"info","ts":"2026-07-11T04:29:02.879295Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27964,"took":"134.190652ms","hash":1816519723,"current-db-size-bytes":59781120,"current-db-size":"60 MB","current-db-size-in-use-bytes":35217408,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-07-11T04:29:02.879393Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1816519723,"revision":27964,"compact-revision":25028} {"level":"info","ts":"2026-07-11T04:34:02.74677Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30635} {"level":"info","ts":"2026-07-11T04:34:02.891994Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30635,"took":"141.85466ms","hash":1640755642,"current-db-size-bytes":59781120,"current-db-size":"60 MB","current-db-size-in-use-bytes":30953472,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-11T04:34:02.892073Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1640755642,"revision":30635,"compact-revision":27964} {"level":"info","ts":"2026-07-11T04:39:02.753768Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32902} {"level":"info","ts":"2026-07-11T04:39:02.900869Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32902,"took":"143.246359ms","hash":3763576078,"current-db-size-bytes":60825600,"current-db-size":"61 MB","current-db-size-in-use-bytes":30547968,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-11T04:39:02.901046Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3763576078,"revision":32902,"compact-revision":30635} {"level":"info","ts":"2026-07-11T04:44:02.767847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35150} {"level":"info","ts":"2026-07-11T04:44:02.921092Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35150,"took":"145.464058ms","hash":1492195518,"current-db-size-bytes":60825600,"current-db-size":"61 MB","current-db-size-in-use-bytes":31010816,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-11T04:44:02.92116Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1492195518,"revision":35150,"compact-revision":32902} {"level":"info","ts":"2026-07-11T04:46:53.884903Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"c47ca1a7b1fe506b","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-11T04:46:53.890007Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-07-11T04:46:53.890185Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-07-11T04:49:02.776306Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37454} {"level":"info","ts":"2026-07-11T04:49:02.884406Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37454,"took":"103.646839ms","hash":1418048063,"current-db-size-bytes":60825600,"current-db-size":"61 MB","current-db-size-in-use-bytes":31252480,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-07-11T04:49:02.884465Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1418048063,"revision":37454,"compact-revision":35150}