{"level":"warn","ts":"2026-05-12T11:22:32.179849Z","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-12T11:22:32.179935Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.123:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.123:2380","--initial-cluster=instance=https://199.19.213.123:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.123:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.123: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-12T11:22:32.179997Z","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-12T11:22:32.180009Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.123:2380"]} {"level":"info","ts":"2026-05-12T11:22:32.180024Z","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-12T11:22:32.180785Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"]} {"level":"info","ts":"2026-05-12T11:22:32.180881Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.123:2380"],"listen-peer-urls":["https://199.19.213.123:2380"],"advertise-client-urls":["https://199.19.213.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.123: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-12T11:22:32.18467Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.544944ms"} {"level":"info","ts":"2026-05-12T11:22:32.192117Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3e4829a3cabe4fce","cluster-id":"b469cfed817d8605"} {"level":"info","ts":"2026-05-12T11:22:32.192193Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=()"} {"level":"info","ts":"2026-05-12T11:22:32.192218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became follower at term 0"} {"level":"info","ts":"2026-05-12T11:22:32.192235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3e4829a3cabe4fce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-12T11:22:32.192245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became follower at term 1"} {"level":"info","ts":"2026-05-12T11:22:32.19229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=(4487882812132577230)"} {"level":"warn","ts":"2026-05-12T11:22:32.199117Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-12T11:22:32.202278Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-12T11:22:32.203588Z","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-12T11:22:32.206063Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3e4829a3cabe4fce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-12T11:22:32.206278Z","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-12T11:22:32.206383Z","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-12T11:22:32.206394Z","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-12T11:22:32.206515Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3e4829a3cabe4fce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-12T11:22:32.207076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=(4487882812132577230)"} {"level":"info","ts":"2026-05-12T11:22:32.207616Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b469cfed817d8605","local-member-id":"3e4829a3cabe4fce","added-peer-id":"3e4829a3cabe4fce","added-peer-peer-urls":["https://199.19.213.123:2380"]} {"level":"info","ts":"2026-05-12T11:22:32.21057Z","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-12T11:22:32.210663Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.123:2380"} {"level":"info","ts":"2026-05-12T11:22:32.210715Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.123:2380"} {"level":"info","ts":"2026-05-12T11:22:32.210924Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3e4829a3cabe4fce","initial-advertise-peer-urls":["https://199.19.213.123:2380"],"listen-peer-urls":["https://199.19.213.123:2380"],"advertise-client-urls":["https://199.19.213.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-12T11:22:32.211023Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-12T11:22:32.693741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce is starting a new election at term 1"} {"level":"info","ts":"2026-05-12T11:22:32.69379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became pre-candidate at term 1"} {"level":"info","ts":"2026-05-12T11:22:32.693818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce received MsgPreVoteResp from 3e4829a3cabe4fce at term 1"} {"level":"info","ts":"2026-05-12T11:22:32.693832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became candidate at term 2"} {"level":"info","ts":"2026-05-12T11:22:32.693839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce received MsgVoteResp from 3e4829a3cabe4fce at term 2"} {"level":"info","ts":"2026-05-12T11:22:32.693849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became leader at term 2"} {"level":"info","ts":"2026-05-12T11:22:32.693858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3e4829a3cabe4fce elected leader 3e4829a3cabe4fce at term 2"} {"level":"info","ts":"2026-05-12T11:22:32.70417Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3e4829a3cabe4fce","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.123:2379]}","request-path":"/0/members/3e4829a3cabe4fce/attributes","cluster-id":"b469cfed817d8605","publish-timeout":"7s"} {"level":"info","ts":"2026-05-12T11:22:32.704166Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:22:32.704217Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-12T11:22:32.704209Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:22:32.705062Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-12T11:22:32.705093Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-12T11:22:32.706633Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.123:2379"} {"level":"info","ts":"2026-05-12T11:22:32.707463Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-12T11:22:32.732264Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b469cfed817d8605","local-member-id":"3e4829a3cabe4fce","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:22:32.732559Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-12T11:22:32.732708Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-12T11:22:36.531585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.430087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:22:36.5317Z","caller":"traceutil/trace.go:171","msg":"trace[1450802631] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:0; response_revision:214; }","duration":"161.648111ms","start":"2026-05-12T11:22:36.370026Z","end":"2026-05-12T11:22:36.531674Z","steps":["trace[1450802631] 'range keys from in-memory index tree' (duration: 161.356464ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:22:36.674654Z","caller":"traceutil/trace.go:171","msg":"trace[1461313587] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"137.594503ms","start":"2026-05-12T11:22:36.537036Z","end":"2026-05-12T11:22:36.674631Z","steps":["trace[1461313587] 'process raft request' (duration: 137.464645ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:22:36.934242Z","caller":"traceutil/trace.go:171","msg":"trace[1155406859] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"250.872439ms","start":"2026-05-12T11:22:36.683338Z","end":"2026-05-12T11:22:36.934211Z","steps":["trace[1155406859] 'process raft request' (duration: 244.591934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:22:36.934387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.266703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:22:36.934438Z","caller":"traceutil/trace.go:171","msg":"trace[1303433821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:216; }","duration":"245.362179ms","start":"2026-05-12T11:22:36.689063Z","end":"2026-05-12T11:22:36.934425Z","steps":["trace[1303433821] 'agreement among raft nodes before linearized reading' (duration: 245.221951ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:22:36.934223Z","caller":"traceutil/trace.go:171","msg":"trace[289240920] linearizableReadLoop","detail":"{readStateIndex:222; appliedIndex:221; }","duration":"245.079483ms","start":"2026-05-12T11:22:36.68909Z","end":"2026-05-12T11:22:36.93417Z","steps":["trace[289240920] 'read index received' (duration: 238.852111ms)","trace[289240920] 'applied index is now lower than readState.Index' (duration: 6.226352ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:22:36.935007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.945346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3492"} {"level":"info","ts":"2026-05-12T11:22:36.935051Z","caller":"traceutil/trace.go:171","msg":"trace[2118866593] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:216; }","duration":"158.016809ms","start":"2026-05-12T11:22:36.777023Z","end":"2026-05-12T11:22:36.93504Z","steps":["trace[2118866593] 'agreement among raft nodes before linearized reading' (duration: 157.935714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:03.131603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.245558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:23:03.131689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.84727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:23:03.13158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.5661ms","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-12T11:23:03.13176Z","caller":"traceutil/trace.go:171","msg":"trace[670996559] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:506; }","duration":"556.762372ms","start":"2026-05-12T11:23:02.574976Z","end":"2026-05-12T11:23:03.131738Z","steps":["trace[670996559] 'range keys from in-memory index tree' (duration: 556.456994ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:03.131755Z","caller":"traceutil/trace.go:171","msg":"trace[1068390679] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:506; }","duration":"385.928594ms","start":"2026-05-12T11:23:02.745806Z","end":"2026-05-12T11:23:03.131735Z","steps":["trace[1068390679] 'range keys from in-memory index tree' (duration: 385.790296ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:03.131805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:02.574713Z","time spent":"557.079371ms","remote":"127.0.0.1:47986","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-12T11:23:03.131817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:02.745791Z","time spent":"386.015699ms","remote":"127.0.0.1:47840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-05-12T11:23:03.131703Z","caller":"traceutil/trace.go:171","msg":"trace[908698059] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:506; }","duration":"568.394157ms","start":"2026-05-12T11:23:02.563287Z","end":"2026-05-12T11:23:03.131681Z","steps":["trace[908698059] 'range keys from in-memory index tree' (duration: 568.11744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:03.131958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:02.563272Z","time spent":"568.658583ms","remote":"127.0.0.1:47754","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-12T11:23:03.31192Z","caller":"traceutil/trace.go:171","msg":"trace[1308269740] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"175.64744ms","start":"2026-05-12T11:23:03.136257Z","end":"2026-05-12T11:23:03.311905Z","steps":["trace[1308269740] 'process raft request' (duration: 175.558485ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:10.083815Z","caller":"traceutil/trace.go:171","msg":"trace[446098225] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"106.771745ms","start":"2026-05-12T11:23:09.977009Z","end":"2026-05-12T11:23:10.083781Z","steps":["trace[446098225] 'process raft request' (duration: 106.166206ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:10.247013Z","caller":"traceutil/trace.go:171","msg":"trace[1465411731] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"145.354631ms","start":"2026-05-12T11:23:10.101604Z","end":"2026-05-12T11:23:10.246959Z","steps":["trace[1465411731] 'process raft request' (duration: 145.012237ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:10.427023Z","caller":"traceutil/trace.go:171","msg":"trace[479597175] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"276.914877ms","start":"2026-05-12T11:23:10.150074Z","end":"2026-05-12T11:23:10.426989Z","steps":["trace[479597175] 'process raft request' (duration: 204.942751ms)","trace[479597175] 'compare' (duration: 71.833602ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:23:10.88467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.923958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:23:10.8848Z","caller":"traceutil/trace.go:171","msg":"trace[2031381465] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"335.511698ms","start":"2026-05-12T11:23:10.549268Z","end":"2026-05-12T11:23:10.884779Z","steps":["trace[2031381465] 'read index received' (duration: 178.766199ms)","trace[2031381465] 'applied index is now lower than readState.Index' (duration: 156.743879ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:23:10.884879Z","caller":"traceutil/trace.go:171","msg":"trace[447719577] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"421.921283ms","start":"2026-05-12T11:23:10.462943Z","end":"2026-05-12T11:23:10.884864Z","steps":["trace[447719577] 'process raft request' (duration: 265.100787ms)","trace[447719577] 'compare' (duration: 155.797615ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:23:10.884996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:10.46293Z","time spent":"422.024213ms","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:23:10.885162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.883805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.885283Z","caller":"traceutil/trace.go:171","msg":"trace[1310534798] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"336.03465ms","start":"2026-05-12T11:23:10.549221Z","end":"2026-05-12T11:23:10.885256Z","steps":["trace[1310534798] 'agreement among raft nodes before linearized reading' (duration: 335.799897ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.885403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:23:10.549203Z","time spent":"336.185914ms","remote":"127.0.0.1:47750","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-12T11:23:10.926005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.108034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.926077Z","caller":"traceutil/trace.go:171","msg":"trace[1696529528] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"279.211234ms","start":"2026-05-12T11:23:10.64685Z","end":"2026-05-12T11:23:10.926061Z","steps":["trace[1696529528] 'agreement among raft nodes before linearized reading' (duration: 279.086082ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.926375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.343986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.9264Z","caller":"traceutil/trace.go:171","msg":"trace[1032626695] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:621; }","duration":"139.38679ms","start":"2026-05-12T11:23:10.787007Z","end":"2026-05-12T11:23:10.926394Z","steps":["trace[1032626695] 'agreement among raft nodes before linearized reading' (duration: 139.347616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.9265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.802462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.926521Z","caller":"traceutil/trace.go:171","msg":"trace[1016880079] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:621; }","duration":"139.838365ms","start":"2026-05-12T11:23:10.786677Z","end":"2026-05-12T11:23:10.926516Z","steps":["trace[1016880079] 'agreement among raft nodes before linearized reading' (duration: 139.804602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.926607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.943655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.926666Z","caller":"traceutil/trace.go:171","msg":"trace[79763964] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:621; }","duration":"140.019253ms","start":"2026-05-12T11:23:10.78664Z","end":"2026-05-12T11:23:10.926659Z","steps":["trace[79763964] 'agreement among raft nodes before linearized reading' (duration: 139.950356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.926846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.583704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.926871Z","caller":"traceutil/trace.go:171","msg":"trace[1628489654] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"155.630858ms","start":"2026-05-12T11:23:10.771234Z","end":"2026-05-12T11:23:10.926865Z","steps":["trace[1628489654] 'agreement among raft nodes before linearized reading' (duration: 155.503836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.926976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.627807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.926996Z","caller":"traceutil/trace.go:171","msg":"trace[1106574796] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"156.668311ms","start":"2026-05-12T11:23:10.770323Z","end":"2026-05-12T11:23:10.926991Z","steps":["trace[1106574796] 'agreement among raft nodes before linearized reading' (duration: 156.636608ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.92707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.749059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.927091Z","caller":"traceutil/trace.go:171","msg":"trace[1045044848] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:621; }","duration":"156.770461ms","start":"2026-05-12T11:23:10.770316Z","end":"2026-05-12T11:23:10.927086Z","steps":["trace[1045044848] 'agreement among raft nodes before linearized reading' (duration: 156.740438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.927165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.563002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.927185Z","caller":"traceutil/trace.go:171","msg":"trace[2052622020] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"174.612987ms","start":"2026-05-12T11:23:10.752567Z","end":"2026-05-12T11:23:10.92718Z","steps":["trace[2052622020] 'agreement among raft nodes before linearized reading' (duration: 174.582344ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.927326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.916806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.92735Z","caller":"traceutil/trace.go:171","msg":"trace[80277924] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"176.95307ms","start":"2026-05-12T11:23:10.750391Z","end":"2026-05-12T11:23:10.927344Z","steps":["trace[80277924] 'agreement among raft nodes before linearized reading' (duration: 176.914966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.927478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.320685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.927501Z","caller":"traceutil/trace.go:171","msg":"trace[1472366226] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"177.369051ms","start":"2026-05-12T11:23:10.750127Z","end":"2026-05-12T11:23:10.927496Z","steps":["trace[1472366226] 'agreement among raft nodes before linearized reading' (duration: 177.330817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.927604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.146727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.927628Z","caller":"traceutil/trace.go:171","msg":"trace[1402751379] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"218.181381ms","start":"2026-05-12T11:23:10.709441Z","end":"2026-05-12T11:23:10.927622Z","steps":["trace[1402751379] 'agreement among raft nodes before linearized reading' (duration: 218.127206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.927745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.340927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.927767Z","caller":"traceutil/trace.go:171","msg":"trace[2056167402] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:621; }","duration":"218.391102ms","start":"2026-05-12T11:23:10.709371Z","end":"2026-05-12T11:23:10.927762Z","steps":["trace[2056167402] 'agreement among raft nodes before linearized reading' (duration: 218.353758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.927914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.183301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.92794Z","caller":"traceutil/trace.go:171","msg":"trace[167996323] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:621; }","duration":"258.246888ms","start":"2026-05-12T11:23:10.669687Z","end":"2026-05-12T11:23:10.927934Z","steps":["trace[167996323] 'agreement among raft nodes before linearized reading' (duration: 258.205254ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.928111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.414114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.928194Z","caller":"traceutil/trace.go:171","msg":"trace[2067935011] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:621; }","duration":"258.531315ms","start":"2026-05-12T11:23:10.669642Z","end":"2026-05-12T11:23:10.928173Z","steps":["trace[2067935011] 'agreement among raft nodes before linearized reading' (duration: 258.345357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.928425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.77746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.929002Z","caller":"traceutil/trace.go:171","msg":"trace[270183104] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:621; }","duration":"259.367569ms","start":"2026-05-12T11:23:10.669616Z","end":"2026-05-12T11:23:10.928984Z","steps":["trace[270183104] 'agreement among raft nodes before linearized reading' (duration: 258.77883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.928723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.785098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.929303Z","caller":"traceutil/trace.go:171","msg":"trace[1558396538] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"282.391198ms","start":"2026-05-12T11:23:10.646895Z","end":"2026-05-12T11:23:10.929286Z","steps":["trace[1558396538] 'agreement among raft nodes before linearized reading' (duration: 281.80133ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:10.928754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.875267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:23:10.929422Z","caller":"traceutil/trace.go:171","msg":"trace[1042757990] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:621; }","duration":"282.550044ms","start":"2026-05-12T11:23:10.646855Z","end":"2026-05-12T11:23:10.929405Z","steps":["trace[1042757990] 'agreement among raft nodes before linearized reading' (duration: 281.886468ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:23:12.249462Z","caller":"traceutil/trace.go:171","msg":"trace[522646754] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"117.281575ms","start":"2026-05-12T11:23:12.13216Z","end":"2026-05-12T11:23:12.249442Z","steps":["trace[522646754] 'process raft request' (duration: 117.169894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:23:26.041398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.222429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.123\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-12T11:23:26.041546Z","caller":"traceutil/trace.go:171","msg":"trace[25564766] range","detail":"{range_begin:/registry/masterleases/199.19.213.123; range_end:; response_count:1; response_revision:784; }","duration":"123.428078ms","start":"2026-05-12T11:23:25.918101Z","end":"2026-05-12T11:23:26.041529Z","steps":["trace[25564766] 'range keys from in-memory index tree' (duration: 123.021841ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:24:15.621524Z","caller":"traceutil/trace.go:171","msg":"trace[1982965004] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"181.855847ms","start":"2026-05-12T11:24:15.439621Z","end":"2026-05-12T11:24:15.621477Z","steps":["trace[1982965004] 'process raft request' (duration: 181.584726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:51.916241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.642284ms","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-12T11:24:51.916339Z","caller":"traceutil/trace.go:171","msg":"trace[758659800] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1904; }","duration":"101.789374ms","start":"2026-05-12T11:24:51.814531Z","end":"2026-05-12T11:24:51.91632Z","steps":["trace[758659800] 'range keys from in-memory index tree' (duration: 101.400316ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:24:52.069692Z","caller":"traceutil/trace.go:171","msg":"trace[1626459856] linearizableReadLoop","detail":"{readStateIndex:1978; appliedIndex:1977; }","duration":"121.503012ms","start":"2026-05-12T11:24:51.948167Z","end":"2026-05-12T11:24:52.06967Z","steps":["trace[1626459856] 'read index received' (duration: 113.797928ms)","trace[1626459856] 'applied index is now lower than readState.Index' (duration: 7.703914ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:24:52.069807Z","caller":"traceutil/trace.go:171","msg":"trace[1613338370] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"148.964827ms","start":"2026-05-12T11:24:51.920798Z","end":"2026-05-12T11:24:52.069763Z","steps":["trace[1613338370] 'process raft request' (duration: 141.08774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:24:52.070141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.940885ms","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-12T11:24:52.070278Z","caller":"traceutil/trace.go:171","msg":"trace[712791935] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1906; }","duration":"122.156271ms","start":"2026-05-12T11:24:51.948102Z","end":"2026-05-12T11:24:52.070258Z","steps":["trace[712791935] 'agreement among raft nodes before linearized reading' (duration: 121.681065ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:24.99353Z","caller":"traceutil/trace.go:171","msg":"trace[1650503428] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"125.501928ms","start":"2026-05-12T11:25:24.867991Z","end":"2026-05-12T11:25:24.993492Z","steps":["trace[1650503428] 'process raft request' (duration: 125.273592ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:25.929732Z","caller":"traceutil/trace.go:171","msg":"trace[464694234] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"203.010113ms","start":"2026-05-12T11:25:25.726697Z","end":"2026-05-12T11:25:25.929707Z","steps":["trace[464694234] 'process raft request' (duration: 202.831741ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:25.988716Z","caller":"traceutil/trace.go:171","msg":"trace[678391185] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"260.888409ms","start":"2026-05-12T11:25:25.72779Z","end":"2026-05-12T11:25:25.988678Z","steps":["trace[678391185] 'process raft request' (duration: 233.767944ms)","trace[678391185] 'compare' (duration: 26.877228ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:25:25.988841Z","caller":"traceutil/trace.go:171","msg":"trace[1615091775] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"139.51212ms","start":"2026-05-12T11:25:25.849279Z","end":"2026-05-12T11:25:25.988791Z","steps":["trace[1615091775] 'process raft request' (duration: 139.37214ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:25.989044Z","caller":"traceutil/trace.go:171","msg":"trace[468758471] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"143.754638ms","start":"2026-05-12T11:25:25.845276Z","end":"2026-05-12T11:25:25.98903Z","steps":["trace[468758471] 'process raft request' (duration: 143.318118ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:25:26.213288Z","caller":"traceutil/trace.go:171","msg":"trace[698020646] linearizableReadLoop","detail":"{readStateIndex:2224; appliedIndex:2223; }","duration":"105.31032ms","start":"2026-05-12T11:25:26.107936Z","end":"2026-05-12T11:25:26.213246Z","steps":["trace[698020646] 'read index received' (duration: 27.138165ms)","trace[698020646] 'applied index is now lower than readState.Index' (duration: 78.169944ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:25:26.213602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.649393ms","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-12T11:25:26.213633Z","caller":"traceutil/trace.go:171","msg":"trace[750398668] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2144; }","duration":"105.702027ms","start":"2026-05-12T11:25:26.10792Z","end":"2026-05-12T11:25:26.213622Z","steps":["trace[750398668] 'agreement among raft nodes before linearized reading' (duration: 105.508193ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:26:59.542929Z","caller":"traceutil/trace.go:171","msg":"trace[903570901] transaction","detail":"{read_only:false; response_revision:2758; number_of_response:1; }","duration":"105.041654ms","start":"2026-05-12T11:26:59.437845Z","end":"2026-05-12T11:26:59.542887Z","steps":["trace[903570901] 'process raft request' (duration: 104.870193ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:04.873257Z","caller":"traceutil/trace.go:171","msg":"trace[1856352654] linearizableReadLoop","detail":"{readStateIndex:2891; appliedIndex:2890; }","duration":"125.210899ms","start":"2026-05-12T11:27:04.748022Z","end":"2026-05-12T11:27:04.873233Z","steps":["trace[1856352654] 'read index received' (duration: 41.032412ms)","trace[1856352654] 'applied index is now lower than readState.Index' (duration: 84.177217ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:27:04.873796Z","caller":"traceutil/trace.go:171","msg":"trace[1431087557] transaction","detail":"{read_only:false; response_revision:2789; number_of_response:1; }","duration":"133.065381ms","start":"2026-05-12T11:27:04.740714Z","end":"2026-05-12T11:27:04.87378Z","steps":["trace[1431087557] 'process raft request' (duration: 48.425273ms)","trace[1431087557] 'compare' (duration: 83.965713ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:27:04.874222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.166754ms","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-12T11:27:04.874308Z","caller":"traceutil/trace.go:171","msg":"trace[1710112826] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2789; }","duration":"126.290002ms","start":"2026-05-12T11:27:04.747995Z","end":"2026-05-12T11:27:04.874285Z","steps":["trace[1710112826] 'agreement among raft nodes before linearized reading' (duration: 125.329007ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:27:05.075916Z","caller":"traceutil/trace.go:171","msg":"trace[965548343] transaction","detail":"{read_only:false; response_revision:2790; number_of_response:1; }","duration":"194.600096ms","start":"2026-05-12T11:27:04.881285Z","end":"2026-05-12T11:27:05.075885Z","steps":["trace[965548343] 'process raft request' (duration: 143.704458ms)","trace[965548343] 'compare' (duration: 50.772269ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:30:47.481946Z","caller":"traceutil/trace.go:171","msg":"trace[1516723351] transaction","detail":"{read_only:false; response_revision:4592; number_of_response:1; }","duration":"123.926562ms","start":"2026-05-12T11:30:47.357999Z","end":"2026-05-12T11:30:47.481925Z","steps":["trace[1516723351] 'process raft request' (duration: 123.801769ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:55.381091Z","caller":"traceutil/trace.go:171","msg":"trace[419476722] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"202.578643ms","start":"2026-05-12T11:30:55.178488Z","end":"2026-05-12T11:30:55.381067Z","steps":["trace[419476722] 'process raft request' (duration: 202.378008ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:30:55.400316Z","caller":"traceutil/trace.go:171","msg":"trace[1192429522] transaction","detail":"{read_only:false; response_revision:4772; number_of_response:1; }","duration":"206.334744ms","start":"2026-05-12T11:30:55.193964Z","end":"2026-05-12T11:30:55.400299Z","steps":["trace[1192429522] 'process raft request' (duration: 206.048177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:07.681454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.157603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-05-12T11:31:07.681542Z","caller":"traceutil/trace.go:171","msg":"trace[296428058] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4937; }","duration":"255.278877ms","start":"2026-05-12T11:31:07.426242Z","end":"2026-05-12T11:31:07.68152Z","steps":["trace[296428058] 'range keys from in-memory index tree' (duration: 255.00782ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:07.681638Z","caller":"traceutil/trace.go:171","msg":"trace[1231849967] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"210.031936ms","start":"2026-05-12T11:31:07.471561Z","end":"2026-05-12T11:31:07.681593Z","steps":["trace[1231849967] 'process raft request' (duration: 198.53627ms)","trace[1231849967] 'compare' (duration: 11.000253ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:31:07.840033Z","caller":"traceutil/trace.go:171","msg":"trace[2050692374] linearizableReadLoop","detail":"{readStateIndex:5125; appliedIndex:5123; }","duration":"316.371709ms","start":"2026-05-12T11:31:07.523639Z","end":"2026-05-12T11:31:07.840011Z","steps":["trace[2050692374] 'read index received' (duration: 146.461978ms)","trace[2050692374] 'applied index is now lower than readState.Index' (duration: 169.908821ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:31:07.840134Z","caller":"traceutil/trace.go:171","msg":"trace[825829194] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"367.043944ms","start":"2026-05-12T11:31:07.473082Z","end":"2026-05-12T11:31:07.840126Z","steps":["trace[825829194] 'process raft request' (duration: 329.933269ms)","trace[825829194] 'compare' (duration: 36.889979ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:31:07.840377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:31:07.473057Z","time spent":"367.100416ms","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-12T11:31:07.840384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.728298ms","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-12T11:31:07.840475Z","caller":"traceutil/trace.go:171","msg":"trace[1818498063] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4939; }","duration":"317.093877ms","start":"2026-05-12T11:31:07.523358Z","end":"2026-05-12T11:31:07.840452Z","steps":["trace[1818498063] 'agreement among raft nodes before linearized reading' (duration: 316.865991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:07.840519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:31:07.523341Z","time spent":"317.16794ms","remote":"127.0.0.1:47908","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-12T11:31:07.895053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.05919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T11:31:07.895123Z","caller":"traceutil/trace.go:171","msg":"trace[2017779113] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:4940; }","duration":"313.168893ms","start":"2026-05-12T11:31:07.581939Z","end":"2026-05-12T11:31:07.895108Z","steps":["trace[2017779113] 'agreement among raft nodes before linearized reading' (duration: 313.037639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:07.895096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.985679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:31:07.895162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:31:07.581926Z","time spent":"313.228025ms","remote":"127.0.0.1:48208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":4,"response size":30,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-12T11:31:07.895185Z","caller":"traceutil/trace.go:171","msg":"trace[124016279] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4940; }","duration":"345.131403ms","start":"2026-05-12T11:31:07.550034Z","end":"2026-05-12T11:31:07.895165Z","steps":["trace[124016279] 'agreement among raft nodes before linearized reading' (duration: 344.967778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:07.89523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:31:07.550007Z","time spent":"345.214356ms","remote":"127.0.0.1:47754","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-12T11:31:07.895208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.474419ms","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-12T11:31:07.895294Z","caller":"traceutil/trace.go:171","msg":"trace[1096777953] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4940; }","duration":"175.607072ms","start":"2026-05-12T11:31:07.719668Z","end":"2026-05-12T11:31:07.895275Z","steps":["trace[1096777953] 'agreement among raft nodes before linearized reading' (duration: 175.299913ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:07.895748Z","caller":"traceutil/trace.go:171","msg":"trace[1297693804] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"204.100388ms","start":"2026-05-12T11:31:07.691628Z","end":"2026-05-12T11:31:07.895728Z","steps":["trace[1297693804] 'process raft request' (duration: 203.151192ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.103667Z","caller":"traceutil/trace.go:171","msg":"trace[1829808606] transaction","detail":"{read_only:false; response_revision:4942; number_of_response:1; }","duration":"199.802173ms","start":"2026-05-12T11:31:07.903837Z","end":"2026-05-12T11:31:08.10364Z","steps":["trace[1829808606] 'process raft request' (duration: 199.535426ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.103717Z","caller":"traceutil/trace.go:171","msg":"trace[665456415] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"199.815063ms","start":"2026-05-12T11:31:07.903885Z","end":"2026-05-12T11:31:08.1037Z","steps":["trace[665456415] 'process raft request' (duration: 199.660429ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.103769Z","caller":"traceutil/trace.go:171","msg":"trace[1437642280] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"199.486355ms","start":"2026-05-12T11:31:07.904259Z","end":"2026-05-12T11:31:08.103746Z","steps":["trace[1437642280] 'process raft request' (duration: 199.341881ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.103708Z","caller":"traceutil/trace.go:171","msg":"trace[1107982268] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"199.232928ms","start":"2026-05-12T11:31:07.904459Z","end":"2026-05-12T11:31:08.103692Z","steps":["trace[1107982268] 'process raft request' (duration: 199.187086ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.104277Z","caller":"traceutil/trace.go:171","msg":"trace[1765956733] linearizableReadLoop","detail":"{readStateIndex:5131; appliedIndex:5131; }","duration":"136.107372ms","start":"2026-05-12T11:31:07.968154Z","end":"2026-05-12T11:31:08.104262Z","steps":["trace[1765956733] 'read index received' (duration: 136.098561ms)","trace[1765956733] 'applied index is now lower than readState.Index' (duration: 7.241µs)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:31:08.104413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.243735ms","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-12T11:31:08.104437Z","caller":"traceutil/trace.go:171","msg":"trace[1054365305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4945; }","duration":"136.305257ms","start":"2026-05-12T11:31:07.968125Z","end":"2026-05-12T11:31:08.10443Z","steps":["trace[1054365305] 'agreement among raft nodes before linearized reading' (duration: 136.199014ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.140214Z","caller":"traceutil/trace.go:171","msg":"trace[1970972854] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"171.849888ms","start":"2026-05-12T11:31:07.968338Z","end":"2026-05-12T11:31:08.140188Z","steps":["trace[1970972854] 'process raft request' (duration: 171.615762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:08.14024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.280816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-12T11:31:08.140287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.499541ms","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-12T11:31:08.140316Z","caller":"traceutil/trace.go:171","msg":"trace[1511793689] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:4946; }","duration":"144.40839ms","start":"2026-05-12T11:31:07.995888Z","end":"2026-05-12T11:31:08.140297Z","steps":["trace[1511793689] 'agreement among raft nodes before linearized reading' (duration: 144.244086ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.14034Z","caller":"traceutil/trace.go:171","msg":"trace[2017298372] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4946; }","duration":"150.590834ms","start":"2026-05-12T11:31:07.989735Z","end":"2026-05-12T11:31:08.140326Z","steps":["trace[2017298372] 'agreement among raft nodes before linearized reading' (duration: 150.390028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:31:08.140508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.759639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-12T11:31:08.14058Z","caller":"traceutil/trace.go:171","msg":"trace[805475394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4946; }","duration":"144.859472ms","start":"2026-05-12T11:31:07.995709Z","end":"2026-05-12T11:31:08.140568Z","steps":["trace[805475394] 'agreement among raft nodes before linearized reading' (duration: 144.442811ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.228989Z","caller":"traceutil/trace.go:171","msg":"trace[2020030721] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"120.603844ms","start":"2026-05-12T11:31:08.108337Z","end":"2026-05-12T11:31:08.228941Z","steps":["trace[2020030721] 'process raft request' (duration: 51.151957ms)","trace[2020030721] 'compare' (duration: 68.952893ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:31:08.55984Z","caller":"traceutil/trace.go:171","msg":"trace[806259460] linearizableReadLoop","detail":"{readStateIndex:5137; appliedIndex:5136; }","duration":"124.865858ms","start":"2026-05-12T11:31:08.434951Z","end":"2026-05-12T11:31:08.559817Z","steps":["trace[806259460] 'read index received' (duration: 91.29283ms)","trace[806259460] 'applied index is now lower than readState.Index' (duration: 33.571688ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:31:08.559968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.999262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:31:08.560009Z","caller":"traceutil/trace.go:171","msg":"trace[1224106998] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4951; }","duration":"125.098344ms","start":"2026-05-12T11:31:08.434901Z","end":"2026-05-12T11:31:08.56Z","steps":["trace[1224106998] 'agreement among raft nodes before linearized reading' (duration: 125.006012ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:08.559925Z","caller":"traceutil/trace.go:171","msg":"trace[1039141105] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"152.478166ms","start":"2026-05-12T11:31:08.407427Z","end":"2026-05-12T11:31:08.559905Z","steps":["trace[1039141105] 'process raft request' (duration: 118.900678ms)","trace[1039141105] 'compare' (duration: 33.345422ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:31:08.608904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.386286ms","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-12T11:31:08.609457Z","caller":"traceutil/trace.go:171","msg":"trace[1930078046] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4952; }","duration":"102.686504ms","start":"2026-05-12T11:31:08.506449Z","end":"2026-05-12T11:31:08.609136Z","steps":["trace[1930078046] 'agreement among raft nodes before linearized reading' (duration: 102.268953ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:31:09.041645Z","caller":"traceutil/trace.go:171","msg":"trace[537749844] transaction","detail":"{read_only:false; response_revision:4955; number_of_response:1; }","duration":"167.589896ms","start":"2026-05-12T11:31:08.874018Z","end":"2026-05-12T11:31:09.041608Z","steps":["trace[537749844] 'process raft request' (duration: 96.367515ms)","trace[537749844] 'compare' (duration: 71.024476ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:32:32.999086Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2936} {"level":"info","ts":"2026-05-12T11:32:33.077517Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2936,"took":"76.990022ms","hash":544918439,"current-db-size-bytes":53096448,"current-db-size":"53 MB","current-db-size-in-use-bytes":29097984,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-12T11:32:33.077819Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":544918439,"revision":2936,"compact-revision":-1} {"level":"info","ts":"2026-05-12T11:34:24.10323Z","caller":"traceutil/trace.go:171","msg":"trace[148265615] transaction","detail":"{read_only:false; response_revision:6307; number_of_response:1; }","duration":"106.791517ms","start":"2026-05-12T11:34:23.996405Z","end":"2026-05-12T11:34:24.103196Z","steps":["trace[148265615] 'process raft request' (duration: 106.569977ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:24.391425Z","caller":"traceutil/trace.go:171","msg":"trace[1343823280] transaction","detail":"{read_only:false; response_revision:6308; number_of_response:1; }","duration":"207.834107ms","start":"2026-05-12T11:34:24.183563Z","end":"2026-05-12T11:34:24.391397Z","steps":["trace[1343823280] 'process raft request' (duration: 205.917152ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:24.709764Z","caller":"traceutil/trace.go:171","msg":"trace[1896054367] linearizableReadLoop","detail":"{readStateIndex:6552; appliedIndex:6550; }","duration":"241.35729ms","start":"2026-05-12T11:34:24.468311Z","end":"2026-05-12T11:34:24.709668Z","steps":["trace[1896054367] 'read index received' (duration: 241.066777ms)","trace[1896054367] 'applied index is now lower than readState.Index' (duration: 289.053µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:34:24.7099Z","caller":"traceutil/trace.go:171","msg":"trace[1645446247] transaction","detail":"{read_only:false; response_revision:6317; number_of_response:1; }","duration":"257.228832ms","start":"2026-05-12T11:34:24.452657Z","end":"2026-05-12T11:34:24.709886Z","steps":["trace[1645446247] 'process raft request' (duration: 256.770421ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:24.710053Z","caller":"traceutil/trace.go:171","msg":"trace[625194375] transaction","detail":"{read_only:false; response_revision:6318; number_of_response:1; }","duration":"255.649271ms","start":"2026-05-12T11:34:24.454391Z","end":"2026-05-12T11:34:24.710041Z","steps":["trace[625194375] 'process raft request' (duration: 255.216401ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:34:24.710286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.953776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-12T11:34:24.710539Z","caller":"traceutil/trace.go:171","msg":"trace[527376377] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:6318; }","duration":"242.056441ms","start":"2026-05-12T11:34:24.46826Z","end":"2026-05-12T11:34:24.710317Z","steps":["trace[527376377] 'agreement among raft nodes before linearized reading' (duration: 241.875663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:34:24.712384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.609461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-12T11:34:24.712535Z","caller":"traceutil/trace.go:171","msg":"trace[1765280050] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:6320; }","duration":"243.786579ms","start":"2026-05-12T11:34:24.468734Z","end":"2026-05-12T11:34:24.71252Z","steps":["trace[1765280050] 'agreement among raft nodes before linearized reading' (duration: 243.454745ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:24.712994Z","caller":"traceutil/trace.go:171","msg":"trace[79770352] transaction","detail":"{read_only:false; response_revision:6319; number_of_response:1; }","duration":"208.079359ms","start":"2026-05-12T11:34:24.504895Z","end":"2026-05-12T11:34:24.712974Z","steps":["trace[79770352] 'process raft request' (duration: 207.033032ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:25.313705Z","caller":"traceutil/trace.go:171","msg":"trace[814371689] transaction","detail":"{read_only:false; response_revision:6339; number_of_response:1; }","duration":"371.876502ms","start":"2026-05-12T11:34:24.941791Z","end":"2026-05-12T11:34:25.313667Z","steps":["trace[814371689] 'process raft request' (duration: 371.412592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:34:25.314056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:34:24.941772Z","time spent":"372.02063ms","remote":"127.0.0.1:48168","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8131,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-12T11:34:25.314584Z","caller":"traceutil/trace.go:171","msg":"trace[488412586] transaction","detail":"{read_only:false; response_revision:6340; number_of_response:1; }","duration":"372.618047ms","start":"2026-05-12T11:34:24.941937Z","end":"2026-05-12T11:34:25.314555Z","steps":["trace[488412586] 'process raft request' (duration: 372.331134ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:25.314598Z","caller":"traceutil/trace.go:171","msg":"trace[2137010950] linearizableReadLoop","detail":"{readStateIndex:6575; appliedIndex:6572; }","duration":"369.519258ms","start":"2026-05-12T11:34:24.945034Z","end":"2026-05-12T11:34:25.314553Z","steps":["trace[2137010950] 'read index received' (duration: 368.485081ms)","trace[2137010950] 'applied index is now lower than readState.Index' (duration: 1.032497ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:34:25.314934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:34:24.941912Z","time spent":"372.730652ms","remote":"127.0.0.1:47922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":503,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:34:25.315269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.069534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:62003"} {"level":"info","ts":"2026-05-12T11:34:25.315345Z","caller":"traceutil/trace.go:171","msg":"trace[648034941] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:6341; }","duration":"366.189599ms","start":"2026-05-12T11:34:24.949137Z","end":"2026-05-12T11:34:25.315326Z","steps":["trace[648034941] 'agreement among raft nodes before linearized reading' (duration: 365.805832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:34:25.315396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:34:24.949127Z","time spent":"366.254592ms","remote":"127.0.0.1:47938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":6,"response size":62026,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"info","ts":"2026-05-12T11:34:25.316495Z","caller":"traceutil/trace.go:171","msg":"trace[103686790] transaction","detail":"{read_only:false; response_revision:6341; number_of_response:1; }","duration":"374.403696ms","start":"2026-05-12T11:34:24.942062Z","end":"2026-05-12T11:34:25.316466Z","steps":["trace[103686790] 'process raft request' (duration: 372.418818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:34:25.316778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:34:24.942049Z","time spent":"374.626028ms","remote":"127.0.0.1:47988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":966,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-12T11:34:25.317135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.772579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-12T11:34:25.317215Z","caller":"traceutil/trace.go:171","msg":"trace[1266887004] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:6341; }","duration":"372.185928ms","start":"2026-05-12T11:34:24.945008Z","end":"2026-05-12T11:34:25.317194Z","steps":["trace[1266887004] 'agreement among raft nodes before linearized reading' (duration: 369.770989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:34:25.317469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:34:24.944999Z","time spent":"372.411117ms","remote":"127.0.0.1:48086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":1147,"request content":"key:\"/registry/storageclasses/general\" "} {"level":"warn","ts":"2026-05-12T11:34:25.319014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.745674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195929"} {"level":"info","ts":"2026-05-12T11:34:25.319284Z","caller":"traceutil/trace.go:171","msg":"trace[1622777722] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:6341; }","duration":"361.228217ms","start":"2026-05-12T11:34:24.957898Z","end":"2026-05-12T11:34:25.319126Z","steps":["trace[1622777722] 'agreement among raft nodes before linearized reading' (duration: 358.110587ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:34:25.319412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:34:24.957883Z","time spent":"361.455718ms","remote":"127.0.0.1:47854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2195952,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-05-12T11:34:48.980764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.391674ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-12T11:34:48.981115Z","caller":"traceutil/trace.go:171","msg":"trace[1033739102] transaction","detail":"{read_only:false; response_revision:6559; number_of_response:1; }","duration":"160.667261ms","start":"2026-05-12T11:34:48.82041Z","end":"2026-05-12T11:34:48.981078Z","steps":["trace[1033739102] 'process raft request' (duration: 56.87988ms)","trace[1033739102] 'compare' (duration: 103.258247ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:34:48.981367Z","caller":"traceutil/trace.go:171","msg":"trace[2060279916] transaction","detail":"{read_only:false; response_revision:6560; number_of_response:1; }","duration":"158.416938ms","start":"2026-05-12T11:34:48.822929Z","end":"2026-05-12T11:34:48.981346Z","steps":["trace[2060279916] 'process raft request' (duration: 157.933096ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:49.177979Z","caller":"traceutil/trace.go:171","msg":"trace[700827186] transaction","detail":"{read_only:false; response_revision:6561; number_of_response:1; }","duration":"126.546565ms","start":"2026-05-12T11:34:49.051404Z","end":"2026-05-12T11:34:49.17795Z","steps":["trace[700827186] 'process raft request' (duration: 68.311102ms)","trace[700827186] 'compare' (duration: 57.891287ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:34:49.542572Z","caller":"traceutil/trace.go:171","msg":"trace[2090384857] transaction","detail":"{read_only:false; response_revision:6562; number_of_response:1; }","duration":"114.229282ms","start":"2026-05-12T11:34:49.428312Z","end":"2026-05-12T11:34:49.542541Z","steps":["trace[2090384857] 'process raft request' (duration: 113.979251ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:49.69632Z","caller":"traceutil/trace.go:171","msg":"trace[1915171960] transaction","detail":"{read_only:false; response_revision:6565; number_of_response:1; }","duration":"132.063877ms","start":"2026-05-12T11:34:49.564224Z","end":"2026-05-12T11:34:49.696288Z","steps":["trace[1915171960] 'process raft request' (duration: 89.069882ms)","trace[1915171960] 'compare' (duration: 42.769664ms)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:34:49.696984Z","caller":"traceutil/trace.go:171","msg":"trace[1408528122] transaction","detail":"{read_only:false; response_revision:6567; number_of_response:1; }","duration":"114.451942ms","start":"2026-05-12T11:34:49.582508Z","end":"2026-05-12T11:34:49.69696Z","steps":["trace[1408528122] 'process raft request' (duration: 114.345237ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:34:49.696996Z","caller":"traceutil/trace.go:171","msg":"trace[246251972] transaction","detail":"{read_only:false; response_revision:6566; number_of_response:1; }","duration":"132.632583ms","start":"2026-05-12T11:34:49.564343Z","end":"2026-05-12T11:34:49.696975Z","steps":["trace[246251972] 'process raft request' (duration: 131.884849ms)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:37:33.005667Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5620} {"level":"info","ts":"2026-05-12T11:37:33.07212Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5620,"took":"64.929107ms","hash":1989488007,"current-db-size-bytes":53096448,"current-db-size":"53 MB","current-db-size-in-use-bytes":18378752,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-12T11:37:33.072169Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1989488007,"revision":5620,"compact-revision":2936} {"level":"info","ts":"2026-05-12T11:38:08.500123Z","caller":"traceutil/trace.go:171","msg":"trace[703563731] linearizableReadLoop","detail":"{readStateIndex:7934; appliedIndex:7933; }","duration":"220.185244ms","start":"2026-05-12T11:38:08.279917Z","end":"2026-05-12T11:38:08.500102Z","steps":["trace[703563731] 'read index received' (duration: 219.98742ms)","trace[703563731] 'applied index is now lower than readState.Index' (duration: 196.644µs)"],"step_count":2} {"level":"info","ts":"2026-05-12T11:38:08.500279Z","caller":"traceutil/trace.go:171","msg":"trace[566385704] transaction","detail":"{read_only:false; response_revision:7650; number_of_response:1; }","duration":"249.006393ms","start":"2026-05-12T11:38:08.251261Z","end":"2026-05-12T11:38:08.500267Z","steps":["trace[566385704] 'process raft request' (duration: 248.706827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:08.500307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.379847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/openstack/horizon-horizon-db-init\" ","response":"range_response_count:1 size:744"} {"level":"info","ts":"2026-05-12T11:38:08.500338Z","caller":"traceutil/trace.go:171","msg":"trace[1507407333] range","detail":"{range_begin:/registry/rolebindings/openstack/horizon-horizon-db-init; range_end:; response_count:1; response_revision:7650; }","duration":"220.451758ms","start":"2026-05-12T11:38:08.279876Z","end":"2026-05-12T11:38:08.500328Z","steps":["trace[1507407333] 'agreement among raft nodes before linearized reading' (duration: 220.313025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:09.984007Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750707616969773602,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T11:38:10.484489Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750707616969773602,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T11:38:10.984585Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750707616969773602,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T11:38:11.485348Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750707616969773602,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T11:38:11.98648Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750707616969773602,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-12T11:38:11.997037Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.519371641s","expected-duration":"1s"} {"level":"info","ts":"2026-05-12T11:38:11.997445Z","caller":"traceutil/trace.go:171","msg":"trace[1099678181] transaction","detail":"{read_only:false; response_revision:7655; number_of_response:1; }","duration":"2.5198428s","start":"2026-05-12T11:38:09.477567Z","end":"2026-05-12T11:38:11.99741Z","steps":["trace[1099678181] 'process raft request' (duration: 2.519721608s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:11.997562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:09.477543Z","time spent":"2.519932692s","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:38:12.000723Z","caller":"traceutil/trace.go:171","msg":"trace[988231479] transaction","detail":"{read_only:false; response_revision:7656; number_of_response:1; }","duration":"2.278331577s","start":"2026-05-12T11:38:09.722377Z","end":"2026-05-12T11:38:12.000708Z","steps":["trace[988231479] 'process raft request' (duration: 2.278219655s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.000806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:09.722355Z","time spent":"2.278405748s","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:38:12.001393Z","caller":"traceutil/trace.go:171","msg":"trace[1159362876] transaction","detail":"{read_only:false; response_revision:7657; number_of_response:1; }","duration":"2.123822924s","start":"2026-05-12T11:38:09.877547Z","end":"2026-05-12T11:38:12.00137Z","steps":["trace[1159362876] 'process raft request' (duration: 2.123129689s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.001679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:09.877523Z","time spent":"2.123948966s","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:38:12.001665Z","caller":"traceutil/trace.go:171","msg":"trace[1091535086] transaction","detail":"{read_only:false; response_revision:7658; number_of_response:1; }","duration":"1.496295944s","start":"2026-05-12T11:38:10.505285Z","end":"2026-05-12T11:38:12.001581Z","steps":["trace[1091535086] 'process raft request' (duration: 1.495732062s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.002211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.505266Z","time spent":"1.496820533s","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-12T11:38:12.004117Z","caller":"traceutil/trace.go:171","msg":"trace[288376014] linearizableReadLoop","detail":"{readStateIndex:7943; appliedIndex:7938; }","duration":"2.520744819s","start":"2026-05-12T11:38:09.483354Z","end":"2026-05-12T11:38:12.004099Z","steps":["trace[288376014] 'read index received' (duration: 2.513938957s)","trace[288376014] 'applied index is now lower than readState.Index' (duration: 6.804792ms)"],"step_count":2} {"level":"warn","ts":"2026-05-12T11:38:12.004294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390149417s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-12T11:38:12.004292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.520928493s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:751"} {"level":"info","ts":"2026-05-12T11:38:12.004322Z","caller":"traceutil/trace.go:171","msg":"trace[886736282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7658; }","duration":"1.390224209s","start":"2026-05-12T11:38:10.614091Z","end":"2026-05-12T11:38:12.004316Z","steps":["trace[886736282] 'agreement among raft nodes before linearized reading' (duration: 1.390125277s)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:38:12.004337Z","caller":"traceutil/trace.go:171","msg":"trace[1549415282] range","detail":"{range_begin:/registry/rolebindings/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:7658; }","duration":"2.521004814s","start":"2026-05-12T11:38:09.483319Z","end":"2026-05-12T11:38:12.004324Z","steps":["trace[1549415282] 'agreement among raft nodes before linearized reading' (duration: 2.520873701s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.004346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.614071Z","time spent":"1.390269449s","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-12T11:38:12.004344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.260488436s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-12T11:38:12.004346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.87671944s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-12T11:38:12.004385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.454918606s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-12T11:38:12.004379Z","caller":"traceutil/trace.go:171","msg":"trace[2046413384] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:7658; }","duration":"2.260520987s","start":"2026-05-12T11:38:09.743847Z","end":"2026-05-12T11:38:12.004368Z","steps":["trace[2046413384] 'agreement among raft nodes before linearized reading' (duration: 2.260470916s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.004339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.534117103s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-12T11:38:12.004405Z","caller":"traceutil/trace.go:171","msg":"trace[803262731] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7658; }","duration":"1.454969167s","start":"2026-05-12T11:38:10.549432Z","end":"2026-05-12T11:38:12.004401Z","steps":["trace[803262731] 'agreement among raft nodes before linearized reading' (duration: 1.454941217s)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:38:12.004405Z","caller":"traceutil/trace.go:171","msg":"trace[107908652] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7658; }","duration":"1.876813322s","start":"2026-05-12T11:38:10.127577Z","end":"2026-05-12T11:38:12.004391Z","steps":["trace[107908652] 'agreement among raft nodes before linearized reading' (duration: 1.87668726s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.004418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.549416Z","time spent":"1.454999528s","remote":"127.0.0.1:47754","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-12T11:38:12.004415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:09.743819Z","time spent":"2.260587838s","remote":"127.0.0.1:47908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":4,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-05-12T11:38:12.004437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.127558Z","time spent":"1.876870663s","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-12T11:38:12.004462Z","caller":"traceutil/trace.go:171","msg":"trace[1688384110] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7658; }","duration":"1.534261256s","start":"2026-05-12T11:38:10.470151Z","end":"2026-05-12T11:38:12.004413Z","steps":["trace[1688384110] 'agreement among raft nodes before linearized reading' (duration: 1.534089482s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.004523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.388250701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-12T11:38:12.004507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.329016719s","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":"warn","ts":"2026-05-12T11:38:12.00454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.470128Z","time spent":"1.534372638s","remote":"127.0.0.1:59152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":30,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-05-12T11:38:12.004546Z","caller":"traceutil/trace.go:171","msg":"trace[1430731710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7658; }","duration":"1.388291541s","start":"2026-05-12T11:38:10.616249Z","end":"2026-05-12T11:38:12.00454Z","steps":["trace[1430731710] 'agreement among raft nodes before linearized reading' (duration: 1.38824371s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.004566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.616239Z","time spent":"1.388322321s","remote":"127.0.0.1:47986","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-12T11:38:12.004565Z","caller":"traceutil/trace.go:171","msg":"trace[293821757] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7658; }","duration":"1.32910191s","start":"2026-05-12T11:38:10.675447Z","end":"2026-05-12T11:38:12.004549Z","steps":["trace[293821757] 'agreement among raft nodes before linearized reading' (duration: 1.328944047s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.004597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.675439Z","time spent":"1.329151112s","remote":"127.0.0.1:47986","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-12T11:38:12.004482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.381214754s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-05-12T11:38:12.004298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.454969478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/openstack/keystone-credential-rotate\" ","response":"range_response_count:1 size:755"} {"level":"info","ts":"2026-05-12T11:38:12.004634Z","caller":"traceutil/trace.go:171","msg":"trace[918953470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7658; }","duration":"1.381379668s","start":"2026-05-12T11:38:10.623244Z","end":"2026-05-12T11:38:12.004624Z","steps":["trace[918953470] 'agreement among raft nodes before linearized reading' (duration: 1.381204944s)"],"step_count":1} {"level":"info","ts":"2026-05-12T11:38:12.004646Z","caller":"traceutil/trace.go:171","msg":"trace[1680454197] range","detail":"{range_begin:/registry/rolebindings/openstack/keystone-credential-rotate; range_end:; response_count:1; response_revision:7658; }","duration":"2.455361105s","start":"2026-05-12T11:38:09.549278Z","end":"2026-05-12T11:38:12.004639Z","steps":["trace[1680454197] 'agreement among raft nodes before linearized reading' (duration: 2.454929747s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.004656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.048795245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-12T11:38:12.004663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.623234Z","time spent":"1.381420818s","remote":"127.0.0.1:47986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-12T11:38:12.004678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:09.549262Z","time spent":"2.455407107s","remote":"127.0.0.1:48056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":778,"request content":"key:\"/registry/rolebindings/openstack/keystone-credential-rotate\" "} {"level":"info","ts":"2026-05-12T11:38:12.004679Z","caller":"traceutil/trace.go:171","msg":"trace[1839797945] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:7658; }","duration":"1.048857427s","start":"2026-05-12T11:38:10.955815Z","end":"2026-05-12T11:38:12.004673Z","steps":["trace[1839797945] 'agreement among raft nodes before linearized reading' (duration: 1.048803376s)"],"step_count":1} {"level":"warn","ts":"2026-05-12T11:38:12.00436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:09.483301Z","time spent":"2.521053986s","remote":"127.0.0.1:48056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":774,"request content":"key:\"/registry/rolebindings/openstack/keystone-credential-setup\" "} {"level":"warn","ts":"2026-05-12T11:38:12.004709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-12T11:38:10.955796Z","time spent":"1.048906287s","remote":"127.0.0.1:48190","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":19,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "}