{"level":"warn","ts":"2026-05-19T00:01:05.374765Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-19T00:01:05.374918Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246: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.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246: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-05-19T00:01:05.375044Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-19T00:01:05.37506Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]}
{"level":"info","ts":"2026-05-19T00:01:05.375086Z","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-05-19T00:01:05.376151Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]}
{"level":"info","ts":"2026-05-19T00:01:05.376252Z","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.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246: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-05-19T00:01:05.379917Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.397404ms"}
{"level":"info","ts":"2026-05-19T00:01:05.392041Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"}
{"level":"info","ts":"2026-05-19T00:01:05.39219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"}
{"level":"info","ts":"2026-05-19T00:01:05.392225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"}
{"level":"info","ts":"2026-05-19T00:01:05.392243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-19T00:01:05.392256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"}
{"level":"info","ts":"2026-05-19T00:01:05.392517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"}
{"level":"warn","ts":"2026-05-19T00:01:05.399723Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-19T00:01:05.401637Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-19T00:01:05.402947Z","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-05-19T00:01:05.404789Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-19T00:01:05.405004Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-19T00:01:05.405649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"}
{"level":"info","ts":"2026-05-19T00:01:05.405009Z","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-05-19T00:01:05.408537Z","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-05-19T00:01:05.408561Z","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-05-19T00:01:05.408655Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]}
{"level":"info","ts":"2026-05-19T00:01:05.410425Z","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-05-19T00:01:05.410661Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"}
{"level":"info","ts":"2026-05-19T00:01:05.410726Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"}
{"level":"info","ts":"2026-05-19T00:01:05.410941Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-19T00:01:05.410992Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-19T00:01:05.793314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"}
{"level":"info","ts":"2026-05-19T00:01:05.793477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-19T00:01:05.79354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"}
{"level":"info","ts":"2026-05-19T00:01:05.793591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"}
{"level":"info","ts":"2026-05-19T00:01:05.793625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"}
{"level":"info","ts":"2026-05-19T00:01:05.79367Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"}
{"level":"info","ts":"2026-05-19T00:01:05.793706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"}
{"level":"info","ts":"2026-05-19T00:01:05.794931Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-19T00:01:05.795019Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-19T00:01:05.795173Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-19T00:01:05.795307Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-19T00:01:05.795472Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-19T00:01:05.795548Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-19T00:01:05.796162Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-19T00:01:05.796252Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-19T00:01:05.796283Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-19T00:01:05.79704Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"}
{"level":"info","ts":"2026-05-19T00:01:05.798985Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-19T00:01:09.852478Z","caller":"traceutil/trace.go:171","msg":"trace[1468944975] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"126.942608ms","start":"2026-05-19T00:01:09.725507Z","end":"2026-05-19T00:01:09.852449Z","steps":["trace[1468944975] 'process raft request'  (duration: 79.623395ms)","trace[1468944975] 'compare'  (duration: 47.135231ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:01:10.865275Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836960590493086207,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-19T00:01:11.046085Z","caller":"traceutil/trace.go:171","msg":"trace[2113242105] linearizableReadLoop","detail":"{readStateIndex:220; appliedIndex:219; }","duration":"681.274803ms","start":"2026-05-19T00:01:10.364778Z","end":"2026-05-19T00:01:11.046053Z","steps":["trace[2113242105] 'read index received'  (duration: 681.123951ms)","trace[2113242105] 'applied index is now lower than readState.Index'  (duration: 149.342µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:01:11.046097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:10.265203Z","time spent":"780.888529ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-05-19T00:01:11.046291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.497585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3709"}
{"level":"info","ts":"2026-05-19T00:01:11.04637Z","caller":"traceutil/trace.go:171","msg":"trace[362243297] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:214; }","duration":"681.590006ms","start":"2026-05-19T00:01:10.364764Z","end":"2026-05-19T00:01:11.046354Z","steps":["trace[362243297] 'agreement among raft nodes before linearized reading'  (duration: 681.443745ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:11.046418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:10.36472Z","time spent":"681.686388ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3732,"request content":"key:\"/registry/minions/instance\" "}
{"level":"warn","ts":"2026-05-19T00:01:11.046605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.984771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:01:11.046658Z","caller":"traceutil/trace.go:171","msg":"trace[181372787] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:214; }","duration":"346.070332ms","start":"2026-05-19T00:01:10.700568Z","end":"2026-05-19T00:01:11.046638Z","steps":["trace[181372787] 'agreement among raft nodes before linearized reading'  (duration: 345.998731ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:11.046703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:10.700547Z","time spent":"346.146062ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-19T00:01:11.498442Z","caller":"traceutil/trace.go:171","msg":"trace[977216019] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"451.11246ms","start":"2026-05-19T00:01:11.047307Z","end":"2026-05-19T00:01:11.498419Z","steps":["trace[977216019] 'process raft request'  (duration: 365.824471ms)","trace[977216019] 'compare'  (duration: 85.178157ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:01:11.498774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:11.04728Z","time spent":"451.216762ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18b0ce773b9f0b36\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18b0ce773b9f0b36\" value_size:524 lease:1613588553638310403 >> failure:<>"}
{"level":"info","ts":"2026-05-19T00:01:11.572784Z","caller":"traceutil/trace.go:171","msg":"trace[1220511318] linearizableReadLoop","detail":"{readStateIndex:223; appliedIndex:220; }","duration":"490.026736ms","start":"2026-05-19T00:01:11.082717Z","end":"2026-05-19T00:01:11.572744Z","steps":["trace[1220511318] 'read index received'  (duration: 330.431318ms)","trace[1220511318] 'applied index is now lower than readState.Index'  (duration: 159.593938ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:01:11.57292Z","caller":"traceutil/trace.go:171","msg":"trace[1872721972] transaction","detail":"{read_only:false; response_revision:217; number_of_response:1; }","duration":"518.387447ms","start":"2026-05-19T00:01:11.054481Z","end":"2026-05-19T00:01:11.572869Z","steps":["trace[1872721972] 'process raft request'  (duration: 518.169325ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:11.572957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.222108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-05-19T00:01:11.573021Z","caller":"traceutil/trace.go:171","msg":"trace[1758972129] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:217; }","duration":"490.323259ms","start":"2026-05-19T00:01:11.082681Z","end":"2026-05-19T00:01:11.573005Z","steps":["trace[1758972129] 'agreement among raft nodes before linearized reading'  (duration: 490.189457ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:11.573083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:11.082671Z","time spent":"490.399ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}
{"level":"info","ts":"2026-05-19T00:01:11.573021Z","caller":"traceutil/trace.go:171","msg":"trace[2138450517] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"522.737729ms","start":"2026-05-19T00:01:11.050088Z","end":"2026-05-19T00:01:11.572825Z","steps":["trace[2138450517] 'process raft request'  (duration: 522.367485ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:11.573344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:11.054466Z","time spent":"518.538069ms","remote":"127.0.0.1:42266","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:210 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3969 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-05-19T00:01:11.573462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:11.050071Z","time spent":"523.241605ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:0 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<>"}
{"level":"info","ts":"2026-05-19T00:01:11.613519Z","caller":"traceutil/trace.go:171","msg":"trace[304716110] transaction","detail":"{read_only:false; response_revision:218; number_of_response:1; }","duration":"111.105771ms","start":"2026-05-19T00:01:11.50239Z","end":"2026-05-19T00:01:11.613495Z","steps":["trace[304716110] 'process raft request'  (duration: 105.340893ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:11.613775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.884984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"}
{"level":"info","ts":"2026-05-19T00:01:11.613834Z","caller":"traceutil/trace.go:171","msg":"trace[1375796920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:220; }","duration":"530.963184ms","start":"2026-05-19T00:01:11.082854Z","end":"2026-05-19T00:01:11.613817Z","steps":["trace[1375796920] 'agreement among raft nodes before linearized reading'  (duration: 530.844523ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:11.613873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:11.082848Z","time spent":"531.015315ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-19T00:01:11.613979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.70302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:01:11.614177Z","caller":"traceutil/trace.go:171","msg":"trace[1252898267] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:220; }","duration":"260.024564ms","start":"2026-05-19T00:01:11.35406Z","end":"2026-05-19T00:01:11.614084Z","steps":["trace[1252898267] 'agreement among raft nodes before linearized reading'  (duration: 259.631219ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:16.474322Z","caller":"traceutil/trace.go:171","msg":"trace[2018380991] linearizableReadLoop","detail":"{readStateIndex:360; appliedIndex:359; }","duration":"196.427808ms","start":"2026-05-19T00:01:16.277876Z","end":"2026-05-19T00:01:16.474304Z","steps":["trace[2018380991] 'read index received'  (duration: 196.347717ms)","trace[2018380991] 'applied index is now lower than readState.Index'  (duration: 79.421µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:01:16.474461Z","caller":"traceutil/trace.go:171","msg":"trace[1102016143] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"237.876245ms","start":"2026-05-19T00:01:16.236546Z","end":"2026-05-19T00:01:16.474423Z","steps":["trace[1102016143] 'process raft request'  (duration: 237.669703ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:16.474537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.64386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"info","ts":"2026-05-19T00:01:16.474569Z","caller":"traceutil/trace.go:171","msg":"trace[1831759526] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:347; }","duration":"196.687981ms","start":"2026-05-19T00:01:16.27787Z","end":"2026-05-19T00:01:16.474558Z","steps":["trace[1831759526] 'agreement among raft nodes before linearized reading'  (duration: 196.535689ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:16.474793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-05-19T00:01:16.474819Z","caller":"traceutil/trace.go:171","msg":"trace[901680508] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:347; }","duration":"145.65455ms","start":"2026-05-19T00:01:16.329158Z","end":"2026-05-19T00:01:16.474813Z","steps":["trace[901680508] 'agreement among raft nodes before linearized reading'  (duration: 145.61066ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.028692Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836960590493086498,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-19T00:01:17.105005Z","caller":"traceutil/trace.go:171","msg":"trace[256600155] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"625.104964ms","start":"2026-05-19T00:01:16.479871Z","end":"2026-05-19T00:01:17.104976Z","steps":["trace[256600155] 'process raft request'  (duration: 560.506578ms)","trace[256600155] 'compare'  (duration: 64.322213ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:01:17.105322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.479838Z","time spent":"625.336406ms","remote":"127.0.0.1:42182","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" value_size:1678 >> failure:<>"}
{"level":"info","ts":"2026-05-19T00:01:17.125008Z","caller":"traceutil/trace.go:171","msg":"trace[117126627] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"641.830181ms","start":"2026-05-19T00:01:16.483145Z","end":"2026-05-19T00:01:17.124975Z","steps":["trace[117126627] 'process raft request'  (duration: 641.644589ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.125145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.483131Z","time spent":"641.946102ms","remote":"127.0.0.1:42578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3642,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" mod_revision:0 > success:<request_put:<key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" value_size:3582 >> failure:<>"}
{"level":"info","ts":"2026-05-19T00:01:17.125137Z","caller":"traceutil/trace.go:171","msg":"trace[1870967049] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"641.74255ms","start":"2026-05-19T00:01:16.483343Z","end":"2026-05-19T00:01:17.125085Z","steps":["trace[1870967049] 'process raft request'  (duration: 641.552358ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.125314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.483333Z","time spent":"641.899802ms","remote":"127.0.0.1:42436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterroles/admin\" mod_revision:78 > success:<request_put:<key:\"/registry/clusterroles/admin\" value_size:863 >> failure:<request_range:<key:\"/registry/clusterroles/admin\" > >"}
{"level":"info","ts":"2026-05-19T00:01:17.125324Z","caller":"traceutil/trace.go:171","msg":"trace[335974855] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"641.702489ms","start":"2026-05-19T00:01:16.483596Z","end":"2026-05-19T00:01:17.125298Z","steps":["trace[335974855] 'process raft request'  (duration: 641.351426ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.125461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.483582Z","time spent":"641.80896ms","remote":"127.0.0.1:42436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterroles/view\" mod_revision:80 > success:<request_put:<key:\"/registry/clusterroles/view\" value_size:2059 >> failure:<request_range:<key:\"/registry/clusterroles/view\" > >"}
{"level":"info","ts":"2026-05-19T00:01:17.12594Z","caller":"traceutil/trace.go:171","msg":"trace[1469005370] linearizableReadLoop","detail":"{readStateIndex:366; appliedIndex:360; }","duration":"597.555013ms","start":"2026-05-19T00:01:16.528372Z","end":"2026-05-19T00:01:17.125927Z","steps":["trace[1469005370] 'read index received'  (duration: 512.052385ms)","trace[1469005370] 'applied index is now lower than readState.Index'  (duration: 85.501918ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:01:17.126239Z","caller":"traceutil/trace.go:171","msg":"trace[1635851910] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"642.056443ms","start":"2026-05-19T00:01:16.484152Z","end":"2026-05-19T00:01:17.126208Z","steps":["trace[1635851910] 'process raft request'  (duration: 641.095573ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.126473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.48414Z","time spent":"642.173284ms","remote":"127.0.0.1:42284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":156,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/serviceaccounts/default/default\" mod_revision:0 > success:<request_put:<key:\"/registry/serviceaccounts/default/default\" value_size:108 >> failure:<>"}
{"level":"warn","ts":"2026-05-19T00:01:17.126662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.284141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-05-19T00:01:17.126704Z","caller":"traceutil/trace.go:171","msg":"trace[46819630] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"642.174564ms","start":"2026-05-19T00:01:16.484516Z","end":"2026-05-19T00:01:17.12669Z","steps":["trace[46819630] 'process raft request'  (duration: 641.368676ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:17.126723Z","caller":"traceutil/trace.go:171","msg":"trace[1029807372] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:353; }","duration":"598.440172ms","start":"2026-05-19T00:01:16.528269Z","end":"2026-05-19T00:01:17.126709Z","steps":["trace[1029807372] 'agreement among raft nodes before linearized reading'  (duration: 598.23502ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.126764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.528254Z","time spent":"598.501873ms","remote":"127.0.0.1:42284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "}
{"level":"warn","ts":"2026-05-19T00:01:17.126788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.484506Z","time spent":"642.237155ms","remote":"127.0.0.1:42436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/clusterroles/edit\" mod_revision:79 > success:<request_put:<key:\"/registry/clusterroles/edit\" value_size:2156 >> failure:<request_range:<key:\"/registry/clusterroles/edit\" > >"}
{"level":"warn","ts":"2026-05-19T00:01:17.143872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.525088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"warn","ts":"2026-05-19T00:01:17.143893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.790758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-05-19T00:01:17.143915Z","caller":"traceutil/trace.go:171","msg":"trace[2021903078] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:354; }","duration":"365.610219ms","start":"2026-05-19T00:01:16.778294Z","end":"2026-05-19T00:01:17.143904Z","steps":["trace[2021903078] 'agreement among raft nodes before linearized reading'  (duration: 365.540958ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:17.143939Z","caller":"traceutil/trace.go:171","msg":"trace[2093852409] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:354; }","duration":"465.8621ms","start":"2026-05-19T00:01:16.678063Z","end":"2026-05-19T00:01:17.143925Z","steps":["trace[2093852409] 'agreement among raft nodes before linearized reading'  (duration: 465.762949ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.143942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.778271Z","time spent":"365.665879ms","remote":"127.0.0.1:42284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "}
{"level":"warn","ts":"2026-05-19T00:01:17.143965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.67805Z","time spent":"465.90953ms","remote":"127.0.0.1:42284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "}
{"level":"warn","ts":"2026-05-19T00:01:17.144044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.570336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-05-19T00:01:17.144066Z","caller":"traceutil/trace.go:171","msg":"trace[1816781548] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:354; }","duration":"515.625666ms","start":"2026-05-19T00:01:16.628435Z","end":"2026-05-19T00:01:17.144061Z","steps":["trace[1816781548] 'agreement among raft nodes before linearized reading'  (duration: 515.590676ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.14408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.748179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"}
{"level":"warn","ts":"2026-05-19T00:01:17.144083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.628419Z","time spent":"515.660257ms","remote":"127.0.0.1:42284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "}
{"level":"info","ts":"2026-05-19T00:01:17.144132Z","caller":"traceutil/trace.go:171","msg":"trace[817646123] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:354; }","duration":"414.798299ms","start":"2026-05-19T00:01:16.729298Z","end":"2026-05-19T00:01:17.144097Z","steps":["trace[817646123] 'agreement among raft nodes before linearized reading'  (duration: 414.482285ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.144156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.729283Z","time spent":"414.869449ms","remote":"127.0.0.1:42284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":218,"request content":"key:\"/registry/serviceaccounts/kube-system/node-controller\" "}
{"level":"warn","ts":"2026-05-19T00:01:17.144609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.492244ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"}
{"level":"info","ts":"2026-05-19T00:01:17.144785Z","caller":"traceutil/trace.go:171","msg":"trace[1048037089] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:354; }","duration":"565.721837ms","start":"2026-05-19T00:01:16.579043Z","end":"2026-05-19T00:01:17.144765Z","steps":["trace[1048037089] 'agreement among raft nodes before linearized reading'  (duration: 565.014669ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:17.144886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:16.579022Z","time spent":"565.850168ms","remote":"127.0.0.1:42284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "}
{"level":"info","ts":"2026-05-19T00:01:43.913951Z","caller":"traceutil/trace.go:171","msg":"trace[1605533987] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"219.44063ms","start":"2026-05-19T00:01:43.694473Z","end":"2026-05-19T00:01:43.913913Z","steps":["trace[1605533987] 'process raft request'  (duration: 218.852006ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:44.216847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.040694ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960590493086985 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:605 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-19T00:01:44.21697Z","caller":"traceutil/trace.go:171","msg":"trace[1726998075] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"288.484228ms","start":"2026-05-19T00:01:43.928469Z","end":"2026-05-19T00:01:44.216953Z","steps":["trace[1726998075] 'read index received'  (duration: 129.018971ms)","trace[1726998075] 'applied index is now lower than readState.Index'  (duration: 159.464087ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:01:44.216987Z","caller":"traceutil/trace.go:171","msg":"trace[140634424] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"298.486425ms","start":"2026-05-19T00:01:43.918469Z","end":"2026-05-19T00:01:44.216955Z","steps":["trace[140634424] 'process raft request'  (duration: 139.112489ms)","trace[140634424] 'compare'  (duration: 158.924133ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:01:44.217152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.67807ms","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-05-19T00:01:44.217188Z","caller":"traceutil/trace.go:171","msg":"trace[2075606352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"288.74133ms","start":"2026-05-19T00:01:43.928437Z","end":"2026-05-19T00:01:44.217178Z","steps":["trace[2075606352] 'agreement among raft nodes before linearized reading'  (duration: 288.587589ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:44.74901Z","caller":"traceutil/trace.go:171","msg":"trace[49641774] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"528.014731ms","start":"2026-05-19T00:01:44.220972Z","end":"2026-05-19T00:01:44.748987Z","steps":["trace[49641774] 'process raft request'  (duration: 527.95455ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:44.749005Z","caller":"traceutil/trace.go:171","msg":"trace[1537108522] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"784.531752ms","start":"2026-05-19T00:01:43.964444Z","end":"2026-05-19T00:01:44.748976Z","steps":["trace[1537108522] 'process raft request'  (duration: 784.3484ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:44.749065Z","caller":"traceutil/trace.go:171","msg":"trace[1666259087] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:646; }","duration":"532.029711ms","start":"2026-05-19T00:01:44.216997Z","end":"2026-05-19T00:01:44.749026Z","steps":["trace[1666259087] 'read index received'  (duration: 480.667119ms)","trace[1666259087] 'applied index is now lower than readState.Index'  (duration: 51.359302ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:01:44.749175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:44.220951Z","time spent":"528.136351ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:606 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:370 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-19T00:01:44.749251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:43.964414Z","time spent":"784.688284ms","remote":"127.0.0.1:42610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" value_size:1527 >> failure:<>"}
{"level":"warn","ts":"2026-05-19T00:01:44.74941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.982836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-19T00:01:44.749401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.878239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-klbkq\" ","response":"range_response_count:1 size:16965"}
{"level":"warn","ts":"2026-05-19T00:01:44.749434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.518412ms","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-05-19T00:01:44.749465Z","caller":"traceutil/trace.go:171","msg":"trace[1928585997] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"293.071467ms","start":"2026-05-19T00:01:44.456376Z","end":"2026-05-19T00:01:44.749448Z","steps":["trace[1928585997] 'agreement among raft nodes before linearized reading'  (duration: 292.975326ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:44.749483Z","caller":"traceutil/trace.go:171","msg":"trace[795649655] range","detail":"{range_begin:/registry/pods/kube-system/cilium-klbkq; range_end:; response_count:1; response_revision:622; }","duration":"558.014189ms","start":"2026-05-19T00:01:44.191447Z","end":"2026-05-19T00:01:44.749461Z","steps":["trace[795649655] 'agreement among raft nodes before linearized reading'  (duration: 557.831768ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:44.749491Z","caller":"traceutil/trace.go:171","msg":"trace[297566732] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:622; }","duration":"819.608162ms","start":"2026-05-19T00:01:43.929869Z","end":"2026-05-19T00:01:44.749477Z","steps":["trace[297566732] 'agreement among raft nodes before linearized reading'  (duration: 819.34596ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:44.749531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:44.191429Z","time spent":"558.09277ms","remote":"127.0.0.1:42270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-klbkq\" "}
{"level":"warn","ts":"2026-05-19T00:01:44.749554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:43.929865Z","time spent":"819.670173ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-19T00:01:44.749555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.113196ms","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-05-19T00:01:44.749638Z","caller":"traceutil/trace.go:171","msg":"trace[1009320987] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:622; }","duration":"820.216328ms","start":"2026-05-19T00:01:43.929401Z","end":"2026-05-19T00:01:44.749617Z","steps":["trace[1009320987] 'agreement among raft nodes before linearized reading'  (duration: 819.999696ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:44.749677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:43.929394Z","time spent":"820.274448ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-19T00:01:45.729293Z","caller":"traceutil/trace.go:171","msg":"trace[1507866007] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"541.066662ms","start":"2026-05-19T00:01:45.188098Z","end":"2026-05-19T00:01:45.729164Z","steps":["trace[1507866007] 'process raft request'  (duration: 539.699392ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:01:45.72948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:01:45.188074Z","time spent":"541.309444ms","remote":"127.0.0.1:42178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:619 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036221 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-19T00:01:47.627228Z","caller":"traceutil/trace.go:171","msg":"trace[368727708] linearizableReadLoop","detail":"{readStateIndex:674; appliedIndex:673; }","duration":"172.988356ms","start":"2026-05-19T00:01:47.454205Z","end":"2026-05-19T00:01:47.627194Z","steps":["trace[368727708] 'read index received'  (duration: 172.384121ms)","trace[368727708] 'applied index is now lower than readState.Index'  (duration: 601.175µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:01:47.62749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.259658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:01:47.627587Z","caller":"traceutil/trace.go:171","msg":"trace[875949237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"173.415719ms","start":"2026-05-19T00:01:47.45416Z","end":"2026-05-19T00:01:47.627576Z","steps":["trace[875949237] 'agreement among raft nodes before linearized reading'  (duration: 173.218448ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:47.627593Z","caller":"traceutil/trace.go:171","msg":"trace[38446800] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"196.737113ms","start":"2026-05-19T00:01:47.430786Z","end":"2026-05-19T00:01:47.627523Z","steps":["trace[38446800] 'process raft request'  (duration: 195.823386ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:01:48.593554Z","caller":"traceutil/trace.go:171","msg":"trace[1292147657] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"103.951907ms","start":"2026-05-19T00:01:48.489571Z","end":"2026-05-19T00:01:48.593523Z","steps":["trace[1292147657] 'process raft request'  (duration: 103.819476ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:02:02.622543Z","caller":"traceutil/trace.go:171","msg":"trace[1887881661] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"856.917781ms","start":"2026-05-19T00:02:01.765596Z","end":"2026-05-19T00:02:02.622514Z","steps":["trace[1887881661] 'process raft request'  (duration: 856.7365ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:02:02.622767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:02:01.765579Z","time spent":"857.070772ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:771 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >"}
{"level":"info","ts":"2026-05-19T00:02:02.62626Z","caller":"traceutil/trace.go:171","msg":"trace[550921320] linearizableReadLoop","detail":"{readStateIndex:817; appliedIndex:815; }","duration":"254.505749ms","start":"2026-05-19T00:02:02.371734Z","end":"2026-05-19T00:02:02.62624Z","steps":["trace[550921320] 'read index received'  (duration: 250.729504ms)","trace[550921320] 'applied index is now lower than readState.Index'  (duration: 3.775235ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:02:02.626523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.779991ms","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-05-19T00:02:02.626795Z","caller":"traceutil/trace.go:171","msg":"trace[2126335935] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:786; }","duration":"255.071933ms","start":"2026-05-19T00:02:02.371702Z","end":"2026-05-19T00:02:02.626774Z","steps":["trace[2126335935] 'agreement among raft nodes before linearized reading'  (duration: 254.68885ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:02:02.626903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.548626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-s58st\" ","response":"range_response_count:1 size:5050"}
{"level":"info","ts":"2026-05-19T00:02:02.62706Z","caller":"traceutil/trace.go:171","msg":"trace[1590287019] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-s58st; range_end:; response_count:1; response_revision:786; }","duration":"252.712057ms","start":"2026-05-19T00:02:02.374329Z","end":"2026-05-19T00:02:02.627041Z","steps":["trace[1590287019] 'agreement among raft nodes before linearized reading'  (duration: 252.469316ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:02:02.626316Z","caller":"traceutil/trace.go:171","msg":"trace[1011389879] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"317.793922ms","start":"2026-05-19T00:02:02.30849Z","end":"2026-05-19T00:02:02.626284Z","steps":["trace[1011389879] 'process raft request'  (duration: 317.627791ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:02:02.627477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:02:02.308468Z","time spent":"318.834389ms","remote":"127.0.0.1:42322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:632 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2707 >> failure:<request_range:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" > >"}
{"level":"info","ts":"2026-05-19T00:02:31.013482Z","caller":"traceutil/trace.go:171","msg":"trace[1270879412] linearizableReadLoop","detail":"{readStateIndex:1223; appliedIndex:1222; }","duration":"228.664405ms","start":"2026-05-19T00:02:30.784796Z","end":"2026-05-19T00:02:31.013461Z","steps":["trace[1270879412] 'read index received'  (duration: 228.477298ms)","trace[1270879412] 'applied index is now lower than readState.Index'  (duration: 186.327µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:02:31.013558Z","caller":"traceutil/trace.go:171","msg":"trace[509387017] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"230.091916ms","start":"2026-05-19T00:02:30.783426Z","end":"2026-05-19T00:02:31.013518Z","steps":["trace[509387017] 'process raft request'  (duration: 229.905518ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:02:31.013701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.890125ms","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-05-19T00:02:31.013746Z","caller":"traceutil/trace.go:171","msg":"trace[1218225904] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1185; }","duration":"228.994859ms","start":"2026-05-19T00:02:30.78474Z","end":"2026-05-19T00:02:31.013735Z","steps":["trace[1218225904] 'agreement among raft nodes before linearized reading'  (duration: 228.841723ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:02:31.160403Z","caller":"traceutil/trace.go:171","msg":"trace[1669277480] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"140.478573ms","start":"2026-05-19T00:02:31.019899Z","end":"2026-05-19T00:02:31.160378Z","steps":["trace[1669277480] 'process raft request'  (duration: 140.393649ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:02:31.160465Z","caller":"traceutil/trace.go:171","msg":"trace[988105680] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"142.931803ms","start":"2026-05-19T00:02:31.017468Z","end":"2026-05-19T00:02:31.1604Z","steps":["trace[988105680] 'process raft request'  (duration: 93.024796ms)","trace[988105680] 'compare'  (duration: 49.596055ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:02:31.160714Z","caller":"traceutil/trace.go:171","msg":"trace[1308477036] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"141.3972ms","start":"2026-05-19T00:02:31.019293Z","end":"2026-05-19T00:02:31.16069Z","steps":["trace[1308477036] 'process raft request'  (duration: 140.967483ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:02:31.160711Z","caller":"traceutil/trace.go:171","msg":"trace[1675005382] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"141.438232ms","start":"2026-05-19T00:02:31.019238Z","end":"2026-05-19T00:02:31.160676Z","steps":["trace[1675005382] 'process raft request'  (duration: 140.975083ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:02:51.819772Z","caller":"traceutil/trace.go:171","msg":"trace[309851625] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"164.186363ms","start":"2026-05-19T00:02:51.655567Z","end":"2026-05-19T00:02:51.819753Z","steps":["trace[309851625] 'process raft request'  (duration: 164.055398ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:16.257172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.68053ms","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-05-19T00:03:16.257292Z","caller":"traceutil/trace.go:171","msg":"trace[1088676171] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1835; }","duration":"236.812013ms","start":"2026-05-19T00:03:16.020462Z","end":"2026-05-19T00:03:16.257274Z","steps":["trace[1088676171] 'range keys from in-memory index tree'  (duration: 236.6659ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:16.257306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.273813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b0ce95698a5497\" ","response":"range_response_count:1 size:982"}
{"level":"info","ts":"2026-05-19T00:03:16.257402Z","caller":"traceutil/trace.go:171","msg":"trace[376778031] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b0ce95698a5497; range_end:; response_count:1; response_revision:1835; }","duration":"484.433857ms","start":"2026-05-19T00:03:15.772946Z","end":"2026-05-19T00:03:16.25738Z","steps":["trace[376778031] 'range keys from in-memory index tree'  (duration: 484.086568ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:16.257449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:03:15.772924Z","time spent":"484.514819ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":1005,"request content":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18b0ce95698a5497\" "}
{"level":"info","ts":"2026-05-19T00:03:16.265287Z","caller":"traceutil/trace.go:171","msg":"trace[1849102816] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1909; }","duration":"294.950362ms","start":"2026-05-19T00:03:15.970313Z","end":"2026-05-19T00:03:16.265263Z","steps":["trace[1849102816] 'read index received'  (duration: 294.795528ms)","trace[1849102816] 'applied index is now lower than readState.Index'  (duration: 153.684µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:03:16.265553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.232919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9246a7a0-9e9a-4c7c-b7a4-dc7551445e69\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-19T00:03:16.265605Z","caller":"traceutil/trace.go:171","msg":"trace[642089955] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9246a7a0-9e9a-4c7c-b7a4-dc7551445e69; range_end:; response_count:1; response_revision:1836; }","duration":"295.338852ms","start":"2026-05-19T00:03:15.970254Z","end":"2026-05-19T00:03:16.265593Z","steps":["trace[642089955] 'agreement among raft nodes before linearized reading'  (duration: 295.155487ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:03:16.265902Z","caller":"traceutil/trace.go:171","msg":"trace[1825539410] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"352.39295ms","start":"2026-05-19T00:03:15.912958Z","end":"2026-05-19T00:03:16.265351Z","steps":["trace[1825539410] 'process raft request'  (duration: 352.168104ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:16.266099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:03:15.912933Z","time spent":"353.008925ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:1779 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-05-19T00:03:16.505398Z","caller":"traceutil/trace.go:171","msg":"trace[1721304885] linearizableReadLoop","detail":"{readStateIndex:1911; appliedIndex:1910; }","duration":"239.950903ms","start":"2026-05-19T00:03:16.265414Z","end":"2026-05-19T00:03:16.505365Z","steps":["trace[1721304885] 'read index received'  (duration: 232.076523ms)","trace[1721304885] 'applied index is now lower than readState.Index'  (duration: 7.87254ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:03:16.505702Z","caller":"traceutil/trace.go:171","msg":"trace[1795456429] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"245.836143ms","start":"2026-05-19T00:03:16.259792Z","end":"2026-05-19T00:03:16.505628Z","steps":["trace[1795456429] 'process raft request'  (duration: 237.720966ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:16.505743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.849721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-19T00:03:16.505826Z","caller":"traceutil/trace.go:171","msg":"trace[1381491254] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"146.989694ms","start":"2026-05-19T00:03:16.358815Z","end":"2026-05-19T00:03:16.505805Z","steps":["trace[1381491254] 'agreement among raft nodes before linearized reading'  (duration: 146.798079ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:16.506133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.703161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-19T00:03:16.50621Z","caller":"traceutil/trace.go:171","msg":"trace[35562331] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"408.825944ms","start":"2026-05-19T00:03:16.097365Z","end":"2026-05-19T00:03:16.506191Z","steps":["trace[35562331] 'agreement among raft nodes before linearized reading'  (duration: 408.552857ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:16.506248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:03:16.097343Z","time spent":"408.895966ms","remote":"127.0.0.1:52832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-05-19T00:03:16.506244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.837022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-19T00:03:16.506319Z","caller":"traceutil/trace.go:171","msg":"trace[407634927] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1837; }","duration":"117.950535ms","start":"2026-05-19T00:03:16.38835Z","end":"2026-05-19T00:03:16.506301Z","steps":["trace[407634927] 'agreement among raft nodes before linearized reading'  (duration: 117.673558ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:16.799693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.736262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9246a7a0-9e9a-4c7c-b7a4-dc7551445e69\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-19T00:03:16.799774Z","caller":"traceutil/trace.go:171","msg":"trace[923703302] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9246a7a0-9e9a-4c7c-b7a4-dc7551445e69; range_end:; response_count:1; response_revision:1838; }","duration":"134.856736ms","start":"2026-05-19T00:03:16.664897Z","end":"2026-05-19T00:03:16.799753Z","steps":["trace[923703302] 'range keys from in-memory index tree'  (duration: 134.562138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:03:29.589975Z","caller":"traceutil/trace.go:171","msg":"trace[611988293] transaction","detail":"{read_only:false; response_revision:1950; number_of_response:1; }","duration":"162.154412ms","start":"2026-05-19T00:03:29.427799Z","end":"2026-05-19T00:03:29.589953Z","steps":["trace[611988293] 'process raft request'  (duration: 161.942157ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:50.820598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.200595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-19T00:03:50.820685Z","caller":"traceutil/trace.go:171","msg":"trace[172176630] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2081; }","duration":"103.367748ms","start":"2026-05-19T00:03:50.717294Z","end":"2026-05-19T00:03:50.820662Z","steps":["trace[172176630] 'range keys from in-memory index tree'  (duration: 102.995771ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:03:51.195074Z","caller":"traceutil/trace.go:171","msg":"trace[2077522027] transaction","detail":"{read_only:false; response_revision:2083; number_of_response:1; }","duration":"222.970752ms","start":"2026-05-19T00:03:50.972078Z","end":"2026-05-19T00:03:51.195049Z","steps":["trace[2077522027] 'process raft request'  (duration: 222.494453ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:51.649553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.171672ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960590493089995 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/openstack/percona-xtradb-pxc-0.18b0ce9e1c5c1344\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/percona-xtradb-pxc-0.18b0ce9e1c5c1344\" value_size:737 lease:1613588553638313443 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-19T00:03:51.649675Z","caller":"traceutil/trace.go:171","msg":"trace[1768550836] linearizableReadLoop","detail":"{readStateIndex:2166; appliedIndex:2165; }","duration":"257.442831ms","start":"2026-05-19T00:03:51.392209Z","end":"2026-05-19T00:03:51.649651Z","steps":["trace[1768550836] 'read index received'  (duration: 6.021934ms)","trace[1768550836] 'applied index is now lower than readState.Index'  (duration: 251.418937ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:03:51.649958Z","caller":"traceutil/trace.go:171","msg":"trace[1301659731] transaction","detail":"{read_only:false; response_revision:2084; number_of_response:1; }","duration":"360.579311ms","start":"2026-05-19T00:03:51.289335Z","end":"2026-05-19T00:03:51.649914Z","steps":["trace[1301659731] 'process raft request'  (duration: 108.980811ms)","trace[1301659731] 'compare'  (duration: 251.012549ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:03:51.650016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.380992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-19T00:03:51.650069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:03:51.289313Z","time spent":"360.711694ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":819,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/openstack/percona-xtradb-pxc-0.18b0ce9e1c5c1344\" mod_revision:0 > success:<request_put:<key:\"/registry/events/openstack/percona-xtradb-pxc-0.18b0ce9e1c5c1344\" value_size:737 lease:1613588553638313443 >> failure:<>"}
{"level":"info","ts":"2026-05-19T00:03:51.650107Z","caller":"traceutil/trace.go:171","msg":"trace[1660924686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2084; }","duration":"195.510385ms","start":"2026-05-19T00:03:51.454577Z","end":"2026-05-19T00:03:51.650087Z","steps":["trace[1660924686] 'agreement among raft nodes before linearized reading'  (duration: 195.341091ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:51.650249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.985961ms","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-05-19T00:03:51.650614Z","caller":"traceutil/trace.go:171","msg":"trace[112359853] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2084; }","duration":"258.257527ms","start":"2026-05-19T00:03:51.392157Z","end":"2026-05-19T00:03:51.650414Z","steps":["trace[112359853] 'agreement among raft nodes before linearized reading'  (duration: 257.840789ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:03:52.006219Z","caller":"traceutil/trace.go:171","msg":"trace[1094317114] transaction","detail":"{read_only:false; response_revision:2087; number_of_response:1; }","duration":"288.268397ms","start":"2026-05-19T00:03:51.717927Z","end":"2026-05-19T00:03:52.006195Z","steps":["trace[1094317114] 'process raft request'  (duration: 288.137434ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:03:52.007437Z","caller":"traceutil/trace.go:171","msg":"trace[977536549] linearizableReadLoop","detail":"{readStateIndex:2172; appliedIndex:2168; }","duration":"179.889688ms","start":"2026-05-19T00:03:51.827521Z","end":"2026-05-19T00:03:52.007411Z","steps":["trace[977536549] 'read index received'  (duration: 178.591363ms)","trace[977536549] 'applied index is now lower than readState.Index'  (duration: 1.297245ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:03:52.00788Z","caller":"traceutil/trace.go:171","msg":"trace[1918671571] transaction","detail":"{read_only:false; response_revision:2089; number_of_response:1; }","duration":"289.675403ms","start":"2026-05-19T00:03:51.718192Z","end":"2026-05-19T00:03:52.007868Z","steps":["trace[1918671571] 'process raft request'  (duration: 289.146663ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:03:52.007893Z","caller":"traceutil/trace.go:171","msg":"trace[2002153807] transaction","detail":"{read_only:false; response_revision:2088; number_of_response:1; }","duration":"289.714464ms","start":"2026-05-19T00:03:51.718132Z","end":"2026-05-19T00:03:52.007846Z","steps":["trace[2002153807] 'process raft request'  (duration: 289.072152ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:03:52.00802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.474978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"}
{"level":"info","ts":"2026-05-19T00:03:52.008066Z","caller":"traceutil/trace.go:171","msg":"trace[745917732] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2090; }","duration":"180.571511ms","start":"2026-05-19T00:03:51.827479Z","end":"2026-05-19T00:03:52.00805Z","steps":["trace[745917732] 'agreement among raft nodes before linearized reading'  (duration: 180.275685ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:03:52.008424Z","caller":"traceutil/trace.go:171","msg":"trace[446844330] transaction","detail":"{read_only:false; response_revision:2090; number_of_response:1; }","duration":"289.113463ms","start":"2026-05-19T00:03:51.718844Z","end":"2026-05-19T00:03:52.007957Z","steps":["trace[446844330] 'process raft request'  (duration: 288.533542ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:04:45.967524Z","caller":"traceutil/trace.go:171","msg":"trace[1344625754] transaction","detail":"{read_only:false; response_revision:2424; number_of_response:1; }","duration":"104.851014ms","start":"2026-05-19T00:04:45.862648Z","end":"2026-05-19T00:04:45.967499Z","steps":["trace[1344625754] 'process raft request'  (duration: 104.699681ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:04:56.601702Z","caller":"traceutil/trace.go:171","msg":"trace[1178847127] transaction","detail":"{read_only:false; response_revision:2531; number_of_response:1; }","duration":"298.277545ms","start":"2026-05-19T00:04:56.303401Z","end":"2026-05-19T00:04:56.601678Z","steps":["trace[1178847127] 'process raft request'  (duration: 298.101323ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:04:56.604533Z","caller":"traceutil/trace.go:171","msg":"trace[1427139131] linearizableReadLoop","detail":"{readStateIndex:2629; appliedIndex:2627; }","duration":"294.779358ms","start":"2026-05-19T00:04:56.309732Z","end":"2026-05-19T00:04:56.604511Z","steps":["trace[1427139131] 'read index received'  (duration: 291.738397ms)","trace[1427139131] 'applied index is now lower than readState.Index'  (duration: 3.040001ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:04:56.604706Z","caller":"traceutil/trace.go:171","msg":"trace[1530626792] transaction","detail":"{read_only:false; response_revision:2532; number_of_response:1; }","duration":"299.571902ms","start":"2026-05-19T00:04:56.305115Z","end":"2026-05-19T00:04:56.604687Z","steps":["trace[1530626792] 'process raft request'  (duration: 299.277948ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:04:56.604902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.098332ms","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-05-19T00:04:56.604975Z","caller":"traceutil/trace.go:171","msg":"trace[259446640] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2532; }","duration":"295.246204ms","start":"2026-05-19T00:04:56.309712Z","end":"2026-05-19T00:04:56.604958Z","steps":["trace[259446640] 'agreement among raft nodes before linearized reading'  (duration: 295.011961ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:04:56.605464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.056421ms","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-05-19T00:04:56.605548Z","caller":"traceutil/trace.go:171","msg":"trace[612982589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2532; }","duration":"295.155793ms","start":"2026-05-19T00:04:56.310346Z","end":"2026-05-19T00:04:56.605502Z","steps":["trace[612982589] 'agreement among raft nodes before linearized reading'  (duration: 294.997851ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:04:56.605816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.94617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:04:56.60609Z","caller":"traceutil/trace.go:171","msg":"trace[1893042664] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2532; }","duration":"158.033142ms","start":"2026-05-19T00:04:56.447813Z","end":"2026-05-19T00:04:56.605846Z","steps":["trace[1893042664] 'agreement among raft nodes before linearized reading'  (duration: 157.955611ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:05:27.899122Z","caller":"traceutil/trace.go:171","msg":"trace[1844920530] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"383.254251ms","start":"2026-05-19T00:05:27.515848Z","end":"2026-05-19T00:05:27.899102Z","steps":["trace[1844920530] 'process raft request'  (duration: 381.443879ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:05:27.899284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:05:27.515823Z","time spent":"383.385743ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2648 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"info","ts":"2026-05-19T00:05:27.899691Z","caller":"traceutil/trace.go:171","msg":"trace[841898090] linearizableReadLoop","detail":"{readStateIndex:2809; appliedIndex:2808; }","duration":"224.854769ms","start":"2026-05-19T00:05:27.674043Z","end":"2026-05-19T00:05:27.898898Z","steps":["trace[841898090] 'read index received'  (duration: 223.215819ms)","trace[841898090] 'applied index is now lower than readState.Index'  (duration: 1.63752ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:05:27.899806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.725249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-05-19T00:05:27.899877Z","caller":"traceutil/trace.go:171","msg":"trace[1778024516] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2705; }","duration":"225.854702ms","start":"2026-05-19T00:05:27.674003Z","end":"2026-05-19T00:05:27.899857Z","steps":["trace[1778024516] 'agreement among raft nodes before linearized reading'  (duration: 225.507567ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:05:27.899891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.739645ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-19T00:05:27.899937Z","caller":"traceutil/trace.go:171","msg":"trace[503948911] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2705; }","duration":"190.824676ms","start":"2026-05-19T00:05:27.709098Z","end":"2026-05-19T00:05:27.899923Z","steps":["trace[503948911] 'agreement among raft nodes before linearized reading'  (duration: 190.708945ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:05:28.033549Z","caller":"traceutil/trace.go:171","msg":"trace[602445553] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"129.672303ms","start":"2026-05-19T00:05:27.90385Z","end":"2026-05-19T00:05:28.033522Z","steps":["trace[602445553] 'process raft request'  (duration: 106.459582ms)","trace[602445553] 'compare'  (duration: 23.10381ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:06:44.537025Z","caller":"traceutil/trace.go:171","msg":"trace[1173475833] linearizableReadLoop","detail":"{readStateIndex:3228; appliedIndex:3226; }","duration":"115.593731ms","start":"2026-05-19T00:06:44.421408Z","end":"2026-05-19T00:06:44.537002Z","steps":["trace[1173475833] 'read index received'  (duration: 61.099478ms)","trace[1173475833] 'applied index is now lower than readState.Index'  (duration: 54.492883ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:06:44.537096Z","caller":"traceutil/trace.go:171","msg":"trace[825404997] transaction","detail":"{read_only:false; response_revision:3107; number_of_response:1; }","duration":"144.379493ms","start":"2026-05-19T00:06:44.392677Z","end":"2026-05-19T00:06:44.537057Z","steps":["trace[825404997] 'process raft request'  (duration: 144.200777ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:06:44.537264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.831599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-05-19T00:06:44.537312Z","caller":"traceutil/trace.go:171","msg":"trace[902984268] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:3107; }","duration":"115.928872ms","start":"2026-05-19T00:06:44.421366Z","end":"2026-05-19T00:06:44.537295Z","steps":["trace[902984268] 'agreement among raft nodes before linearized reading'  (duration: 115.775447ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:06:46.746654Z","caller":"traceutil/trace.go:171","msg":"trace[1835372257] transaction","detail":"{read_only:false; response_revision:3118; number_of_response:1; }","duration":"116.070329ms","start":"2026-05-19T00:06:46.630558Z","end":"2026-05-19T00:06:46.746628Z","steps":["trace[1835372257] 'process raft request'  (duration: 64.042884ms)","trace[1835372257] 'compare'  (duration: 51.926852ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:06:47.360441Z","caller":"traceutil/trace.go:171","msg":"trace[1991162523] transaction","detail":"{read_only:false; response_revision:3120; number_of_response:1; }","duration":"105.535282ms","start":"2026-05-19T00:06:47.254885Z","end":"2026-05-19T00:06:47.36042Z","steps":["trace[1991162523] 'process raft request'  (duration: 105.403378ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:06:47.361571Z","caller":"traceutil/trace.go:171","msg":"trace[1744981030] transaction","detail":"{read_only:false; response_revision:3121; number_of_response:1; }","duration":"106.235965ms","start":"2026-05-19T00:06:47.255307Z","end":"2026-05-19T00:06:47.361543Z","steps":["trace[1744981030] 'process raft request'  (duration: 106.092371ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:06:48.73528Z","caller":"traceutil/trace.go:171","msg":"trace[1517854374] linearizableReadLoop","detail":"{readStateIndex:3248; appliedIndex:3247; }","duration":"122.247252ms","start":"2026-05-19T00:06:48.613005Z","end":"2026-05-19T00:06:48.735253Z","steps":["trace[1517854374] 'read index received'  (duration: 122.074366ms)","trace[1517854374] 'applied index is now lower than readState.Index'  (duration: 171.986µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:06:48.735369Z","caller":"traceutil/trace.go:171","msg":"trace[809830181] transaction","detail":"{read_only:false; response_revision:3127; number_of_response:1; }","duration":"141.027195ms","start":"2026-05-19T00:06:48.594312Z","end":"2026-05-19T00:06:48.735339Z","steps":["trace[809830181] 'process raft request'  (duration: 140.756036ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:06:48.735478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.456619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"info","ts":"2026-05-19T00:06:48.735522Z","caller":"traceutil/trace.go:171","msg":"trace[101007717] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:3127; }","duration":"122.553442ms","start":"2026-05-19T00:06:48.612955Z","end":"2026-05-19T00:06:48.735508Z","steps":["trace[101007717] 'agreement among raft nodes before linearized reading'  (duration: 122.411898ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:06:48.862235Z","caller":"traceutil/trace.go:171","msg":"trace[1484874708] transaction","detail":"{read_only:false; response_revision:3129; number_of_response:1; }","duration":"102.083836ms","start":"2026-05-19T00:06:48.760124Z","end":"2026-05-19T00:06:48.862208Z","steps":["trace[1484874708] 'process raft request'  (duration: 38.830526ms)","trace[1484874708] 'compare'  (duration: 63.012742ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:06:50.320758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.590426ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960590493092894 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:3083 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-19T00:06:50.320874Z","caller":"traceutil/trace.go:171","msg":"trace[1622738632] linearizableReadLoop","detail":"{readStateIndex:3259; appliedIndex:3258; }","duration":"188.858103ms","start":"2026-05-19T00:06:50.131998Z","end":"2026-05-19T00:06:50.320856Z","steps":["trace[1622738632] 'read index received'  (duration: 49.009908ms)","trace[1622738632] 'applied index is now lower than readState.Index'  (duration: 139.847105ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:06:50.320925Z","caller":"traceutil/trace.go:171","msg":"trace[870558505] transaction","detail":"{read_only:false; response_revision:3137; number_of_response:1; }","duration":"206.811073ms","start":"2026-05-19T00:06:50.114073Z","end":"2026-05-19T00:06:50.320884Z","steps":["trace[870558505] 'process raft request'  (duration: 67.01476ms)","trace[870558505] 'compare'  (duration: 139.476872ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:06:50.321045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.047718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"}
{"level":"info","ts":"2026-05-19T00:06:50.321084Z","caller":"traceutil/trace.go:171","msg":"trace[326969988] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:3137; }","duration":"189.122711ms","start":"2026-05-19T00:06:50.13195Z","end":"2026-05-19T00:06:50.321072Z","steps":["trace[326969988] 'agreement among raft nodes before linearized reading'  (duration: 188.954105ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:05.597701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.051677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:07:05.597784Z","caller":"traceutil/trace.go:171","msg":"trace[724702163] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:3212; }","duration":"176.186411ms","start":"2026-05-19T00:07:05.421579Z","end":"2026-05-19T00:07:05.597766Z","steps":["trace[724702163] 'count revisions from in-memory index tree'  (duration: 175.946523ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:05.762327Z","caller":"traceutil/trace.go:171","msg":"trace[1226154283] transaction","detail":"{read_only:false; response_revision:3214; number_of_response:1; }","duration":"160.227837ms","start":"2026-05-19T00:07:05.602073Z","end":"2026-05-19T00:07:05.762301Z","steps":["trace[1226154283] 'process raft request'  (duration: 160.055652ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:05.762515Z","caller":"traceutil/trace.go:171","msg":"trace[492533128] linearizableReadLoop","detail":"{readStateIndex:3340; appliedIndex:3337; }","duration":"156.095213ms","start":"2026-05-19T00:07:05.606391Z","end":"2026-05-19T00:07:05.762486Z","steps":["trace[492533128] 'read index received'  (duration: 68.166953ms)","trace[492533128] 'applied index is now lower than readState.Index'  (duration: 87.92508ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:07:05.762697Z","caller":"traceutil/trace.go:171","msg":"trace[872010644] transaction","detail":"{read_only:false; response_revision:3215; number_of_response:1; }","duration":"160.490914ms","start":"2026-05-19T00:07:05.602153Z","end":"2026-05-19T00:07:05.762644Z","steps":["trace[872010644] 'process raft request'  (duration: 160.109853ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:05.762855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.444624ms","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-05-19T00:07:05.762922Z","caller":"traceutil/trace.go:171","msg":"trace[1977374253] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3215; }","duration":"156.529947ms","start":"2026-05-19T00:07:05.60638Z","end":"2026-05-19T00:07:05.762909Z","steps":["trace[1977374253] 'agreement among raft nodes before linearized reading'  (duration: 156.28135ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:07.872294Z","caller":"traceutil/trace.go:171","msg":"trace[1596713367] transaction","detail":"{read_only:false; response_revision:3225; number_of_response:1; }","duration":"101.708423ms","start":"2026-05-19T00:07:07.770564Z","end":"2026-05-19T00:07:07.872273Z","steps":["trace[1596713367] 'process raft request'  (duration: 101.529247ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:31.796894Z","caller":"traceutil/trace.go:171","msg":"trace[1646577726] linearizableReadLoop","detail":"{readStateIndex:3530; appliedIndex:3528; }","duration":"174.265203ms","start":"2026-05-19T00:07:31.622603Z","end":"2026-05-19T00:07:31.796868Z","steps":["trace[1646577726] 'read index received'  (duration: 36.904271ms)","trace[1646577726] 'applied index is now lower than readState.Index'  (duration: 137.359982ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:07:31.797027Z","caller":"traceutil/trace.go:171","msg":"trace[568658773] transaction","detail":"{read_only:false; response_revision:3397; number_of_response:1; }","duration":"173.757569ms","start":"2026-05-19T00:07:31.623254Z","end":"2026-05-19T00:07:31.797012Z","steps":["trace[568658773] 'process raft request'  (duration: 173.535013ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:31.797118Z","caller":"traceutil/trace.go:171","msg":"trace[2095123308] transaction","detail":"{read_only:false; response_revision:3396; number_of_response:1; }","duration":"176.101432ms","start":"2026-05-19T00:07:31.620989Z","end":"2026-05-19T00:07:31.79709Z","steps":["trace[2095123308] 'process raft request'  (duration: 86.592082ms)","trace[2095123308] 'compare'  (duration: 89.033027ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:07:31.797298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.685264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/passwords.secretgen.k14s.io\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:07:31.797347Z","caller":"traceutil/trace.go:171","msg":"trace[611780080] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/passwords.secretgen.k14s.io; range_end:; response_count:0; response_revision:3397; }","duration":"174.778226ms","start":"2026-05-19T00:07:31.622557Z","end":"2026-05-19T00:07:31.797335Z","steps":["trace[611780080] 'agreement among raft nodes before linearized reading'  (duration: 174.694054ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:31.797605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.015473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-19T00:07:31.797665Z","caller":"traceutil/trace.go:171","msg":"trace[424719557] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:3397; }","duration":"134.129866ms","start":"2026-05-19T00:07:31.663519Z","end":"2026-05-19T00:07:31.797649Z","steps":["trace[424719557] 'agreement among raft nodes before linearized reading'  (duration: 134.010252ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:31.797971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.097226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-19T00:07:31.798063Z","caller":"traceutil/trace.go:171","msg":"trace[783069841] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:3397; }","duration":"119.213649ms","start":"2026-05-19T00:07:31.678813Z","end":"2026-05-19T00:07:31.798026Z","steps":["trace[783069841] 'agreement among raft nodes before linearized reading'  (duration: 119.095565ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.147188Z","caller":"traceutil/trace.go:171","msg":"trace[241825871] transaction","detail":"{read_only:false; response_revision:3406; number_of_response:1; }","duration":"105.243556ms","start":"2026-05-19T00:07:32.041914Z","end":"2026-05-19T00:07:32.147157Z","steps":["trace[241825871] 'process raft request'  (duration: 23.721788ms)","trace[241825871] 'compare'  (duration: 81.174809ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:07:32.14745Z","caller":"traceutil/trace.go:171","msg":"trace[2073581605] transaction","detail":"{read_only:false; response_revision:3407; number_of_response:1; }","duration":"104.656321ms","start":"2026-05-19T00:07:32.042758Z","end":"2026-05-19T00:07:32.147415Z","steps":["trace[2073581605] 'process raft request'  (duration: 104.322272ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.147486Z","caller":"traceutil/trace.go:171","msg":"trace[947090363] transaction","detail":"{read_only:false; response_revision:3408; number_of_response:1; }","duration":"104.524597ms","start":"2026-05-19T00:07:32.042925Z","end":"2026-05-19T00:07:32.14745Z","steps":["trace[947090363] 'process raft request'  (duration: 104.387763ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.147485Z","caller":"traceutil/trace.go:171","msg":"trace[1904910027] transaction","detail":"{read_only:false; response_revision:3409; number_of_response:1; }","duration":"102.306888ms","start":"2026-05-19T00:07:32.045167Z","end":"2026-05-19T00:07:32.147474Z","steps":["trace[1904910027] 'process raft request'  (duration: 102.213446ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.147689Z","caller":"traceutil/trace.go:171","msg":"trace[1382582279] transaction","detail":"{read_only:false; response_revision:3410; number_of_response:1; }","duration":"102.404081ms","start":"2026-05-19T00:07:32.045276Z","end":"2026-05-19T00:07:32.14768Z","steps":["trace[1382582279] 'process raft request'  (duration: 102.157144ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.147674Z","caller":"traceutil/trace.go:171","msg":"trace[1420434758] transaction","detail":"{read_only:false; response_revision:3411; number_of_response:1; }","duration":"101.012294ms","start":"2026-05-19T00:07:32.046647Z","end":"2026-05-19T00:07:32.14766Z","steps":["trace[1420434758] 'process raft request'  (duration: 100.947993ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.34709Z","caller":"traceutil/trace.go:171","msg":"trace[1211937056] transaction","detail":"{read_only:false; response_revision:3414; number_of_response:1; }","duration":"192.678331ms","start":"2026-05-19T00:07:32.154387Z","end":"2026-05-19T00:07:32.347065Z","steps":["trace[1211937056] 'process raft request'  (duration: 192.615769ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.347127Z","caller":"traceutil/trace.go:171","msg":"trace[384866248] transaction","detail":"{read_only:false; response_revision:3413; number_of_response:1; }","duration":"192.908637ms","start":"2026-05-19T00:07:32.154165Z","end":"2026-05-19T00:07:32.347074Z","steps":["trace[384866248] 'process raft request'  (duration: 165.123441ms)","trace[384866248] 'compare'  (duration: 27.57518ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:07:32.347393Z","caller":"traceutil/trace.go:171","msg":"trace[1315052969] transaction","detail":"{read_only:false; response_revision:3416; number_of_response:1; }","duration":"170.591656ms","start":"2026-05-19T00:07:32.176786Z","end":"2026-05-19T00:07:32.347378Z","steps":["trace[1315052969] 'process raft request'  (duration: 170.429082ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:32.347891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.433359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/secretgen-controller/\" range_end:\"/registry/limitranges/secretgen-controller0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:07:32.347932Z","caller":"traceutil/trace.go:171","msg":"trace[1249935551] range","detail":"{range_begin:/registry/limitranges/secretgen-controller/; range_end:/registry/limitranges/secretgen-controller0; response_count:0; response_revision:3416; }","duration":"171.50185ms","start":"2026-05-19T00:07:32.176421Z","end":"2026-05-19T00:07:32.347923Z","steps":["trace[1249935551] 'agreement among raft nodes before linearized reading'  (duration: 171.416118ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.347792Z","caller":"traceutil/trace.go:171","msg":"trace[716971755] transaction","detail":"{read_only:false; response_revision:3415; number_of_response:1; }","duration":"172.524098ms","start":"2026-05-19T00:07:32.175254Z","end":"2026-05-19T00:07:32.347779Z","steps":["trace[716971755] 'process raft request'  (duration: 171.865ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:32.347291Z","caller":"traceutil/trace.go:171","msg":"trace[1059617016] linearizableReadLoop","detail":"{readStateIndex:3549; appliedIndex:3546; }","duration":"170.830963ms","start":"2026-05-19T00:07:32.176438Z","end":"2026-05-19T00:07:32.347269Z","steps":["trace[1059617016] 'read index received'  (duration: 142.834402ms)","trace[1059617016] 'applied index is now lower than readState.Index'  (duration: 27.995451ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:07:32.348813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.77349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:07:32.348874Z","caller":"traceutil/trace.go:171","msg":"trace[1316763575] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:3416; }","duration":"122.852492ms","start":"2026-05-19T00:07:32.226009Z","end":"2026-05-19T00:07:32.348861Z","steps":["trace[1316763575] 'agreement among raft nodes before linearized reading'  (duration: 122.736709ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:32.349211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.560952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"}
{"level":"info","ts":"2026-05-19T00:07:32.349319Z","caller":"traceutil/trace.go:171","msg":"trace[1487087602] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:3416; }","duration":"137.690185ms","start":"2026-05-19T00:07:32.211616Z","end":"2026-05-19T00:07:32.349306Z","steps":["trace[1487087602] 'agreement among raft nodes before linearized reading'  (duration: 137.014427ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:38.580805Z","caller":"traceutil/trace.go:171","msg":"trace[1480738957] transaction","detail":"{read_only:false; response_revision:3467; number_of_response:1; }","duration":"104.856381ms","start":"2026-05-19T00:07:38.475936Z","end":"2026-05-19T00:07:38.580793Z","steps":["trace[1480738957] 'process raft request'  (duration: 104.776489ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:40.55908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.038818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:07:40.559154Z","caller":"traceutil/trace.go:171","msg":"trace[1118351842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3477; }","duration":"104.156791ms","start":"2026-05-19T00:07:40.454982Z","end":"2026-05-19T00:07:40.559138Z","steps":["trace[1118351842] 'range keys from in-memory index tree'  (duration: 103.974376ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:07:46.508922Z","caller":"traceutil/trace.go:171","msg":"trace[2122730929] linearizableReadLoop","detail":"{readStateIndex:3649; appliedIndex:3648; }","duration":"190.949384ms","start":"2026-05-19T00:07:46.317953Z","end":"2026-05-19T00:07:46.508902Z","steps":["trace[2122730929] 'read index received'  (duration: 190.731059ms)","trace[2122730929] 'applied index is now lower than readState.Index'  (duration: 217.505µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:07:46.508976Z","caller":"traceutil/trace.go:171","msg":"trace[1453611863] transaction","detail":"{read_only:false; response_revision:3512; number_of_response:1; }","duration":"215.622704ms","start":"2026-05-19T00:07:46.293322Z","end":"2026-05-19T00:07:46.508945Z","steps":["trace[1453611863] 'process raft request'  (duration: 215.381007ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:46.509177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.164284ms","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-05-19T00:07:46.509408Z","caller":"traceutil/trace.go:171","msg":"trace[1480316496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3512; }","duration":"170.309298ms","start":"2026-05-19T00:07:46.338925Z","end":"2026-05-19T00:07:46.509235Z","steps":["trace[1480316496] 'agreement among raft nodes before linearized reading'  (duration: 170.095052ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:07:46.578078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.121038ms","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-05-19T00:07:46.578135Z","caller":"traceutil/trace.go:171","msg":"trace[1843048182] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3512; }","duration":"260.215521ms","start":"2026-05-19T00:07:46.317905Z","end":"2026-05-19T00:07:46.57812Z","steps":["trace[1843048182] 'agreement among raft nodes before linearized reading'  (duration: 191.618062ms)","trace[1843048182] 'range keys from in-memory index tree'  (duration: 68.456796ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:08:32.745734Z","caller":"traceutil/trace.go:171","msg":"trace[1036309521] transaction","detail":"{read_only:false; response_revision:3796; number_of_response:1; }","duration":"169.754966ms","start":"2026-05-19T00:08:32.575952Z","end":"2026-05-19T00:08:32.745707Z","steps":["trace[1036309521] 'process raft request'  (duration: 169.4967ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:08:46.315661Z","caller":"traceutil/trace.go:171","msg":"trace[985055703] transaction","detail":"{read_only:false; response_revision:3907; number_of_response:1; }","duration":"110.628666ms","start":"2026-05-19T00:08:46.205Z","end":"2026-05-19T00:08:46.315628Z","steps":["trace[985055703] 'process raft request'  (duration: 110.377601ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:15.991881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.013189ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960590493095945 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-dtdlp\" mod_revision:4401 > success:<request_put:<key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-dtdlp\" value_size:4240 >> failure:<request_range:<key:\"/registry/pods/monitoring/kube-prometheus-stack-admission-patch-dtdlp\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-19T00:09:15.992109Z","caller":"traceutil/trace.go:171","msg":"trace[1651636775] linearizableReadLoop","detail":"{readStateIndex:4582; appliedIndex:4580; }","duration":"127.048685ms","start":"2026-05-19T00:09:15.865018Z","end":"2026-05-19T00:09:15.992067Z","steps":["trace[1651636775] 'read index received'  (duration: 125.71733ms)","trace[1651636775] 'applied index is now lower than readState.Index'  (duration: 1.330285ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:15.992383Z","caller":"traceutil/trace.go:171","msg":"trace[281153025] transaction","detail":"{read_only:false; response_revision:4406; number_of_response:1; }","duration":"167.46182ms","start":"2026-05-19T00:09:15.824873Z","end":"2026-05-19T00:09:15.992334Z","steps":["trace[281153025] 'process raft request'  (duration: 167.094423ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:15.992413Z","caller":"traceutil/trace.go:171","msg":"trace[762708187] transaction","detail":"{read_only:false; response_revision:4405; number_of_response:1; }","duration":"168.267165ms","start":"2026-05-19T00:09:15.824131Z","end":"2026-05-19T00:09:15.992398Z","steps":["trace[762708187] 'compare'  (duration: 159.929047ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:15.99241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.376731ms","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-05-19T00:09:15.992515Z","caller":"traceutil/trace.go:171","msg":"trace[1216659220] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4406; }","duration":"127.481643ms","start":"2026-05-19T00:09:15.864976Z","end":"2026-05-19T00:09:15.992458Z","steps":["trace[1216659220] 'agreement among raft nodes before linearized reading'  (duration: 127.357411ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:25.805955Z","caller":"traceutil/trace.go:171","msg":"trace[1728972422] linearizableReadLoop","detail":"{readStateIndex:4826; appliedIndex:4825; }","duration":"407.988786ms","start":"2026-05-19T00:09:25.397941Z","end":"2026-05-19T00:09:25.80593Z","steps":["trace[1728972422] 'read index received'  (duration: 407.955155ms)","trace[1728972422] 'applied index is now lower than readState.Index'  (duration: 32.731µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:25.806052Z","caller":"traceutil/trace.go:171","msg":"trace[939106211] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"434.394673ms","start":"2026-05-19T00:09:25.371625Z","end":"2026-05-19T00:09:25.806019Z","steps":["trace[939106211] 'process raft request'  (duration: 434.166819ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:25.806283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.313371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-9cl7l\" ","response":"range_response_count:1 size:9756"}
{"level":"info","ts":"2026-05-19T00:09:25.806499Z","caller":"traceutil/trace.go:171","msg":"trace[145590846] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-9cl7l; range_end:; response_count:1; response_revision:4643; }","duration":"408.576477ms","start":"2026-05-19T00:09:25.397911Z","end":"2026-05-19T00:09:25.806487Z","steps":["trace[145590846] 'agreement among raft nodes before linearized reading'  (duration: 408.21392ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:25.806545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:25.397895Z","time spent":"408.637638ms","remote":"127.0.0.1:42270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9779,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-9cl7l\" "}
{"level":"warn","ts":"2026-05-19T00:09:25.806694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:25.371609Z","time spent":"434.73628ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:4591 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:25.875622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.952358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-19T00:09:25.875638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.847394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-19T00:09:25.875695Z","caller":"traceutil/trace.go:171","msg":"trace[1286442255] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4644; }","duration":"471.04787ms","start":"2026-05-19T00:09:25.40463Z","end":"2026-05-19T00:09:25.875678Z","steps":["trace[1286442255] 'agreement among raft nodes before linearized reading'  (duration: 470.866426ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:25.875702Z","caller":"traceutil/trace.go:171","msg":"trace[976518941] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4644; }","duration":"315.947235ms","start":"2026-05-19T00:09:25.559739Z","end":"2026-05-19T00:09:25.875687Z","steps":["trace[976518941] 'agreement among raft nodes before linearized reading'  (duration: 315.789732ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:25.875661Z","caller":"traceutil/trace.go:171","msg":"trace[21967828] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"476.146625ms","start":"2026-05-19T00:09:25.399469Z","end":"2026-05-19T00:09:25.875615Z","steps":["trace[21967828] 'process raft request'  (duration: 475.91224ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:25.875745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:25.55972Z","time spent":"316.014837ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-19T00:09:25.875789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:25.404624Z","time spent":"471.110742ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-19T00:09:25.875831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:25.399458Z","time spent":"476.297307ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-9cl7l.18b0ceebe6dd66bd\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-9cl7l.18b0ceebe6dd66bd\" value_size:791 lease:1613588553638318783 >> failure:<>"}
{"level":"warn","ts":"2026-05-19T00:09:25.875654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.846593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:09:25.876127Z","caller":"traceutil/trace.go:171","msg":"trace[1881077030] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4644; }","duration":"421.361013ms","start":"2026-05-19T00:09:25.454746Z","end":"2026-05-19T00:09:25.876107Z","steps":["trace[1881077030] 'agreement among raft nodes before linearized reading'  (duration: 420.813323ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:25.876551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:25.454733Z","time spent":"421.797841ms","remote":"127.0.0.1:42052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-05-19T00:09:26.693496Z","caller":"traceutil/trace.go:171","msg":"trace[1694392425] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"276.045207ms","start":"2026-05-19T00:09:26.417427Z","end":"2026-05-19T00:09:26.693472Z","steps":["trace[1694392425] 'process raft request'  (duration: 275.887734ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:26.721978Z","caller":"traceutil/trace.go:171","msg":"trace[526580871] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"291.961371ms","start":"2026-05-19T00:09:26.429998Z","end":"2026-05-19T00:09:26.721959Z","steps":["trace[526580871] 'process raft request'  (duration: 291.578934ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:30.627702Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10836960590493096762,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-19T00:09:30.648771Z","caller":"traceutil/trace.go:171","msg":"trace[2009874740] linearizableReadLoop","detail":"{readStateIndex:4915; appliedIndex:4914; }","duration":"521.46224ms","start":"2026-05-19T00:09:30.127285Z","end":"2026-05-19T00:09:30.648747Z","steps":["trace[2009874740] 'read index received'  (duration: 521.262656ms)","trace[2009874740] 'applied index is now lower than readState.Index'  (duration: 198.724µs)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:30.648972Z","caller":"traceutil/trace.go:171","msg":"trace[851352421] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"522.414817ms","start":"2026-05-19T00:09:30.126494Z","end":"2026-05-19T00:09:30.648909Z","steps":["trace[851352421] 'process raft request'  (duration: 522.112161ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:30.649076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.544604ms","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-05-19T00:09:30.649122Z","caller":"traceutil/trace.go:171","msg":"trace[873775015] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4731; }","duration":"485.633265ms","start":"2026-05-19T00:09:30.163475Z","end":"2026-05-19T00:09:30.649108Z","steps":["trace[873775015] 'agreement among raft nodes before linearized reading'  (duration: 485.476262ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:30.649114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.251993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-19T00:09:30.649157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:30.16345Z","time spent":"485.699007ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-19T00:09:30.649147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.843916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99eb8cd9-4bb5-4a80-b05e-63e16cff13a9\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-05-19T00:09:30.649195Z","caller":"traceutil/trace.go:171","msg":"trace[1490079134] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4731; }","duration":"190.356034ms","start":"2026-05-19T00:09:30.458817Z","end":"2026-05-19T00:09:30.649173Z","steps":["trace[1490079134] 'agreement among raft nodes before linearized reading'  (duration: 190.237082ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:30.649218Z","caller":"traceutil/trace.go:171","msg":"trace[2063140314] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-99eb8cd9-4bb5-4a80-b05e-63e16cff13a9; range_end:; response_count:1; response_revision:4731; }","duration":"521.950628ms","start":"2026-05-19T00:09:30.127247Z","end":"2026-05-19T00:09:30.649197Z","steps":["trace[2063140314] 'agreement among raft nodes before linearized reading'  (duration: 521.683293ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:30.649251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:30.126463Z","time spent":"522.634131ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4664 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:30.649401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.244181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"}
{"level":"warn","ts":"2026-05-19T00:09:30.649264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:30.127228Z","time spent":"522.02228ms","remote":"127.0.0.1:42270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99eb8cd9-4bb5-4a80-b05e-63e16cff13a9\" "}
{"level":"info","ts":"2026-05-19T00:09:30.649438Z","caller":"traceutil/trace.go:171","msg":"trace[1260509756] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4731; }","duration":"483.281983ms","start":"2026-05-19T00:09:30.166142Z","end":"2026-05-19T00:09:30.649424Z","steps":["trace[1260509756] 'agreement among raft nodes before linearized reading'  (duration: 483.182781ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:30.649468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:30.166137Z","time spent":"483.322584ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":594,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"warn","ts":"2026-05-19T00:09:30.649593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.045863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-99eb8cd9-4bb5-4a80-b05e-63e16cff13a9\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-05-19T00:09:30.649636Z","caller":"traceutil/trace.go:171","msg":"trace[1372486076] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-99eb8cd9-4bb5-4a80-b05e-63e16cff13a9; range_end:; response_count:1; response_revision:4731; }","duration":"205.107684ms","start":"2026-05-19T00:09:30.444513Z","end":"2026-05-19T00:09:30.649621Z","steps":["trace[1372486076] 'agreement among raft nodes before linearized reading'  (duration: 205.008692ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:30.757547Z","caller":"traceutil/trace.go:171","msg":"trace[1736079882] transaction","detail":"{read_only:false; response_revision:4733; number_of_response:1; }","duration":"102.4332ms","start":"2026-05-19T00:09:30.655075Z","end":"2026-05-19T00:09:30.757508Z","steps":["trace[1736079882] 'process raft request'  (duration: 89.356022ms)","trace[1736079882] 'compare'  (duration: 12.809623ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:30.758434Z","caller":"traceutil/trace.go:171","msg":"trace[355112230] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"101.073914ms","start":"2026-05-19T00:09:30.657002Z","end":"2026-05-19T00:09:30.758076Z","steps":["trace[355112230] 'process raft request'  (duration: 100.427873ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:32.898267Z","caller":"traceutil/trace.go:171","msg":"trace[1689332169] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"189.561734ms","start":"2026-05-19T00:09:32.70864Z","end":"2026-05-19T00:09:32.898202Z","steps":["trace[1689332169] 'process raft request'  (duration: 178.725597ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:32.8984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.688715ms","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-05-19T00:09:32.897917Z","caller":"traceutil/trace.go:171","msg":"trace[1686668588] linearizableReadLoop","detail":"{readStateIndex:4939; appliedIndex:4938; }","duration":"135.071704ms","start":"2026-05-19T00:09:32.762698Z","end":"2026-05-19T00:09:32.89777Z","steps":["trace[1686668588] 'read index received'  (duration: 124.641755ms)","trace[1686668588] 'applied index is now lower than readState.Index'  (duration: 10.429029ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:32.898698Z","caller":"traceutil/trace.go:171","msg":"trace[720800637] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4754; }","duration":"135.849377ms","start":"2026-05-19T00:09:32.762655Z","end":"2026-05-19T00:09:32.898504Z","steps":["trace[720800637] 'agreement among raft nodes before linearized reading'  (duration: 135.586502ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:32.899507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.500006ms","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-05-19T00:09:32.899748Z","caller":"traceutil/trace.go:171","msg":"trace[1599311311] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4754; }","duration":"117.325942ms","start":"2026-05-19T00:09:32.782406Z","end":"2026-05-19T00:09:32.899732Z","steps":["trace[1599311311] 'agreement among raft nodes before linearized reading'  (duration: 116.270232ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:33.641803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.007064ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960590493096832 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0.18b0ceedc873469c\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0.18b0ceedc873469c\" value_size:741 lease:1613588553638320966 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-19T00:09:33.641909Z","caller":"traceutil/trace.go:171","msg":"trace[2052506686] linearizableReadLoop","detail":"{readStateIndex:4950; appliedIndex:4949; }","duration":"146.864513ms","start":"2026-05-19T00:09:33.495027Z","end":"2026-05-19T00:09:33.641891Z","steps":["trace[2052506686] 'read index received'  (duration: 25.706596ms)","trace[2052506686] 'applied index is now lower than readState.Index'  (duration: 121.154247ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:33.641994Z","caller":"traceutil/trace.go:171","msg":"trace[550256302] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"155.145812ms","start":"2026-05-19T00:09:33.486836Z","end":"2026-05-19T00:09:33.641982Z","steps":["trace[550256302] 'process raft request'  (duration: 33.886904ms)","trace[550256302] 'compare'  (duration: 120.677938ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:09:33.642258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.208069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"}
{"level":"info","ts":"2026-05-19T00:09:33.642335Z","caller":"traceutil/trace.go:171","msg":"trace[1545600282] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4765; }","duration":"147.31341ms","start":"2026-05-19T00:09:33.495004Z","end":"2026-05-19T00:09:33.642317Z","steps":["trace[1545600282] 'agreement among raft nodes before linearized reading'  (duration: 146.982114ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:33.662471Z","caller":"traceutil/trace.go:171","msg":"trace[540517127] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"165.377649ms","start":"2026-05-19T00:09:33.497069Z","end":"2026-05-19T00:09:33.662447Z","steps":["trace[540517127] 'process raft request'  (duration: 165.149145ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:33.662829Z","caller":"traceutil/trace.go:171","msg":"trace[1328426341] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"164.39328ms","start":"2026-05-19T00:09:33.498419Z","end":"2026-05-19T00:09:33.662812Z","steps":["trace[1328426341] 'process raft request'  (duration: 163.956872ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:33.663065Z","caller":"traceutil/trace.go:171","msg":"trace[1537710161] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"161.701141ms","start":"2026-05-19T00:09:33.50134Z","end":"2026-05-19T00:09:33.663041Z","steps":["trace[1537710161] 'process raft request'  (duration: 161.317354ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:33.663221Z","caller":"traceutil/trace.go:171","msg":"trace[1160978188] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"161.751953ms","start":"2026-05-19T00:09:33.501427Z","end":"2026-05-19T00:09:33.663179Z","steps":["trace[1160978188] 'process raft request'  (duration: 161.375286ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:33.867059Z","caller":"traceutil/trace.go:171","msg":"trace[2044636182] linearizableReadLoop","detail":"{readStateIndex:4956; appliedIndex:4955; }","duration":"122.540581ms","start":"2026-05-19T00:09:33.744485Z","end":"2026-05-19T00:09:33.867026Z","steps":["trace[2044636182] 'read index received'  (duration: 57.466241ms)","trace[2044636182] 'applied index is now lower than readState.Index'  (duration: 65.07334ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:33.867124Z","caller":"traceutil/trace.go:171","msg":"trace[1428894807] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"123.854035ms","start":"2026-05-19T00:09:33.743227Z","end":"2026-05-19T00:09:33.867081Z","steps":["trace[1428894807] 'process raft request'  (duration: 58.633743ms)","trace[1428894807] 'compare'  (duration: 65.0677ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:09:33.867363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.845517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-99eb8cd9-4bb5-4a80-b05e-63e16cff13a9\" ","response":"range_response_count:1 size:2243"}
{"level":"info","ts":"2026-05-19T00:09:33.867691Z","caller":"traceutil/trace.go:171","msg":"trace[398030839] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-99eb8cd9-4bb5-4a80-b05e-63e16cff13a9; range_end:; response_count:1; response_revision:4771; }","duration":"123.230974ms","start":"2026-05-19T00:09:33.74444Z","end":"2026-05-19T00:09:33.867671Z","steps":["trace[398030839] 'agreement among raft nodes before linearized reading'  (duration: 122.702845ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:33.869232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.392009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"}
{"level":"info","ts":"2026-05-19T00:09:33.869475Z","caller":"traceutil/trace.go:171","msg":"trace[42185364] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4775; }","duration":"122.671974ms","start":"2026-05-19T00:09:33.746782Z","end":"2026-05-19T00:09:33.869454Z","steps":["trace[42185364] 'agreement among raft nodes before linearized reading'  (duration: 122.308568ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:33.869715Z","caller":"traceutil/trace.go:171","msg":"trace[802018165] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"122.757666ms","start":"2026-05-19T00:09:33.746932Z","end":"2026-05-19T00:09:33.86969Z","steps":["trace[802018165] 'process raft request'  (duration: 121.958621ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:33.870005Z","caller":"traceutil/trace.go:171","msg":"trace[2122625207] transaction","detail":"{read_only:false; response_revision:4773; number_of_response:1; }","duration":"122.662154ms","start":"2026-05-19T00:09:33.747332Z","end":"2026-05-19T00:09:33.869994Z","steps":["trace[2122625207] 'process raft request'  (duration: 121.638146ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:33.870389Z","caller":"traceutil/trace.go:171","msg":"trace[76304391] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"122.267617ms","start":"2026-05-19T00:09:33.748111Z","end":"2026-05-19T00:09:33.870378Z","steps":["trace[76304391] 'process raft request'  (duration: 120.902582ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:34.648862Z","caller":"traceutil/trace.go:171","msg":"trace[1348049933] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"155.745677ms","start":"2026-05-19T00:09:34.493092Z","end":"2026-05-19T00:09:34.648837Z","steps":["trace[1348049933] 'process raft request'  (duration: 155.603234ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:40.415885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.010547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"}
{"level":"info","ts":"2026-05-19T00:09:40.415968Z","caller":"traceutil/trace.go:171","msg":"trace[560717235] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:4876; }","duration":"364.14018ms","start":"2026-05-19T00:09:40.051807Z","end":"2026-05-19T00:09:40.415947Z","steps":["trace[560717235] 'range keys from in-memory index tree'  (duration: 363.749893ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:40.416011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:40.05179Z","time spent":"364.209971ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":581,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "}
{"level":"info","ts":"2026-05-19T00:09:44.519271Z","caller":"traceutil/trace.go:171","msg":"trace[384325403] transaction","detail":"{read_only:false; response_revision:4900; number_of_response:1; }","duration":"527.798019ms","start":"2026-05-19T00:09:43.991441Z","end":"2026-05-19T00:09:44.519239Z","steps":["trace[384325403] 'process raft request'  (duration: 445.045536ms)","trace[384325403] 'compare'  (duration: 82.207414ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:09:44.519417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:43.991414Z","time spent":"527.931111ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:4887 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-19T00:09:44.519277Z","caller":"traceutil/trace.go:171","msg":"trace[637245500] transaction","detail":"{read_only:false; response_revision:4901; number_of_response:1; }","duration":"512.467477ms","start":"2026-05-19T00:09:44.006779Z","end":"2026-05-19T00:09:44.519246Z","steps":["trace[637245500] 'process raft request'  (duration: 512.04816ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:44.519836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.006755Z","time spent":"512.913165ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:4775 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:471 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:45.289933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.018651ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960590493097156 > lease_revoke:<id:16649e3d893f9aa0>","response":"size:28"}
{"level":"info","ts":"2026-05-19T00:09:45.290006Z","caller":"traceutil/trace.go:171","msg":"trace[1698317850] linearizableReadLoop","detail":"{readStateIndex:5092; appliedIndex:5090; }","duration":"1.274917387s","start":"2026-05-19T00:09:44.015077Z","end":"2026-05-19T00:09:45.289994Z","steps":["trace[1698317850] 'read index received'  (duration: 421.401496ms)","trace[1698317850] 'applied index is now lower than readState.Index'  (duration: 853.515111ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:09:45.290084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.274998298s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:09:45.290099Z","caller":"traceutil/trace.go:171","msg":"trace[987662671] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:4901; }","duration":"1.275043209s","start":"2026-05-19T00:09:44.01505Z","end":"2026-05-19T00:09:45.290093Z","steps":["trace[987662671] 'agreement among raft nodes before linearized reading'  (duration: 1.275002008s)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.290117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.015037Z","time spent":"1.275075109s","remote":"127.0.0.1:52662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true "}
{"level":"warn","ts":"2026-05-19T00:09:45.319142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.240918594s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"}
{"level":"info","ts":"2026-05-19T00:09:45.319183Z","caller":"traceutil/trace.go:171","msg":"trace[923230106] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"624.387105ms","start":"2026-05-19T00:09:44.694773Z","end":"2026-05-19T00:09:45.31916Z","steps":["trace[923230106] 'process raft request'  (duration: 624.053849ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:45.319221Z","caller":"traceutil/trace.go:171","msg":"trace[1401404273] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4902; }","duration":"1.241042357s","start":"2026-05-19T00:09:44.07816Z","end":"2026-05-19T00:09:45.319202Z","steps":["trace[1401404273] 'agreement among raft nodes before linearized reading'  (duration: 1.240854423s)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.319216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.061027ms","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":"warn","ts":"2026-05-19T00:09:45.319264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.078132Z","time spent":"1.241120697s","remote":"127.0.0.1:52598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3267,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "}
{"level":"warn","ts":"2026-05-19T00:09:45.319262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.628228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-19T00:09:45.319287Z","caller":"traceutil/trace.go:171","msg":"trace[423990137] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4902; }","duration":"360.1918ms","start":"2026-05-19T00:09:44.959078Z","end":"2026-05-19T00:09:45.31927Z","steps":["trace[423990137] 'agreement among raft nodes before linearized reading'  (duration: 359.963676ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:45.319308Z","caller":"traceutil/trace.go:171","msg":"trace[2100569468] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:4902; }","duration":"125.74126ms","start":"2026-05-19T00:09:45.193554Z","end":"2026-05-19T00:09:45.319295Z","steps":["trace[2100569468] 'agreement among raft nodes before linearized reading'  (duration: 125.650029ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.319312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.69475Z","time spent":"624.487606ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:4889 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:45.319329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.959056Z","time spent":"360.264752ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"warn","ts":"2026-05-19T00:09:45.31933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.01413ms","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-05-19T00:09:45.31941Z","caller":"traceutil/trace.go:171","msg":"trace[1073860455] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4902; }","duration":"684.111182ms","start":"2026-05-19T00:09:44.635274Z","end":"2026-05-19T00:09:45.319385Z","steps":["trace[1073860455] 'agreement among raft nodes before linearized reading'  (duration: 683.941409ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.319457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.635259Z","time spent":"684.185323ms","remote":"127.0.0.1:42252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-05-19T00:09:45.3195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.625914ms","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-05-19T00:09:45.319531Z","caller":"traceutil/trace.go:171","msg":"trace[859774221] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4902; }","duration":"353.674534ms","start":"2026-05-19T00:09:44.965847Z","end":"2026-05-19T00:09:45.319521Z","steps":["trace[859774221] 'agreement among raft nodes before linearized reading'  (duration: 353.593283ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.319541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.71772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"}
{"level":"warn","ts":"2026-05-19T00:09:45.319568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.965837Z","time spent":"353.724765ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-19T00:09:45.319573Z","caller":"traceutil/trace.go:171","msg":"trace[449425567] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4902; }","duration":"750.778651ms","start":"2026-05-19T00:09:44.568785Z","end":"2026-05-19T00:09:45.319563Z","steps":["trace[449425567] 'agreement among raft nodes before linearized reading'  (duration: 750.685189ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.32158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.568753Z","time spent":"752.812087ms","remote":"127.0.0.1:42270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10415,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-05-19T00:09:45.319595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.417212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:09:45.32187Z","caller":"traceutil/trace.go:171","msg":"trace[689515498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4902; }","duration":"866.735973ms","start":"2026-05-19T00:09:44.455119Z","end":"2026-05-19T00:09:45.321855Z","steps":["trace[689515498] 'agreement among raft nodes before linearized reading'  (duration: 864.450873ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.321916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.455099Z","time spent":"866.806104ms","remote":"127.0.0.1:42052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-05-19T00:09:45.319585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.311014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"}
{"level":"info","ts":"2026-05-19T00:09:45.322135Z","caller":"traceutil/trace.go:171","msg":"trace[398398886] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:4902; }","duration":"374.91395ms","start":"2026-05-19T00:09:44.947203Z","end":"2026-05-19T00:09:45.322117Z","steps":["trace[398398886] 'agreement among raft nodes before linearized reading'  (duration: 372.218622ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.322197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:44.947182Z","time spent":"374.995152ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "}
{"level":"info","ts":"2026-05-19T00:09:45.644904Z","caller":"traceutil/trace.go:171","msg":"trace[772962120] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"317.14182ms","start":"2026-05-19T00:09:45.327739Z","end":"2026-05-19T00:09:45.644881Z","steps":["trace[772962120] 'process raft request'  (duration: 317.026958ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:45.645042Z","caller":"traceutil/trace.go:171","msg":"trace[1873635069] linearizableReadLoop","detail":"{readStateIndex:5098; appliedIndex:5095; }","duration":"292.351582ms","start":"2026-05-19T00:09:45.352679Z","end":"2026-05-19T00:09:45.645031Z","steps":["trace[1873635069] 'read index received'  (duration: 291.904614ms)","trace[1873635069] 'applied index is now lower than readState.Index'  (duration: 445.518µs)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:09:45.64521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.417355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-19T00:09:45.64525Z","caller":"traceutil/trace.go:171","msg":"trace[898690120] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4906; }","duration":"189.501646ms","start":"2026-05-19T00:09:45.455737Z","end":"2026-05-19T00:09:45.645238Z","steps":["trace[898690120] 'agreement among raft nodes before linearized reading'  (duration: 189.396695ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.645248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.805239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" ","response":"range_response_count:1 size:1162"}
{"level":"info","ts":"2026-05-19T00:09:45.645386Z","caller":"traceutil/trace.go:171","msg":"trace[2075793298] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-keystone-default-user; range_end:; response_count:1; response_revision:4906; }","duration":"318.962152ms","start":"2026-05-19T00:09:45.326408Z","end":"2026-05-19T00:09:45.64537Z","steps":["trace[2075793298] 'agreement among raft nodes before linearized reading'  (duration: 318.713597ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.645408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.446702ms","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-05-19T00:09:45.644897Z","caller":"traceutil/trace.go:171","msg":"trace[1924872999] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"318.534485ms","start":"2026-05-19T00:09:45.32633Z","end":"2026-05-19T00:09:45.644865Z","steps":["trace[1924872999] 'process raft request'  (duration: 318.307211ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.645427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.3264Z","time spent":"319.015663ms","remote":"127.0.0.1:42178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1185,"request content":"key:\"/registry/secrets/openstack/rabbitmq-keystone-default-user\" "}
{"level":"info","ts":"2026-05-19T00:09:45.645441Z","caller":"traceutil/trace.go:171","msg":"trace[2068343896] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4906; }","duration":"156.508714ms","start":"2026-05-19T00:09:45.488923Z","end":"2026-05-19T00:09:45.645432Z","steps":["trace[2068343896] 'agreement among raft nodes before linearized reading'  (duration: 156.380352ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.645526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.327728Z","time spent":"317.242452ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4890 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:45.645572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.326314Z","time spent":"319.157526ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:4892 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-05-19T00:09:45.645351Z","caller":"traceutil/trace.go:171","msg":"trace[1196588409] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"313.891943ms","start":"2026-05-19T00:09:45.331439Z","end":"2026-05-19T00:09:45.645331Z","steps":["trace[1196588409] 'process raft request'  (duration: 313.402644ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:45.646532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.331421Z","time spent":"314.954122ms","remote":"127.0.0.1:42270","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10670,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" mod_revision:4799 > success:<request_put:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" value_size:10611 >> failure:<request_range:<key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:46.127571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.293109ms","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-05-19T00:09:46.127733Z","caller":"traceutil/trace.go:171","msg":"trace[1715693090] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:4906; }","duration":"107.464802ms","start":"2026-05-19T00:09:46.020239Z","end":"2026-05-19T00:09:46.127704Z","steps":["trace[1715693090] 'range keys from in-memory index tree'  (duration: 107.274999ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.128235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.434218ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960590493097168 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4673 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:881 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-19T00:09:46.128377Z","caller":"traceutil/trace.go:171","msg":"trace[894690616] linearizableReadLoop","detail":"{readStateIndex:5099; appliedIndex:5098; }","duration":"475.633342ms","start":"2026-05-19T00:09:45.652722Z","end":"2026-05-19T00:09:46.128355Z","steps":["trace[894690616] 'read index received'  (duration: 169.603504ms)","trace[894690616] 'applied index is now lower than readState.Index'  (duration: 306.028038ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:46.128489Z","caller":"traceutil/trace.go:171","msg":"trace[1399661286] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"476.63995ms","start":"2026-05-19T00:09:45.651817Z","end":"2026-05-19T00:09:46.128457Z","steps":["trace[1399661286] 'process raft request'  (duration: 170.531681ms)","trace[1399661286] 'compare'  (duration: 305.279274ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:09:46.128583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.851316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" ","response":"range_response_count:1 size:1265"}
{"level":"warn","ts":"2026-05-19T00:09:46.128597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.651799Z","time spent":"476.745311ms","remote":"127.0.0.1:42260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" mod_revision:4673 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" value_size:881 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone-nodes\" > >"}
{"level":"info","ts":"2026-05-19T00:09:46.128639Z","caller":"traceutil/trace.go:171","msg":"trace[35535640] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone-nodes; range_end:; response_count:1; response_revision:4907; }","duration":"475.934648ms","start":"2026-05-19T00:09:45.65269Z","end":"2026-05-19T00:09:46.128625Z","steps":["trace[35535640] 'agreement among raft nodes before linearized reading'  (duration: 475.760895ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.128689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.652675Z","time spent":"475.999879ms","remote":"127.0.0.1:42280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1288,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone-nodes\" "}
{"level":"info","ts":"2026-05-19T00:09:46.197777Z","caller":"traceutil/trace.go:171","msg":"trace[1884333311] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"544.897663ms","start":"2026-05-19T00:09:45.65285Z","end":"2026-05-19T00:09:46.197747Z","steps":["trace[1884333311] 'process raft request'  (duration: 544.644188ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:46.197797Z","caller":"traceutil/trace.go:171","msg":"trace[107051118] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"544.913943ms","start":"2026-05-19T00:09:45.652849Z","end":"2026-05-19T00:09:46.197763Z","steps":["trace[107051118] 'process raft request'  (duration: 544.76838ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:46.197847Z","caller":"traceutil/trace.go:171","msg":"trace[534999867] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"544.21704ms","start":"2026-05-19T00:09:45.653608Z","end":"2026-05-19T00:09:46.197825Z","steps":["trace[534999867] 'process raft request'  (duration: 544.142829ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.197928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.652828Z","time spent":"545.031365ms","remote":"127.0.0.1:42260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" mod_revision:4677 > success:<request_put:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" value_size:829 >> failure:<request_range:<key:\"/registry/services/endpoints/openstack/rabbitmq-keystone\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:46.197934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.6536Z","time spent":"544.290582ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:4893 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:46.197978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.65284Z","time spent":"545.012445ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-h8wbf\" mod_revision:4678 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-h8wbf\" value_size:1363 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-h8wbf\" > >"}
{"level":"info","ts":"2026-05-19T00:09:46.19791Z","caller":"traceutil/trace.go:171","msg":"trace[2017681931] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"544.555257ms","start":"2026-05-19T00:09:45.653317Z","end":"2026-05-19T00:09:46.197872Z","steps":["trace[2017681931] 'process raft request'  (duration: 544.367174ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.198184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.653304Z","time spent":"544.7406ms","remote":"127.0.0.1:42362","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-v55gx\" mod_revision:4674 > success:<request_put:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-v55gx\" value_size:1434 >> failure:<request_range:<key:\"/registry/endpointslices/openstack/rabbitmq-keystone-nodes-v55gx\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:46.471719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.173022ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10836960590493097173 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4898 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-19T00:09:46.471816Z","caller":"traceutil/trace.go:171","msg":"trace[1518259313] linearizableReadLoop","detail":"{readStateIndex:5104; appliedIndex:5099; }","duration":"343.38135ms","start":"2026-05-19T00:09:46.12842Z","end":"2026-05-19T00:09:46.471801Z","steps":["trace[1518259313] 'read index received'  (duration: 69.096038ms)","trace[1518259313] 'applied index is now lower than readState.Index'  (duration: 274.283982ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:09:46.471992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.126584ms","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-05-19T00:09:46.472027Z","caller":"traceutil/trace.go:171","msg":"trace[2057077757] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4912; }","duration":"533.195786ms","start":"2026-05-19T00:09:45.938822Z","end":"2026-05-19T00:09:46.472018Z","steps":["trace[2057077757] 'agreement among raft nodes before linearized reading'  (duration: 533.058183ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.472075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.938803Z","time spent":"533.262037ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"info","ts":"2026-05-19T00:09:46.472231Z","caller":"traceutil/trace.go:171","msg":"trace[1178655531] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"518.611408ms","start":"2026-05-19T00:09:45.953586Z","end":"2026-05-19T00:09:46.472197Z","steps":["trace[1178655531] 'process raft request'  (duration: 273.885826ms)","trace[1178655531] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/08db1feb.percona.com; req_size:507; } (duration: 243.933748ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:09:46.47235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.753946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18b0ceecc40652be\" ","response":"range_response_count:1 size:746"}
{"level":"warn","ts":"2026-05-19T00:09:46.472347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.107339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-05-19T00:09:46.472382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.95356Z","time spent":"518.735101ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4898 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-05-19T00:09:46.472431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.021544ms","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-05-19T00:09:46.472497Z","caller":"traceutil/trace.go:171","msg":"trace[2050460613] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4912; }","duration":"814.121616ms","start":"2026-05-19T00:09:45.658359Z","end":"2026-05-19T00:09:46.472481Z","steps":["trace[2050460613] 'agreement among raft nodes before linearized reading'  (duration: 813.937633ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.472556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.658343Z","time spent":"814.193067ms","remote":"127.0.0.1:42252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "}
{"level":"info","ts":"2026-05-19T00:09:46.472419Z","caller":"traceutil/trace.go:171","msg":"trace[376054175] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18b0ceecc40652be; range_end:; response_count:1; response_revision:4912; }","duration":"339.852178ms","start":"2026-05-19T00:09:46.132546Z","end":"2026-05-19T00:09:46.472398Z","steps":["trace[376054175] 'agreement among raft nodes before linearized reading'  (duration: 339.685105ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:46.472436Z","caller":"traceutil/trace.go:171","msg":"trace[1425890819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4912; }","duration":"497.274512ms","start":"2026-05-19T00:09:45.975139Z","end":"2026-05-19T00:09:46.472414Z","steps":["trace[1425890819] 'agreement among raft nodes before linearized reading'  (duration: 496.690052ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.472709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.975125Z","time spent":"497.565947ms","remote":"127.0.0.1:42354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"warn","ts":"2026-05-19T00:09:46.472676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:46.13253Z","time spent":"340.123002ms","remote":"127.0.0.1:42150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":769,"request content":"key:\"/registry/events/openstack/rabbitmq-keystone.18b0ceecc40652be\" "}
{"level":"warn","ts":"2026-05-19T00:09:46.472576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.044604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1453"}
{"level":"info","ts":"2026-05-19T00:09:46.472953Z","caller":"traceutil/trace.go:171","msg":"trace[272713216] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4912; }","duration":"339.43831ms","start":"2026-05-19T00:09:46.133499Z","end":"2026-05-19T00:09:46.472937Z","steps":["trace[272713216] 'agreement among raft nodes before linearized reading'  (duration: 338.982972ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.473014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:46.133488Z","time spent":"339.510202ms","remote":"127.0.0.1:42280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":1476,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" "}
{"level":"warn","ts":"2026-05-19T00:09:46.473138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.358556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-bcfdf898d-f8pjw\" ","response":"range_response_count:1 size:11840"}
{"level":"info","ts":"2026-05-19T00:09:46.47327Z","caller":"traceutil/trace.go:171","msg":"trace[1733974449] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-bcfdf898d-f8pjw; range_end:; response_count:1; response_revision:4912; }","duration":"820.538849ms","start":"2026-05-19T00:09:45.652709Z","end":"2026-05-19T00:09:46.473247Z","steps":["trace[1733974449] 'agreement among raft nodes before linearized reading'  (duration: 819.547371ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.473442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:09:45.652687Z","time spent":"820.739413ms","remote":"127.0.0.1:42270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":11863,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-bcfdf898d-f8pjw\" "}
{"level":"info","ts":"2026-05-19T00:09:46.631165Z","caller":"traceutil/trace.go:171","msg":"trace[379776416] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"151.386597ms","start":"2026-05-19T00:09:46.479751Z","end":"2026-05-19T00:09:46.631138Z","steps":["trace[379776416] 'process raft request'  (duration: 151.290006ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:46.631226Z","caller":"traceutil/trace.go:171","msg":"trace[1330454749] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"151.51761ms","start":"2026-05-19T00:09:46.479646Z","end":"2026-05-19T00:09:46.631163Z","steps":["trace[1330454749] 'process raft request'  (duration: 111.165269ms)","trace[1330454749] 'compare'  (duration: 40.062306ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:46.631292Z","caller":"traceutil/trace.go:171","msg":"trace[952651072] linearizableReadLoop","detail":"{readStateIndex:5108; appliedIndex:5105; }","duration":"121.44405ms","start":"2026-05-19T00:09:46.509825Z","end":"2026-05-19T00:09:46.63127Z","steps":["trace[952651072] 'read index received'  (duration: 80.898985ms)","trace[952651072] 'applied index is now lower than readState.Index'  (duration: 40.543995ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:46.631596Z","caller":"traceutil/trace.go:171","msg":"trace[1024777440] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"144.940683ms","start":"2026-05-19T00:09:46.486626Z","end":"2026-05-19T00:09:46.631567Z","steps":["trace[1024777440] 'process raft request'  (duration: 144.469165ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.631763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.845225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9635"}
{"level":"info","ts":"2026-05-19T00:09:46.631982Z","caller":"traceutil/trace.go:171","msg":"trace[1487044187] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4916; }","duration":"152.168821ms","start":"2026-05-19T00:09:46.479806Z","end":"2026-05-19T00:09:46.631975Z","steps":["trace[1487044187] 'agreement among raft nodes before linearized reading'  (duration: 151.836595ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.632354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.75216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"}
{"level":"info","ts":"2026-05-19T00:09:46.632406Z","caller":"traceutil/trace.go:171","msg":"trace[1111636977] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4916; }","duration":"119.803931ms","start":"2026-05-19T00:09:46.512595Z","end":"2026-05-19T00:09:46.632399Z","steps":["trace[1111636977] 'agreement among raft nodes before linearized reading'  (duration: 119.690489ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.632561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.688899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18b0ceecc51070fd\" ","response":"range_response_count:1 size:740"}
{"level":"info","ts":"2026-05-19T00:09:46.632638Z","caller":"traceutil/trace.go:171","msg":"trace[321177474] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18b0ceecc51070fd; range_end:; response_count:1; response_revision:4916; }","duration":"119.79779ms","start":"2026-05-19T00:09:46.512822Z","end":"2026-05-19T00:09:46.63262Z","steps":["trace[321177474] 'agreement among raft nodes before linearized reading'  (duration: 119.554696ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.633485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.959469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"}
{"level":"info","ts":"2026-05-19T00:09:46.633982Z","caller":"traceutil/trace.go:171","msg":"trace[297400279] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4916; }","duration":"109.456138ms","start":"2026-05-19T00:09:46.524464Z","end":"2026-05-19T00:09:46.63392Z","steps":["trace[297400279] 'agreement among raft nodes before linearized reading'  (duration: 107.891251ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:46.795905Z","caller":"traceutil/trace.go:171","msg":"trace[2063268251] linearizableReadLoop","detail":"{readStateIndex:5113; appliedIndex:5109; }","duration":"144.201771ms","start":"2026-05-19T00:09:46.651685Z","end":"2026-05-19T00:09:46.795886Z","steps":["trace[2063268251] 'read index received'  (duration: 121.45197ms)","trace[2063268251] 'applied index is now lower than readState.Index'  (duration: 22.749001ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:46.796017Z","caller":"traceutil/trace.go:171","msg":"trace[1666284709] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"158.182177ms","start":"2026-05-19T00:09:46.637823Z","end":"2026-05-19T00:09:46.796006Z","steps":["trace[1666284709] 'process raft request'  (duration: 157.937973ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:46.79616Z","caller":"traceutil/trace.go:171","msg":"trace[1674094333] transaction","detail":"{read_only:false; response_revision:4918; number_of_response:1; }","duration":"158.486232ms","start":"2026-05-19T00:09:46.637636Z","end":"2026-05-19T00:09:46.796122Z","steps":["trace[1674094333] 'process raft request'  (duration: 135.597089ms)","trace[1674094333] 'compare'  (duration: 22.336214ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:09:46.796339Z","caller":"traceutil/trace.go:171","msg":"trace[1785919373] transaction","detail":"{read_only:false; response_revision:4919; number_of_response:1; }","duration":"158.622445ms","start":"2026-05-19T00:09:46.637638Z","end":"2026-05-19T00:09:46.79626Z","steps":["trace[1785919373] 'process raft request'  (duration: 158.065565ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:46.796457Z","caller":"traceutil/trace.go:171","msg":"trace[804599227] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"155.424468ms","start":"2026-05-19T00:09:46.640974Z","end":"2026-05-19T00:09:46.796399Z","steps":["trace[804599227] 'process raft request'  (duration: 154.850788ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.796515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.865098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-19T00:09:46.796567Z","caller":"traceutil/trace.go:171","msg":"trace[94704317] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:4921; }","duration":"154.909289ms","start":"2026-05-19T00:09:46.641639Z","end":"2026-05-19T00:09:46.796548Z","steps":["trace[94704317] 'agreement among raft nodes before linearized reading'  (duration: 154.778456ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-19T00:09:46.796632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.287554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11518"}
{"level":"warn","ts":"2026-05-19T00:09:46.796384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.49ms","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-05-19T00:09:46.796786Z","caller":"traceutil/trace.go:171","msg":"trace[1528817156] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4921; }","duration":"143.470528ms","start":"2026-05-19T00:09:46.65328Z","end":"2026-05-19T00:09:46.79675Z","steps":["trace[1528817156] 'agreement among raft nodes before linearized reading'  (duration: 143.095952ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:09:46.796796Z","caller":"traceutil/trace.go:171","msg":"trace[2022420194] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4921; }","duration":"159.927808ms","start":"2026-05-19T00:09:46.636857Z","end":"2026-05-19T00:09:46.796785Z","steps":["trace[2022420194] 'agreement among raft nodes before linearized reading'  (duration: 159.349248ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:10:06.70092Z","caller":"traceutil/trace.go:171","msg":"trace[1018200961] transaction","detail":"{read_only:false; response_revision:5071; number_of_response:1; }","duration":"140.664031ms","start":"2026-05-19T00:10:06.560216Z","end":"2026-05-19T00:10:06.70088Z","steps":["trace[1018200961] 'process raft request'  (duration: 114.391167ms)","trace[1018200961] 'compare'  (duration: 26.107721ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:10:55.399905Z","caller":"traceutil/trace.go:171","msg":"trace[1707730272] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"189.571183ms","start":"2026-05-19T00:10:55.210294Z","end":"2026-05-19T00:10:55.399865Z","steps":["trace[1707730272] 'process raft request'  (duration: 119.786062ms)","trace[1707730272] 'compare'  (duration: 69.565087ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-19T00:10:55.400138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.211465ms","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-05-19T00:10:55.400232Z","caller":"traceutil/trace.go:171","msg":"trace[188079533] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5506; }","duration":"187.392829ms","start":"2026-05-19T00:10:55.212806Z","end":"2026-05-19T00:10:55.400199Z","steps":["trace[188079533] 'agreement among raft nodes before linearized reading'  (duration: 187.125425ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:10:55.399871Z","caller":"traceutil/trace.go:171","msg":"trace[686767814] linearizableReadLoop","detail":"{readStateIndex:5714; appliedIndex:5713; }","duration":"186.987372ms","start":"2026-05-19T00:10:55.212833Z","end":"2026-05-19T00:10:55.39982Z","steps":["trace[686767814] 'read index received'  (duration: 117.192991ms)","trace[686767814] 'applied index is now lower than readState.Index'  (duration: 69.793461ms)"],"step_count":2}
{"level":"info","ts":"2026-05-19T00:11:05.827577Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2904}
{"level":"info","ts":"2026-05-19T00:11:05.901504Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2904,"took":"72.589579ms","hash":3073988222,"current-db-size-bytes":54091776,"current-db-size":"54 MB","current-db-size-in-use-bytes":29655040,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-19T00:11:05.901572Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3073988222,"revision":2904,"compact-revision":-1}
{"level":"warn","ts":"2026-05-19T00:15:47.814957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.399874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:1 size:363"}
{"level":"warn","ts":"2026-05-19T00:15:47.815066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.749412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-public\" ","response":"range_response_count:1 size:351"}
{"level":"info","ts":"2026-05-19T00:15:47.815087Z","caller":"traceutil/trace.go:171","msg":"trace[551664161] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:1; response_revision:7334; }","duration":"118.588701ms","start":"2026-05-19T00:15:47.696469Z","end":"2026-05-19T00:15:47.815057Z","steps":["trace[551664161] 'range keys from in-memory index tree'  (duration: 118.232309ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:15:47.815151Z","caller":"traceutil/trace.go:171","msg":"trace[1311547091] range","detail":"{range_begin:/registry/namespaces/kube-public; range_end:; response_count:1; response_revision:7334; }","duration":"110.865606ms","start":"2026-05-19T00:15:47.704263Z","end":"2026-05-19T00:15:47.815129Z","steps":["trace[1311547091] 'range keys from in-memory index tree'  (duration: 110.598857ms)"],"step_count":1}
{"level":"info","ts":"2026-05-19T00:16:05.835745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5566}
{"level":"info","ts":"2026-05-19T00:16:05.947011Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5566,"took":"110.153233ms","hash":3828170695,"current-db-size-bytes":54091776,"current-db-size":"54 MB","current-db-size-in-use-bytes":18403328,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-19T00:16:05.947065Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3828170695,"revision":5566,"compact-revision":2904}