{"level":"warn","ts":"2026-07-14T23:02:10.954098Z","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-14T23:02:10.954183Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.44:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.44:2380","--initial-cluster=instance=https://199.19.213.44:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.44:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.44: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-14T23:02:10.954241Z","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-14T23:02:10.954256Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.44:2380"]} {"level":"info","ts":"2026-07-14T23:02:10.954271Z","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-14T23:02:10.95488Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.44:2379"]} {"level":"info","ts":"2026-07-14T23:02:10.954975Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.44:2380"],"listen-peer-urls":["https://199.19.213.44:2380"],"advertise-client-urls":["https://199.19.213.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.44: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-14T23:02:10.960452Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.275063ms"} {"level":"info","ts":"2026-07-14T23:02:10.969249Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4f2979fc0f638003","cluster-id":"ce06e7bc3b23612b"} {"level":"info","ts":"2026-07-14T23:02:10.969306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 switched to configuration voters=()"} {"level":"info","ts":"2026-07-14T23:02:10.969321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 became follower at term 0"} {"level":"info","ts":"2026-07-14T23:02:10.969328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4f2979fc0f638003 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-14T23:02:10.969334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 became follower at term 1"} {"level":"info","ts":"2026-07-14T23:02:10.969361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 switched to configuration voters=(5704224526538342403)"} {"level":"warn","ts":"2026-07-14T23:02:10.981458Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-14T23:02:10.983233Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-14T23:02:10.98446Z","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-14T23:02:10.986727Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4f2979fc0f638003","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-14T23:02:10.987078Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4f2979fc0f638003","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-14T23:02:10.987225Z","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-14T23:02:10.987261Z","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-14T23:02:10.98727Z","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-14T23:02:10.987828Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 switched to configuration voters=(5704224526538342403)"} {"level":"info","ts":"2026-07-14T23:02:10.987922Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ce06e7bc3b23612b","local-member-id":"4f2979fc0f638003","added-peer-id":"4f2979fc0f638003","added-peer-peer-urls":["https://199.19.213.44:2380"]} {"level":"info","ts":"2026-07-14T23:02:10.991183Z","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-14T23:02:10.991467Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4f2979fc0f638003","initial-advertise-peer-urls":["https://199.19.213.44:2380"],"listen-peer-urls":["https://199.19.213.44:2380"],"advertise-client-urls":["https://199.19.213.44:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.44:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-14T23:02:10.991509Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-14T23:02:10.991715Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.44:2380"} {"level":"info","ts":"2026-07-14T23:02:10.991829Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.44:2380"} {"level":"info","ts":"2026-07-14T23:02:11.870248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 is starting a new election at term 1"} {"level":"info","ts":"2026-07-14T23:02:11.870319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-14T23:02:11.870351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 received MsgPreVoteResp from 4f2979fc0f638003 at term 1"} {"level":"info","ts":"2026-07-14T23:02:11.870371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 became candidate at term 2"} {"level":"info","ts":"2026-07-14T23:02:11.870381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 received MsgVoteResp from 4f2979fc0f638003 at term 2"} {"level":"info","ts":"2026-07-14T23:02:11.870401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4f2979fc0f638003 became leader at term 2"} {"level":"info","ts":"2026-07-14T23:02:11.870418Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4f2979fc0f638003 elected leader 4f2979fc0f638003 at term 2"} {"level":"info","ts":"2026-07-14T23:02:11.871419Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T23:02:11.872435Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4f2979fc0f638003","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.44:2379]}","request-path":"/0/members/4f2979fc0f638003/attributes","cluster-id":"ce06e7bc3b23612b","publish-timeout":"7s"} {"level":"info","ts":"2026-07-14T23:02:11.872446Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T23:02:11.872773Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ce06e7bc3b23612b","local-member-id":"4f2979fc0f638003","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T23:02:11.872868Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T23:02:11.872896Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-14T23:02:11.873072Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-14T23:02:11.873159Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-14T23:02:11.87433Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.44:2379"} {"level":"info","ts":"2026-07-14T23:02:11.874407Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-14T23:02:11.875754Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-14T23:02:24.364218Z","caller":"traceutil/trace.go:171","msg":"trace[1549574039] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"109.31598ms","start":"2026-07-14T23:02:24.254876Z","end":"2026-07-14T23:02:24.364191Z","steps":["trace[1549574039] 'process raft request' (duration: 109.192369ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:02:29.741836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.148961ms","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-14T23:02:29.741968Z","caller":"traceutil/trace.go:171","msg":"trace[886676950] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:379; }","duration":"249.339121ms","start":"2026-07-14T23:02:29.492604Z","end":"2026-07-14T23:02:29.741943Z","steps":["trace[886676950] 'range keys from in-memory index tree' (duration: 249.036471ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:02:30.423581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.596186ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-14T23:02:46.075725Z","caller":"traceutil/trace.go:171","msg":"trace[638167593] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"152.120594ms","start":"2026-07-14T23:02:45.923581Z","end":"2026-07-14T23:02:46.075702Z","steps":["trace[638167593] 'process raft request' (duration: 145.417324ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:46.076992Z","caller":"traceutil/trace.go:171","msg":"trace[1298876898] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"149.80653ms","start":"2026-07-14T23:02:45.927174Z","end":"2026-07-14T23:02:46.07698Z","steps":["trace[1298876898] 'process raft request' (duration: 149.692521ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:46.0772Z","caller":"traceutil/trace.go:171","msg":"trace[1937592326] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"152.900152ms","start":"2026-07-14T23:02:45.924245Z","end":"2026-07-14T23:02:46.077146Z","steps":["trace[1937592326] 'process raft request' (duration: 152.350313ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:52.086026Z","caller":"traceutil/trace.go:171","msg":"trace[2097905771] linearizableReadLoop","detail":"{readStateIndex:611; appliedIndex:610; }","duration":"114.572709ms","start":"2026-07-14T23:02:51.971434Z","end":"2026-07-14T23:02:52.086007Z","steps":["trace[2097905771] 'read index received' (duration: 113.873561ms)","trace[2097905771] 'applied index is now lower than readState.Index' (duration: 698.588µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:02:52.086258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.804969ms","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-14T23:02:52.086323Z","caller":"traceutil/trace.go:171","msg":"trace[517798406] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"114.915398ms","start":"2026-07-14T23:02:51.971399Z","end":"2026-07-14T23:02:52.086314Z","steps":["trace[517798406] 'agreement among raft nodes before linearized reading' (duration: 114.694159ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:02:52.086222Z","caller":"traceutil/trace.go:171","msg":"trace[259641532] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"295.887281ms","start":"2026-07-14T23:02:51.790278Z","end":"2026-07-14T23:02:52.086165Z","steps":["trace[259641532] 'process raft request' (duration: 295.248192ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:02:52.879747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.223977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9zvpd\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-14T23:02:52.879827Z","caller":"traceutil/trace.go:171","msg":"trace[2080060849] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9zvpd; range_end:; response_count:1; response_revision:589; }","duration":"590.355776ms","start":"2026-07-14T23:02:52.289453Z","end":"2026-07-14T23:02:52.879808Z","steps":["trace[2080060849] 'range keys from in-memory index tree' (duration: 589.998067ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:02:52.879873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:02:52.289425Z","time spent":"590.439186ms","remote":"127.0.0.1:41756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-9zvpd\" "} {"level":"info","ts":"2026-07-14T23:02:52.885404Z","caller":"traceutil/trace.go:171","msg":"trace[636211043] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"309.73057ms","start":"2026-07-14T23:02:52.575653Z","end":"2026-07-14T23:02:52.885383Z","steps":["trace[636211043] 'process raft request' (duration: 305.779282ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:02:52.885972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:02:52.57562Z","time spent":"309.841579ms","remote":"127.0.0.1:41656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:03:07.816212Z","caller":"traceutil/trace.go:171","msg":"trace[1110348744] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:778; }","duration":"261.118934ms","start":"2026-07-14T23:03:07.555072Z","end":"2026-07-14T23:03:07.816191Z","steps":["trace[1110348744] 'read index received' (duration: 260.970925ms)","trace[1110348744] 'applied index is now lower than readState.Index' (duration: 146.869µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:03:07.81635Z","caller":"traceutil/trace.go:171","msg":"trace[776230718] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"429.513901ms","start":"2026-07-14T23:03:07.38682Z","end":"2026-07-14T23:03:07.816334Z","steps":["trace[776230718] 'process raft request' (duration: 429.236252ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:03:07.816459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:03:07.386671Z","time spent":"429.71158ms","remote":"127.0.0.1:41756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:03:07.816676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.615512ms","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-14T23:03:07.816742Z","caller":"traceutil/trace.go:171","msg":"trace[2078480656] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:751; }","duration":"261.663022ms","start":"2026-07-14T23:03:07.555052Z","end":"2026-07-14T23:03:07.816715Z","steps":["trace[2078480656] 'agreement among raft nodes before linearized reading' (duration: 261.515393ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:03:07.816988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.88251ms","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-14T23:03:07.817098Z","caller":"traceutil/trace.go:171","msg":"trace[1199951837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:751; }","duration":"256.023269ms","start":"2026-07-14T23:03:07.561056Z","end":"2026-07-14T23:03:07.817079Z","steps":["trace[1199951837] 'agreement among raft nodes before linearized reading' (duration: 255.78957ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:03:07.817085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.641749ms","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-14T23:03:07.817214Z","caller":"traceutil/trace.go:171","msg":"trace[767286814] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:751; }","duration":"259.855599ms","start":"2026-07-14T23:03:07.557333Z","end":"2026-07-14T23:03:07.817189Z","steps":["trace[767286814] 'agreement among raft nodes before linearized reading' (duration: 259.47477ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:03:54.291379Z","caller":"traceutil/trace.go:171","msg":"trace[1234610580] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"149.773568ms","start":"2026-07-14T23:03:54.141584Z","end":"2026-07-14T23:03:54.291358Z","steps":["trace[1234610580] 'process raft request' (duration: 143.239977ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:24.383339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.742058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a15027ab-0fdd-4dab-86b7-8819f6e0d0be\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-07-14T23:04:24.383432Z","caller":"traceutil/trace.go:171","msg":"trace[1700807364] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a15027ab-0fdd-4dab-86b7-8819f6e0d0be; range_end:; response_count:1; response_revision:1825; }","duration":"397.873928ms","start":"2026-07-14T23:04:23.985531Z","end":"2026-07-14T23:04:24.383405Z","steps":["trace[1700807364] 'range keys from in-memory index tree' (duration: 397.514739ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:24.38385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:23.985512Z","time spent":"398.304027ms","remote":"127.0.0.1:41756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a15027ab-0fdd-4dab-86b7-8819f6e0d0be\" "} {"level":"info","ts":"2026-07-14T23:04:24.418061Z","caller":"traceutil/trace.go:171","msg":"trace[1665491476] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"363.198057ms","start":"2026-07-14T23:04:24.054838Z","end":"2026-07-14T23:04:24.418037Z","steps":["trace[1665491476] 'process raft request' (duration: 362.986678ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:24.418352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:24.054814Z","time spent":"363.378007ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:04:24.431789Z","caller":"traceutil/trace.go:171","msg":"trace[1109858562] linearizableReadLoop","detail":"{readStateIndex:1901; appliedIndex:1899; }","duration":"129.552768ms","start":"2026-07-14T23:04:24.302208Z","end":"2026-07-14T23:04:24.431761Z","steps":["trace[1109858562] 'read index received' (duration: 115.749948ms)","trace[1109858562] 'applied index is now lower than readState.Index' (duration: 13.80154ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:04:24.432019Z","caller":"traceutil/trace.go:171","msg":"trace[1193887900] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"267.717351ms","start":"2026-07-14T23:04:24.164259Z","end":"2026-07-14T23:04:24.431976Z","steps":["trace[1193887900] 'process raft request' (duration: 267.380492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:24.432065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.271756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-14T23:04:24.43209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.871227ms","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-14T23:04:24.432121Z","caller":"traceutil/trace.go:171","msg":"trace[226945779] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1827; }","duration":"109.337586ms","start":"2026-07-14T23:04:24.322767Z","end":"2026-07-14T23:04:24.432104Z","steps":["trace[226945779] 'agreement among raft nodes before linearized reading' (duration: 109.154516ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:24.432172Z","caller":"traceutil/trace.go:171","msg":"trace[924740162] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1827; }","duration":"130.005587ms","start":"2026-07-14T23:04:24.302149Z","end":"2026-07-14T23:04:24.432155Z","steps":["trace[924740162] 'agreement among raft nodes before linearized reading' (duration: 129.769017ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:24.590488Z","caller":"traceutil/trace.go:171","msg":"trace[1561803520] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"106.070506ms","start":"2026-07-14T23:04:24.484386Z","end":"2026-07-14T23:04:24.590457Z","steps":["trace[1561803520] 'process raft request' (duration: 16.227173ms)","trace[1561803520] 'compare' (duration: 89.405953ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:04:24.913902Z","caller":"traceutil/trace.go:171","msg":"trace[658603462] linearizableReadLoop","detail":"{readStateIndex:1905; appliedIndex:1904; }","duration":"308.771004ms","start":"2026-07-14T23:04:24.605106Z","end":"2026-07-14T23:04:24.913877Z","steps":["trace[658603462] 'read index received' (duration: 286.733417ms)","trace[658603462] 'applied index is now lower than readState.Index' (duration: 22.036287ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:04:24.914342Z","caller":"traceutil/trace.go:171","msg":"trace[1772522606] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"319.144334ms","start":"2026-07-14T23:04:24.595159Z","end":"2026-07-14T23:04:24.914303Z","steps":["trace[1772522606] 'process raft request' (duration: 296.612249ms)","trace[1772522606] 'compare' (duration: 21.816718ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:04:24.914505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:24.595127Z","time spent":"319.287143ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:04:24.914532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.378262ms","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-14T23:04:24.914629Z","caller":"traceutil/trace.go:171","msg":"trace[1674911833] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1831; }","duration":"309.5292ms","start":"2026-07-14T23:04:24.605078Z","end":"2026-07-14T23:04:24.914607Z","steps":["trace[1674911833] 'agreement among raft nodes before linearized reading' (duration: 309.206172ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:24.914676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:24.605065Z","time spent":"309.60388ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-14T23:04:24.918599Z","caller":"traceutil/trace.go:171","msg":"trace[620522111] transaction","detail":"{read_only:false; response_revision:1832; number_of_response:1; }","duration":"100.475872ms","start":"2026-07-14T23:04:24.818093Z","end":"2026-07-14T23:04:24.918569Z","steps":["trace[620522111] 'process raft request' (duration: 100.300442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:24.918866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.457161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T23:04:24.918876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.095332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a15027ab-0fdd-4dab-86b7-8819f6e0d0be\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-07-14T23:04:24.918863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.050724ms","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-14T23:04:24.91891Z","caller":"traceutil/trace.go:171","msg":"trace[781418966] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1832; }","duration":"170.539561ms","start":"2026-07-14T23:04:24.74836Z","end":"2026-07-14T23:04:24.918899Z","steps":["trace[781418966] 'agreement among raft nodes before linearized reading' (duration: 170.451811ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:24.918927Z","caller":"traceutil/trace.go:171","msg":"trace[1932379060] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a15027ab-0fdd-4dab-86b7-8819f6e0d0be; range_end:; response_count:1; response_revision:1832; }","duration":"170.163732ms","start":"2026-07-14T23:04:24.748749Z","end":"2026-07-14T23:04:24.918912Z","steps":["trace[1932379060] 'agreement among raft nodes before linearized reading' (duration: 170.050072ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:24.918965Z","caller":"traceutil/trace.go:171","msg":"trace[599712307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1832; }","duration":"267.351394ms","start":"2026-07-14T23:04:24.651567Z","end":"2026-07-14T23:04:24.918919Z","steps":["trace[599712307] 'agreement among raft nodes before linearized reading' (duration: 266.928215ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:24.918678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.605211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.44\" ","response":"range_response_count:1 size:132"} {"level":"info","ts":"2026-07-14T23:04:24.919265Z","caller":"traceutil/trace.go:171","msg":"trace[1256527658] range","detail":"{range_begin:/registry/masterleases/199.19.213.44; range_end:; response_count:1; response_revision:1832; }","duration":"164.23273ms","start":"2026-07-14T23:04:24.75502Z","end":"2026-07-14T23:04:24.919253Z","steps":["trace[1256527658] 'agreement among raft nodes before linearized reading' (duration: 163.511292ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:39.345822Z","caller":"traceutil/trace.go:171","msg":"trace[892598675] linearizableReadLoop","detail":"{readStateIndex:2025; appliedIndex:2024; }","duration":"367.300436ms","start":"2026-07-14T23:04:38.978506Z","end":"2026-07-14T23:04:39.345806Z","steps":["trace[892598675] 'read index received' (duration: 367.126637ms)","trace[892598675] 'applied index is now lower than readState.Index' (duration: 173.189µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:04:39.345999Z","caller":"traceutil/trace.go:171","msg":"trace[888012066] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"385.801133ms","start":"2026-07-14T23:04:38.96019Z","end":"2026-07-14T23:04:39.345991Z","steps":["trace[888012066] 'process raft request' (duration: 385.524094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:39.346076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:38.960167Z","time spent":"385.856163ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:04:39.346297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.788575ms","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-14T23:04:39.346328Z","caller":"traceutil/trace.go:171","msg":"trace[703452388] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1947; }","duration":"367.857744ms","start":"2026-07-14T23:04:38.978462Z","end":"2026-07-14T23:04:39.34632Z","steps":["trace[703452388] 'agreement among raft nodes before linearized reading' (duration: 367.765455ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:39.346352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:38.978442Z","time spent":"367.904244ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-14T23:04:39.346536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.039644ms","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-14T23:04:39.346555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.401928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-2mrm5\" ","response":"range_response_count:1 size:5851"} {"level":"info","ts":"2026-07-14T23:04:39.346642Z","caller":"traceutil/trace.go:171","msg":"trace[2056439783] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-2mrm5; range_end:; response_count:1; response_revision:1947; }","duration":"147.535227ms","start":"2026-07-14T23:04:39.199086Z","end":"2026-07-14T23:04:39.346621Z","steps":["trace[2056439783] 'agreement among raft nodes before linearized reading' (duration: 147.273538ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:39.346592Z","caller":"traceutil/trace.go:171","msg":"trace[1008687534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1947; }","duration":"302.135764ms","start":"2026-07-14T23:04:39.044443Z","end":"2026-07-14T23:04:39.346579Z","steps":["trace[1008687534] 'agreement among raft nodes before linearized reading' (duration: 301.936404ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:39.346736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:39.044423Z","time spent":"302.295152ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-14T23:04:39.3469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.362843ms","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-14T23:04:39.346985Z","caller":"traceutil/trace.go:171","msg":"trace[847382135] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1947; }","duration":"340.548712ms","start":"2026-07-14T23:04:39.006418Z","end":"2026-07-14T23:04:39.346967Z","steps":["trace[847382135] 'agreement among raft nodes before linearized reading' (duration: 339.952414ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:39.347034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:39.006402Z","time spent":"340.621012ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-14T23:04:57.566573Z","caller":"traceutil/trace.go:171","msg":"trace[1812414084] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"115.645088ms","start":"2026-07-14T23:04:57.450891Z","end":"2026-07-14T23:04:57.566536Z","steps":["trace[1812414084] 'process raft request' (duration: 80.946828ms)","trace[1812414084] 'compare' (duration: 34.48327ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:04:57.988416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.440808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"warn","ts":"2026-07-14T23:04:57.988483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.668257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:04:57.988495Z","caller":"traceutil/trace.go:171","msg":"trace[1658130769] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2063; }","duration":"150.532218ms","start":"2026-07-14T23:04:57.837945Z","end":"2026-07-14T23:04:57.988477Z","steps":["trace[1658130769] 'range keys from in-memory index tree' (duration: 150.23103ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:57.988574Z","caller":"traceutil/trace.go:171","msg":"trace[424834426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2063; }","duration":"241.795607ms","start":"2026-07-14T23:04:57.746765Z","end":"2026-07-14T23:04:57.98856Z","steps":["trace[424834426] 'range keys from in-memory index tree' (duration: 241.587637ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:58.479864Z","caller":"traceutil/trace.go:171","msg":"trace[619964564] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"215.255303ms","start":"2026-07-14T23:04:58.264586Z","end":"2026-07-14T23:04:58.479841Z","steps":["trace[619964564] 'process raft request' (duration: 215.139303ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:04:58.717611Z","caller":"traceutil/trace.go:171","msg":"trace[1423714531] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"178.364538ms","start":"2026-07-14T23:04:58.53921Z","end":"2026-07-14T23:04:58.717575Z","steps":["trace[1423714531] 'process raft request' (duration: 159.542262ms)","trace[1423714531] 'compare' (duration: 18.533057ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:04:59.088966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.36138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T23:04:59.089092Z","caller":"traceutil/trace.go:171","msg":"trace[543722358] linearizableReadLoop","detail":"{readStateIndex:2148; appliedIndex:2146; }","duration":"515.426303ms","start":"2026-07-14T23:04:58.573634Z","end":"2026-07-14T23:04:59.08906Z","steps":["trace[543722358] 'read index received' (duration: 125.127941ms)","trace[543722358] 'applied index is now lower than readState.Index' (duration: 390.296432ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:04:59.089317Z","caller":"traceutil/trace.go:171","msg":"trace[894445173] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"543.573492ms","start":"2026-07-14T23:04:58.545714Z","end":"2026-07-14T23:04:59.089287Z","steps":["trace[894445173] 'process raft request' (duration: 361.797633ms)","trace[894445173] 'compare' (duration: 181.222231ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:04:59.089426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.746252ms","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":"warn","ts":"2026-07-14T23:04:59.089454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:58.545684Z","time spent":"543.707791ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:04:59.089482Z","caller":"traceutil/trace.go:171","msg":"trace[444192166] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2066; }","duration":"515.866921ms","start":"2026-07-14T23:04:58.573584Z","end":"2026-07-14T23:04:59.089451Z","steps":["trace[444192166] 'agreement among raft nodes before linearized reading' (duration: 515.684602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:59.089532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:58.573563Z","time spent":"515.936271ms","remote":"127.0.0.1:43352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-07-14T23:04:59.08996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.245507ms","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-14T23:04:59.090016Z","caller":"traceutil/trace.go:171","msg":"trace[718237984] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2066; }","duration":"486.344015ms","start":"2026-07-14T23:04:58.603657Z","end":"2026-07-14T23:04:59.090001Z","steps":["trace[718237984] 'agreement among raft nodes before linearized reading' (duration: 486.189586ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:59.090103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:58.603642Z","time spent":"486.447445ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-14T23:04:59.090153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.234274ms","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-14T23:04:59.09024Z","caller":"traceutil/trace.go:171","msg":"trace[685800720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2066; }","duration":"483.359924ms","start":"2026-07-14T23:04:58.606863Z","end":"2026-07-14T23:04:59.090223Z","steps":["trace[685800720] 'agreement among raft nodes before linearized reading' (duration: 483.189124ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:59.090288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:58.606857Z","time spent":"483.419454ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-14T23:04:59.090537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.180212ms","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-14T23:04:59.090595Z","caller":"traceutil/trace.go:171","msg":"trace[1992968744] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2066; }","duration":"355.304932ms","start":"2026-07-14T23:04:58.735273Z","end":"2026-07-14T23:04:59.090578Z","steps":["trace[1992968744] 'agreement among raft nodes before linearized reading' (duration: 354.720784ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:04:59.090744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:04:58.735257Z","time spent":"355.471171ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-14T23:04:59.445165Z","caller":"traceutil/trace.go:171","msg":"trace[1192399943] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"257.894871ms","start":"2026-07-14T23:04:59.187239Z","end":"2026-07-14T23:04:59.445134Z","steps":["trace[1192399943] 'process raft request' (duration: 219.070901ms)","trace[1192399943] 'compare' (duration: 38.487031ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:06:21.936982Z","caller":"traceutil/trace.go:171","msg":"trace[1910875523] transaction","detail":"{read_only:false; response_revision:2628; number_of_response:1; }","duration":"107.045684ms","start":"2026-07-14T23:06:21.829899Z","end":"2026-07-14T23:06:21.936945Z","steps":["trace[1910875523] 'process raft request' (duration: 100.974731ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:06:21.943043Z","caller":"traceutil/trace.go:171","msg":"trace[856479688] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"110.032846ms","start":"2026-07-14T23:06:21.832994Z","end":"2026-07-14T23:06:21.943027Z","steps":["trace[856479688] 'process raft request' (duration: 109.750107ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:06:28.034481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.597309ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T23:06:28.035331Z","caller":"traceutil/trace.go:171","msg":"trace[1702832764] transaction","detail":"{read_only:false; response_revision:2655; number_of_response:1; }","duration":"439.553288ms","start":"2026-07-14T23:06:27.595749Z","end":"2026-07-14T23:06:28.035303Z","steps":["trace[1702832764] 'process raft request' (duration: 183.002619ms)","trace[1702832764] 'compare' (duration: 255.417592ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:06:28.035375Z","caller":"traceutil/trace.go:171","msg":"trace[275833836] linearizableReadLoop","detail":"{readStateIndex:2759; appliedIndex:2757; }","duration":"287.210087ms","start":"2026-07-14T23:06:27.748145Z","end":"2026-07-14T23:06:28.035355Z","steps":["trace[275833836] 'read index received' (duration: 30.603563ms)","trace[275833836] 'applied index is now lower than readState.Index' (duration: 256.605244ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:06:28.035489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:06:27.595733Z","time spent":"439.667908ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-14T23:06:28.035574Z","caller":"traceutil/trace.go:171","msg":"trace[2063701122] transaction","detail":"{read_only:false; response_revision:2657; number_of_response:1; }","duration":"263.504453ms","start":"2026-07-14T23:06:27.772058Z","end":"2026-07-14T23:06:28.035563Z","steps":["trace[2063701122] 'process raft request' (duration: 263.262261ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:06:28.035545Z","caller":"traceutil/trace.go:171","msg":"trace[902337282] transaction","detail":"{read_only:false; response_revision:2656; number_of_response:1; }","duration":"437.508602ms","start":"2026-07-14T23:06:27.597998Z","end":"2026-07-14T23:06:28.035507Z","steps":["trace[902337282] 'process raft request' (duration: 437.216185ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:06:28.035732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-14T23:06:27.597986Z","time spent":"437.657956ms","remote":"127.0.0.1:41838","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-14T23:06:28.035812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.673731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:06:28.03585Z","caller":"traceutil/trace.go:171","msg":"trace[2015150370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2657; }","duration":"287.747388ms","start":"2026-07-14T23:06:27.748093Z","end":"2026-07-14T23:06:28.03584Z","steps":["trace[2015150370] 'agreement among raft nodes before linearized reading' (duration: 287.693532ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:06:28.048223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.225208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-14T23:06:28.048499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.182448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18c24a8c11a205fd\" ","response":"range_response_count:1 size:778"} {"level":"info","ts":"2026-07-14T23:06:28.048581Z","caller":"traceutil/trace.go:171","msg":"trace[1099895610] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18c24a8c11a205fd; range_end:; response_count:1; response_revision:2658; }","duration":"202.301619ms","start":"2026-07-14T23:06:27.846259Z","end":"2026-07-14T23:06:28.048561Z","steps":["trace[1099895610] 'agreement among raft nodes before linearized reading' (duration: 202.09908ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:06:28.048999Z","caller":"traceutil/trace.go:171","msg":"trace[168914127] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:2658; }","duration":"163.508044ms","start":"2026-07-14T23:06:27.884932Z","end":"2026-07-14T23:06:28.04844Z","steps":["trace[168914127] 'agreement among raft nodes before linearized reading' (duration: 163.237738ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:09:48.420134Z","caller":"traceutil/trace.go:171","msg":"trace[1532190326] transaction","detail":"{read_only:false; response_revision:3880; number_of_response:1; }","duration":"122.493312ms","start":"2026-07-14T23:09:48.297617Z","end":"2026-07-14T23:09:48.420111Z","steps":["trace[1532190326] 'process raft request' (duration: 122.374409ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:15.773099Z","caller":"traceutil/trace.go:171","msg":"trace[1602026534] linearizableReadLoop","detail":"{readStateIndex:4706; appliedIndex:4705; }","duration":"209.179159ms","start":"2026-07-14T23:10:15.563895Z","end":"2026-07-14T23:10:15.773074Z","steps":["trace[1602026534] 'read index received' (duration: 125.08471ms)","trace[1602026534] 'applied index is now lower than readState.Index' (duration: 84.093579ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:15.773169Z","caller":"traceutil/trace.go:171","msg":"trace[1990172017] transaction","detail":"{read_only:false; response_revision:4527; number_of_response:1; }","duration":"247.061369ms","start":"2026-07-14T23:10:15.526084Z","end":"2026-07-14T23:10:15.773146Z","steps":["trace[1990172017] 'process raft request' (duration: 162.940329ms)","trace[1990172017] 'compare' (duration: 83.944756ms)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:10:15.77329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.380064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:10:15.773609Z","caller":"traceutil/trace.go:171","msg":"trace[1749292139] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4527; }","duration":"209.736922ms","start":"2026-07-14T23:10:15.56386Z","end":"2026-07-14T23:10:15.773597Z","steps":["trace[1749292139] 'agreement among raft nodes before linearized reading' (duration: 209.327653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:15.804282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.813438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-14T23:10:15.80436Z","caller":"traceutil/trace.go:171","msg":"trace[13835929] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:4528; }","duration":"115.94022ms","start":"2026-07-14T23:10:15.688404Z","end":"2026-07-14T23:10:15.804344Z","steps":["trace[13835929] 'agreement among raft nodes before linearized reading' (duration: 115.800917ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.082904Z","caller":"traceutil/trace.go:171","msg":"trace[246099301] transaction","detail":"{read_only:false; response_revision:4535; number_of_response:1; }","duration":"156.134764ms","start":"2026-07-14T23:10:15.926748Z","end":"2026-07-14T23:10:16.082883Z","steps":["trace[246099301] 'process raft request' (duration: 121.259907ms)","trace[246099301] 'compare' (duration: 34.715114ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:16.083035Z","caller":"traceutil/trace.go:171","msg":"trace[1925066502] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"145.08879ms","start":"2026-07-14T23:10:15.937933Z","end":"2026-07-14T23:10:16.083022Z","steps":["trace[1925066502] 'process raft request' (duration: 144.981598ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:16.083125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.227813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-07-14T23:10:16.082934Z","caller":"traceutil/trace.go:171","msg":"trace[588072785] transaction","detail":"{read_only:false; response_revision:4536; number_of_response:1; }","duration":"156.154374ms","start":"2026-07-14T23:10:15.92674Z","end":"2026-07-14T23:10:16.082895Z","steps":["trace[588072785] 'process raft request' (duration: 156.082433ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.083153Z","caller":"traceutil/trace.go:171","msg":"trace[557688842] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4540; }","duration":"155.281205ms","start":"2026-07-14T23:10:15.927863Z","end":"2026-07-14T23:10:16.083144Z","steps":["trace[557688842] 'agreement among raft nodes before linearized reading' (duration: 155.167813ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.082966Z","caller":"traceutil/trace.go:171","msg":"trace[1748650464] transaction","detail":"{read_only:false; response_revision:4537; number_of_response:1; }","duration":"156.150114ms","start":"2026-07-14T23:10:15.926789Z","end":"2026-07-14T23:10:16.082939Z","steps":["trace[1748650464] 'process raft request' (duration: 156.057132ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.083008Z","caller":"traceutil/trace.go:171","msg":"trace[1886384580] linearizableReadLoop","detail":"{readStateIndex:4716; appliedIndex:4713; }","duration":"155.08359ms","start":"2026-07-14T23:10:15.927883Z","end":"2026-07-14T23:10:16.082966Z","steps":["trace[1886384580] 'read index received' (duration: 28.952835ms)","trace[1886384580] 'applied index is now lower than readState.Index' (duration: 126.129925ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:16.082987Z","caller":"traceutil/trace.go:171","msg":"trace[723904635] transaction","detail":"{read_only:false; response_revision:4538; number_of_response:1; }","duration":"154.201039ms","start":"2026-07-14T23:10:15.928759Z","end":"2026-07-14T23:10:16.08296Z","steps":["trace[723904635] 'process raft request' (duration: 154.109477ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.083031Z","caller":"traceutil/trace.go:171","msg":"trace[1062003296] transaction","detail":"{read_only:false; response_revision:4539; number_of_response:1; }","duration":"154.187039ms","start":"2026-07-14T23:10:15.928834Z","end":"2026-07-14T23:10:16.083021Z","steps":["trace[1062003296] 'process raft request' (duration: 154.058306ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:16.08382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.179253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-07-14T23:10:16.083888Z","caller":"traceutil/trace.go:171","msg":"trace[1603546443] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4540; }","duration":"152.266464ms","start":"2026-07-14T23:10:15.931604Z","end":"2026-07-14T23:10:16.083871Z","steps":["trace[1603546443] 'agreement among raft nodes before linearized reading' (duration: 152.024229ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.28272Z","caller":"traceutil/trace.go:171","msg":"trace[1093842591] linearizableReadLoop","detail":"{readStateIndex:4723; appliedIndex:4722; }","duration":"101.527728ms","start":"2026-07-14T23:10:16.181138Z","end":"2026-07-14T23:10:16.282666Z","steps":["trace[1093842591] 'read index received' (duration: 101.330333ms)","trace[1093842591] 'applied index is now lower than readState.Index' (duration: 196.305µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:16.282915Z","caller":"traceutil/trace.go:171","msg":"trace[1120044992] transaction","detail":"{read_only:false; response_revision:4544; number_of_response:1; }","duration":"107.702828ms","start":"2026-07-14T23:10:16.175074Z","end":"2026-07-14T23:10:16.282777Z","steps":["trace[1120044992] 'process raft request' (duration: 107.435692ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:16.283023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.855965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-07-14T23:10:16.283101Z","caller":"traceutil/trace.go:171","msg":"trace[1750178565] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4544; }","duration":"101.960528ms","start":"2026-07-14T23:10:16.181115Z","end":"2026-07-14T23:10:16.283075Z","steps":["trace[1750178565] 'agreement among raft nodes before linearized reading' (duration: 101.727633ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.4698Z","caller":"traceutil/trace.go:171","msg":"trace[685130599] linearizableReadLoop","detail":"{readStateIndex:4724; appliedIndex:4723; }","duration":"173.781067ms","start":"2026-07-14T23:10:16.295997Z","end":"2026-07-14T23:10:16.469778Z","steps":["trace[685130599] 'read index received' (duration: 173.702936ms)","trace[685130599] 'applied index is now lower than readState.Index' (duration: 76.991µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:16.469948Z","caller":"traceutil/trace.go:171","msg":"trace[1726455023] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"174.698128ms","start":"2026-07-14T23:10:16.295123Z","end":"2026-07-14T23:10:16.469821Z","steps":["trace[1726455023] 'process raft request' (duration: 174.504924ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:16.47001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.991773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-07-14T23:10:16.470062Z","caller":"traceutil/trace.go:171","msg":"trace[1446505920] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4545; }","duration":"174.091805ms","start":"2026-07-14T23:10:16.295957Z","end":"2026-07-14T23:10:16.470049Z","steps":["trace[1446505920] 'agreement among raft nodes before linearized reading' (duration: 173.931231ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.488357Z","caller":"traceutil/trace.go:171","msg":"trace[1007815803] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4545; }","duration":"190.298946ms","start":"2026-07-14T23:10:16.29803Z","end":"2026-07-14T23:10:16.488328Z","steps":["trace[1007815803] 'process raft request' (duration: 190.08818ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.488732Z","caller":"traceutil/trace.go:171","msg":"trace[468434342] transaction","detail":"{read_only:false; response_revision:4546; number_of_response:1; }","duration":"134.663295ms","start":"2026-07-14T23:10:16.354043Z","end":"2026-07-14T23:10:16.488706Z","steps":["trace[468434342] 'process raft request' (duration: 134.170824ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:16.489544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.681044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60488"} {"level":"info","ts":"2026-07-14T23:10:16.489571Z","caller":"traceutil/trace.go:171","msg":"trace[1971319955] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4547; }","duration":"190.745545ms","start":"2026-07-14T23:10:16.298818Z","end":"2026-07-14T23:10:16.489564Z","steps":["trace[1971319955] 'agreement among raft nodes before linearized reading' (duration: 189.920287ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:16.489614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.895116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-rqhnj\" ","response":"range_response_count:1 size:9753"} {"level":"info","ts":"2026-07-14T23:10:16.489702Z","caller":"traceutil/trace.go:171","msg":"trace[1269400210] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-rqhnj; range_end:; response_count:1; response_revision:4547; }","duration":"102.020289ms","start":"2026-07-14T23:10:16.387662Z","end":"2026-07-14T23:10:16.489682Z","steps":["trace[1269400210] 'agreement among raft nodes before linearized reading' (duration: 100.752291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:16.489884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.314298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-07-14T23:10:16.489906Z","caller":"traceutil/trace.go:171","msg":"trace[1725263758] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4547; }","duration":"191.37461ms","start":"2026-07-14T23:10:16.298526Z","end":"2026-07-14T23:10:16.4899Z","steps":["trace[1725263758] 'agreement among raft nodes before linearized reading' (duration: 190.008759ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:16.495791Z","caller":"traceutil/trace.go:171","msg":"trace[48234640] transaction","detail":"{read_only:false; response_revision:4547; number_of_response:1; }","duration":"107.011303ms","start":"2026-07-14T23:10:16.388736Z","end":"2026-07-14T23:10:16.495747Z","steps":["trace[48234640] 'process raft request' (duration: 99.555494ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:22.692551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.114681ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-14T23:10:22.693106Z","caller":"traceutil/trace.go:171","msg":"trace[1495715811] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"228.595557ms","start":"2026-07-14T23:10:22.464487Z","end":"2026-07-14T23:10:22.693082Z","steps":["trace[1495715811] 'process raft request' (duration: 52.861302ms)","trace[1495715811] 'compare' (duration: 174.942188ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:22.693237Z","caller":"traceutil/trace.go:171","msg":"trace[49986838] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"114.14438ms","start":"2026-07-14T23:10:22.579073Z","end":"2026-07-14T23:10:22.693218Z","steps":["trace[49986838] 'process raft request' (duration: 113.593737ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:22.898155Z","caller":"traceutil/trace.go:171","msg":"trace[1806272497] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"201.702312ms","start":"2026-07-14T23:10:22.696429Z","end":"2026-07-14T23:10:22.898131Z","steps":["trace[1806272497] 'process raft request' (duration: 167.626136ms)","trace[1806272497] 'compare' (duration: 33.982314ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:22.939772Z","caller":"traceutil/trace.go:171","msg":"trace[2017485817] linearizableReadLoop","detail":"{readStateIndex:4838; appliedIndex:4835; }","duration":"227.31196ms","start":"2026-07-14T23:10:22.712445Z","end":"2026-07-14T23:10:22.939757Z","steps":["trace[2017485817] 'read index received' (duration: 151.707794ms)","trace[2017485817] 'applied index is now lower than readState.Index' (duration: 75.603376ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:22.939777Z","caller":"traceutil/trace.go:171","msg":"trace[868508142] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"242.807774ms","start":"2026-07-14T23:10:22.696935Z","end":"2026-07-14T23:10:22.939743Z","steps":["trace[868508142] 'process raft request' (duration: 242.561737ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:22.93996Z","caller":"traceutil/trace.go:171","msg":"trace[1961137960] transaction","detail":"{read_only:false; response_revision:4657; number_of_response:1; }","duration":"241.318381ms","start":"2026-07-14T23:10:22.698495Z","end":"2026-07-14T23:10:22.939814Z","steps":["trace[1961137960] 'process raft request' (duration: 241.142536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:22.940021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.564336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-50cb5fe9-d38f-440d-b532-e71462be56e0\" ","response":"range_response_count:1 size:3765"} {"level":"info","ts":"2026-07-14T23:10:22.940235Z","caller":"traceutil/trace.go:171","msg":"trace[8462032] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-50cb5fe9-d38f-440d-b532-e71462be56e0; range_end:; response_count:1; response_revision:4658; }","duration":"227.805081ms","start":"2026-07-14T23:10:22.71241Z","end":"2026-07-14T23:10:22.940215Z","steps":["trace[8462032] 'agreement among raft nodes before linearized reading' (duration: 227.516365ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:23.348745Z","caller":"traceutil/trace.go:171","msg":"trace[1882044539] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"103.903032ms","start":"2026-07-14T23:10:23.244821Z","end":"2026-07-14T23:10:23.348724Z","steps":["trace[1882044539] 'process raft request' (duration: 81.728053ms)","trace[1882044539] 'compare' (duration: 21.953364ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:35.791627Z","caller":"traceutil/trace.go:171","msg":"trace[519176576] linearizableReadLoop","detail":"{readStateIndex:5028; appliedIndex:5027; }","duration":"168.200574ms","start":"2026-07-14T23:10:35.623402Z","end":"2026-07-14T23:10:35.791603Z","steps":["trace[519176576] 'read index received' (duration: 168.046541ms)","trace[519176576] 'applied index is now lower than readState.Index' (duration: 152.833µs)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:10:35.791758Z","caller":"traceutil/trace.go:171","msg":"trace[565015597] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"227.746344ms","start":"2026-07-14T23:10:35.563987Z","end":"2026-07-14T23:10:35.791733Z","steps":["trace[565015597] 'process raft request' (duration: 227.444698ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:10:35.791927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.51261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-14T23:10:35.79197Z","caller":"traceutil/trace.go:171","msg":"trace[1435719565] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4840; }","duration":"168.605093ms","start":"2026-07-14T23:10:35.623352Z","end":"2026-07-14T23:10:35.791957Z","steps":["trace[1435719565] 'agreement among raft nodes before linearized reading' (duration: 168.451419ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:10:37.041599Z","caller":"traceutil/trace.go:171","msg":"trace[238030504] transaction","detail":"{read_only:false; response_revision:4851; number_of_response:1; }","duration":"147.422753ms","start":"2026-07-14T23:10:36.894136Z","end":"2026-07-14T23:10:37.041559Z","steps":["trace[238030504] 'process raft request' (duration: 147.172918ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:11:00.981566Z","caller":"traceutil/trace.go:171","msg":"trace[690596124] linearizableReadLoop","detail":"{readStateIndex:5198; appliedIndex:5197; }","duration":"104.293431ms","start":"2026-07-14T23:11:00.877248Z","end":"2026-07-14T23:11:00.981541Z","steps":["trace[690596124] 'read index received' (duration: 104.029076ms)","trace[690596124] 'applied index is now lower than readState.Index' (duration: 263.345µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:11:00.981814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.554246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-07-14T23:11:00.98186Z","caller":"traceutil/trace.go:171","msg":"trace[1180468533] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5005; }","duration":"104.648157ms","start":"2026-07-14T23:11:00.877199Z","end":"2026-07-14T23:11:00.981848Z","steps":["trace[1180468533] 'agreement among raft nodes before linearized reading' (duration: 104.442013ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:11:00.982213Z","caller":"traceutil/trace.go:171","msg":"trace[1802352086] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"165.45343ms","start":"2026-07-14T23:11:00.816746Z","end":"2026-07-14T23:11:00.9822Z","steps":["trace[1802352086] 'process raft request' (duration: 164.607784ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:11:07.653475Z","caller":"traceutil/trace.go:171","msg":"trace[734973786] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"121.72535ms","start":"2026-07-14T23:11:07.531536Z","end":"2026-07-14T23:11:07.653261Z","steps":["trace[734973786] 'process raft request' (duration: 31.460139ms)","trace[734973786] 'compare' (duration: 90.105278ms)"],"step_count":2} {"level":"info","ts":"2026-07-14T23:12:11.905541Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2887} {"level":"info","ts":"2026-07-14T23:12:12.005296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2887,"took":"96.540426ms","hash":1241654489,"current-db-size-bytes":54894592,"current-db-size":"55 MB","current-db-size-in-use-bytes":29782016,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-14T23:12:12.005359Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1241654489,"revision":2887,"compact-revision":-1} {"level":"info","ts":"2026-07-14T23:14:16.096084Z","caller":"traceutil/trace.go:171","msg":"trace[779239082] transaction","detail":"{read_only:false; response_revision:6448; number_of_response:1; }","duration":"234.855955ms","start":"2026-07-14T23:14:15.861201Z","end":"2026-07-14T23:14:16.096057Z","steps":["trace[779239082] 'process raft request' (duration: 234.633573ms)"],"step_count":1} {"level":"warn","ts":"2026-07-14T23:14:16.096397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.112969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-14T23:14:16.096534Z","caller":"traceutil/trace.go:171","msg":"trace[1160850485] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:6448; }","duration":"233.306311ms","start":"2026-07-14T23:14:15.863206Z","end":"2026-07-14T23:14:16.096513Z","steps":["trace[1160850485] 'agreement among raft nodes before linearized reading' (duration: 233.083488ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:14:16.096183Z","caller":"traceutil/trace.go:171","msg":"trace[1854302761] linearizableReadLoop","detail":"{readStateIndex:6689; appliedIndex:6688; }","duration":"232.917297ms","start":"2026-07-14T23:14:15.863241Z","end":"2026-07-14T23:14:16.096158Z","steps":["trace[1854302761] 'read index received' (duration: 232.672514ms)","trace[1854302761] 'applied index is now lower than readState.Index' (duration: 242.123µs)"],"step_count":2} {"level":"warn","ts":"2026-07-14T23:14:16.128795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.950583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4859"} {"level":"info","ts":"2026-07-14T23:14:16.128922Z","caller":"traceutil/trace.go:171","msg":"trace[754178503] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6449; }","duration":"176.120194ms","start":"2026-07-14T23:14:15.952788Z","end":"2026-07-14T23:14:16.128908Z","steps":["trace[754178503] 'agreement among raft nodes before linearized reading' (duration: 175.581778ms)"],"step_count":1} {"level":"info","ts":"2026-07-14T23:17:11.912578Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5614} {"level":"info","ts":"2026-07-14T23:17:12.016157Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5614,"took":"102.38334ms","hash":1018241801,"current-db-size-bytes":54894592,"current-db-size":"55 MB","current-db-size-in-use-bytes":18386944,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-14T23:17:12.016216Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1018241801,"revision":5614,"compact-revision":2887}