{"level":"warn","ts":"2026-07-28T08:02:00.755901Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-28T08:02:00.756004Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-28T08:02:00.756093Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-28T08:02:00.756104Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-07-28T08:02:00.756119Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-28T08:02:00.756726Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-07-28T08:02:00.756793Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-28T08:02:00.760573Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.537944ms"} {"level":"info","ts":"2026-07-28T08:02:00.76984Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-07-28T08:02:00.769959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-07-28T08:02:00.770031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-07-28T08:02:00.770058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-28T08:02:00.770081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-07-28T08:02:00.770132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-07-28T08:02:00.788871Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-28T08:02:00.790635Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-28T08:02:00.79397Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-28T08:02:00.796962Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-28T08:02:00.797422Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-28T08:02:00.797696Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-28T08:02:00.797832Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-28T08:02:00.797895Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-28T08:02:00.804057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-07-28T08:02:00.804259Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-07-28T08:02:00.806434Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-28T08:02:00.806728Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-28T08:02:00.806788Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-28T08:02:00.807254Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-07-28T08:02:00.807281Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-07-28T08:02:00.871128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-07-28T08:02:00.871191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-07-28T08:02:00.871221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-07-28T08:02:00.871239Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-07-28T08:02:00.871249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-07-28T08:02:00.871265Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-07-28T08:02:00.871288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-07-28T08:02:00.872296Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T08:02:00.872975Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T08:02:00.873004Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T08:02:00.872971Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-07-28T08:02:00.873475Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-28T08:02:00.873532Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-28T08:02:00.874371Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T08:02:00.874498Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T08:02:00.874546Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T08:02:00.876438Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-28T08:02:00.878884Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-07-28T08:02:10.621722Z","caller":"traceutil/trace.go:171","msg":"trace[264018774] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"137.030441ms","start":"2026-07-28T08:02:10.484663Z","end":"2026-07-28T08:02:10.621694Z","steps":["trace[264018774] 'process raft request' (duration: 136.836014ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:02:10.775744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.571758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-28T08:02:10.775912Z","caller":"traceutil/trace.go:171","msg":"trace[875299005] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:354; }","duration":"132.779017ms","start":"2026-07-28T08:02:10.643115Z","end":"2026-07-28T08:02:10.775894Z","steps":["trace[875299005] 'read index received' (duration: 17.333688ms)","trace[875299005] 'applied index is now lower than readState.Index' (duration: 115.443949ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:02:10.775983Z","caller":"traceutil/trace.go:171","msg":"trace[1536312296] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"141.7016ms","start":"2026-07-28T08:02:10.634234Z","end":"2026-07-28T08:02:10.775936Z","steps":["trace[1536312296] 'process raft request' (duration: 26.275012ms)","trace[1536312296] 'compare' (duration: 114.40087ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:02:10.776055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.935323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-28T08:02:10.776082Z","caller":"traceutil/trace.go:171","msg":"trace[1327726692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:340; }","duration":"132.996825ms","start":"2026-07-28T08:02:10.643077Z","end":"2026-07-28T08:02:10.776074Z","steps":["trace[1327726692] 'agreement among raft nodes before linearized reading' (duration: 132.892451ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:02:11.958462Z","caller":"traceutil/trace.go:171","msg":"trace[1673065043] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"106.44119ms","start":"2026-07-28T08:02:11.851947Z","end":"2026-07-28T08:02:11.958388Z","steps":["trace[1673065043] 'process raft request' (duration: 106.302765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:02:42.08654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.992958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:02:42.086629Z","caller":"traceutil/trace.go:171","msg":"trace[2100572014] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:634; }","duration":"125.130571ms","start":"2026-07-28T08:02:41.961478Z","end":"2026-07-28T08:02:42.086609Z","steps":["trace[2100572014] 'range keys from in-memory index tree' (duration: 124.936056ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:02:48.453637Z","caller":"traceutil/trace.go:171","msg":"trace[732331226] transaction","detail":"{read_only:false; response_revision:705; number_of_response:1; }","duration":"148.703415ms","start":"2026-07-28T08:02:48.304907Z","end":"2026-07-28T08:02:48.453611Z","steps":["trace[732331226] 'process raft request' (duration: 148.442099ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:02:49.089944Z","caller":"traceutil/trace.go:171","msg":"trace[184167840] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"211.652659ms","start":"2026-07-28T08:02:48.87827Z","end":"2026-07-28T08:02:49.089923Z","steps":["trace[184167840] 'process raft request' (duration: 211.343051ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:02:49.275267Z","caller":"traceutil/trace.go:171","msg":"trace[1619196713] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"181.055113ms","start":"2026-07-28T08:02:49.094184Z","end":"2026-07-28T08:02:49.275239Z","steps":["trace[1619196713] 'process raft request' (duration: 180.90193ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:02:49.281675Z","caller":"traceutil/trace.go:171","msg":"trace[978179152] linearizableReadLoop","detail":"{readStateIndex:738; appliedIndex:735; }","duration":"149.868391ms","start":"2026-07-28T08:02:49.131795Z","end":"2026-07-28T08:02:49.281663Z","steps":["trace[978179152] 'read index received' (duration: 143.364593ms)","trace[978179152] 'applied index is now lower than readState.Index' (duration: 6.503198ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:02:49.281736Z","caller":"traceutil/trace.go:171","msg":"trace[35331639] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"187.020649ms","start":"2026-07-28T08:02:49.094702Z","end":"2026-07-28T08:02:49.281723Z","steps":["trace[35331639] 'process raft request' (duration: 186.820924ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:02:49.281745Z","caller":"traceutil/trace.go:171","msg":"trace[1033583872] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"186.142197ms","start":"2026-07-28T08:02:49.095596Z","end":"2026-07-28T08:02:49.281738Z","steps":["trace[1033583872] 'process raft request' (duration: 185.984483ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:02:49.281862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.061375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:02:49.281896Z","caller":"traceutil/trace.go:171","msg":"trace[1037729362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:709; }","duration":"150.150458ms","start":"2026-07-28T08:02:49.131738Z","end":"2026-07-28T08:02:49.281888Z","steps":["trace[1037729362] 'agreement among raft nodes before linearized reading' (duration: 150.089576ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:03:45.817065Z","caller":"traceutil/trace.go:171","msg":"trace[1159847004] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"169.781696ms","start":"2026-07-28T08:03:45.647258Z","end":"2026-07-28T08:03:45.81704Z","steps":["trace[1159847004] 'process raft request' (duration: 169.602723ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:03:45.817294Z","caller":"traceutil/trace.go:171","msg":"trace[1660038304] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"169.282369ms","start":"2026-07-28T08:03:45.647983Z","end":"2026-07-28T08:03:45.817265Z","steps":["trace[1660038304] 'process raft request' (duration: 169.021194ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:25.21116Z","caller":"traceutil/trace.go:171","msg":"trace[41117515] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"145.343899ms","start":"2026-07-28T08:04:25.065791Z","end":"2026-07-28T08:04:25.211135Z","steps":["trace[41117515] 'process raft request' (duration: 104.159438ms)","trace[41117515] 'compare' (duration: 41.034999ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:04:25.259195Z","caller":"traceutil/trace.go:171","msg":"trace[1293872717] linearizableReadLoop","detail":"{readStateIndex:1884; appliedIndex:1881; }","duration":"170.675523ms","start":"2026-07-28T08:04:25.08849Z","end":"2026-07-28T08:04:25.259165Z","steps":["trace[1293872717] 'read index received' (duration: 81.476749ms)","trace[1293872717] 'applied index is now lower than readState.Index' (duration: 89.197854ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:04:25.259527Z","caller":"traceutil/trace.go:171","msg":"trace[1620515409] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"172.420227ms","start":"2026-07-28T08:04:25.087091Z","end":"2026-07-28T08:04:25.259511Z","steps":["trace[1620515409] 'process raft request' (duration: 171.868089ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:25.259799Z","caller":"traceutil/trace.go:171","msg":"trace[1006061817] transaction","detail":"{read_only:false; response_revision:1802; number_of_response:1; }","duration":"170.521231ms","start":"2026-07-28T08:04:25.089243Z","end":"2026-07-28T08:04:25.259765Z","steps":["trace[1006061817] 'process raft request' (duration: 169.866712ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:04:25.259875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.365851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-28T08:04:25.259892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.366252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/pxc-operator\" ","response":"range_response_count:1 size:4010"} {"level":"info","ts":"2026-07-28T08:04:25.259962Z","caller":"traceutil/trace.go:171","msg":"trace[703542781] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1802; }","duration":"129.486242ms","start":"2026-07-28T08:04:25.130453Z","end":"2026-07-28T08:04:25.259939Z","steps":["trace[703542781] 'agreement among raft nodes before linearized reading' (duration: 129.3213ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:25.259995Z","caller":"traceutil/trace.go:171","msg":"trace[1029167857] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"172.241444ms","start":"2026-07-28T08:04:25.087734Z","end":"2026-07-28T08:04:25.259976Z","steps":["trace[1029167857] 'process raft request' (duration: 171.331122ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:25.26011Z","caller":"traceutil/trace.go:171","msg":"trace[597690373] range","detail":"{range_begin:/registry/deployments/openstack/pxc-operator; range_end:; response_count:1; response_revision:1802; }","duration":"171.493674ms","start":"2026-07-28T08:04:25.088462Z","end":"2026-07-28T08:04:25.259955Z","steps":["trace[597690373] 'agreement among raft nodes before linearized reading' (duration: 171.284392ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:25.375771Z","caller":"traceutil/trace.go:171","msg":"trace[1257268353] transaction","detail":"{read_only:false; response_revision:1803; number_of_response:1; }","duration":"110.984121ms","start":"2026-07-28T08:04:25.264756Z","end":"2026-07-28T08:04:25.37574Z","steps":["trace[1257268353] 'process raft request' (duration: 109.621772ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:25.407347Z","caller":"traceutil/trace.go:171","msg":"trace[309483167] linearizableReadLoop","detail":"{readStateIndex:1888; appliedIndex:1885; }","duration":"140.197428ms","start":"2026-07-28T08:04:25.267121Z","end":"2026-07-28T08:04:25.407318Z","steps":["trace[309483167] 'read index received' (duration: 107.271939ms)","trace[309483167] 'applied index is now lower than readState.Index' (duration: 32.924299ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:04:25.407404Z","caller":"traceutil/trace.go:171","msg":"trace[857457698] transaction","detail":"{read_only:false; response_revision:1804; number_of_response:1; }","duration":"142.486099ms","start":"2026-07-28T08:04:25.264862Z","end":"2026-07-28T08:04:25.407348Z","steps":["trace[857457698] 'process raft request' (duration: 142.199025ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:25.407567Z","caller":"traceutil/trace.go:171","msg":"trace[110972530] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"141.081809ms","start":"2026-07-28T08:04:25.266441Z","end":"2026-07-28T08:04:25.407523Z","steps":["trace[110972530] 'process raft request' (duration: 140.788426ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:04:25.407662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.507272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/pxc-operator-69cb5bbdb9-8sdm6\" ","response":"range_response_count:1 size:3255"} {"level":"info","ts":"2026-07-28T08:04:25.407696Z","caller":"traceutil/trace.go:171","msg":"trace[2086812577] range","detail":"{range_begin:/registry/pods/openstack/pxc-operator-69cb5bbdb9-8sdm6; range_end:; response_count:1; response_revision:1805; }","duration":"140.600854ms","start":"2026-07-28T08:04:25.267086Z","end":"2026-07-28T08:04:25.407687Z","steps":["trace[2086812577] 'agreement among raft nodes before linearized reading' (duration: 140.385731ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:04:25.408178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.029888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/\" range_end:\"/registry/secrets/openstack0\" ","response":"range_response_count:3 size:222187"} {"level":"info","ts":"2026-07-28T08:04:25.408266Z","caller":"traceutil/trace.go:171","msg":"trace[437700245] range","detail":"{range_begin:/registry/secrets/openstack/; range_end:/registry/secrets/openstack0; response_count:3; response_revision:1805; }","duration":"135.158399ms","start":"2026-07-28T08:04:25.273083Z","end":"2026-07-28T08:04:25.408241Z","steps":["trace[437700245] 'agreement among raft nodes before linearized reading' (duration: 134.796414ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:04:35.986174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.735837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a0a38fbb-f9d4-4bca-9e9c-7745f1014977\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-28T08:04:35.986266Z","caller":"traceutil/trace.go:171","msg":"trace[2043501955] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a0a38fbb-f9d4-4bca-9e9c-7745f1014977; range_end:; response_count:1; response_revision:1935; }","duration":"208.8713ms","start":"2026-07-28T08:04:35.777376Z","end":"2026-07-28T08:04:35.986247Z","steps":["trace[2043501955] 'range keys from in-memory index tree' (duration: 208.529575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:04:36.355313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.00512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-28T08:04:36.35552Z","caller":"traceutil/trace.go:171","msg":"trace[1010555395] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"268.792578ms","start":"2026-07-28T08:04:36.086704Z","end":"2026-07-28T08:04:36.355496Z","steps":["trace[1010555395] 'process raft request' (duration: 268.722787ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:36.355538Z","caller":"traceutil/trace.go:171","msg":"trace[230596533] linearizableReadLoop","detail":"{readStateIndex:2024; appliedIndex:2023; }","duration":"271.095918ms","start":"2026-07-28T08:04:36.08441Z","end":"2026-07-28T08:04:36.355506Z","steps":["trace[230596533] 'read index received' (duration: 1.51724ms)","trace[230596533] 'applied index is now lower than readState.Index' (duration: 269.575508ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:04:36.355675Z","caller":"traceutil/trace.go:171","msg":"trace[580515403] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"283.069555ms","start":"2026-07-28T08:04:36.072589Z","end":"2026-07-28T08:04:36.355658Z","steps":["trace[580515403] 'process raft request' (duration: 13.456187ms)","trace[580515403] 'compare' (duration: 268.910289ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:04:36.355825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.400122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-07-28T08:04:36.356154Z","caller":"traceutil/trace.go:171","msg":"trace[1706910911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1940; }","duration":"271.775997ms","start":"2026-07-28T08:04:36.084361Z","end":"2026-07-28T08:04:36.356137Z","steps":["trace[1706910911] 'agreement among raft nodes before linearized reading' (duration: 271.291111ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:36.369098Z","caller":"traceutil/trace.go:171","msg":"trace[1958147579] transaction","detail":"{read_only:false; response_revision:1941; number_of_response:1; }","duration":"182.579806ms","start":"2026-07-28T08:04:36.186488Z","end":"2026-07-28T08:04:36.369067Z","steps":["trace[1958147579] 'process raft request' (duration: 182.345393ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:04:36.369301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.100168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:04:36.369397Z","caller":"traceutil/trace.go:171","msg":"trace[662001370] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1943; }","duration":"239.228649ms","start":"2026-07-28T08:04:36.130145Z","end":"2026-07-28T08:04:36.369374Z","steps":["trace[662001370] 'agreement among raft nodes before linearized reading' (duration: 239.049407ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:04:49.755923Z","caller":"traceutil/trace.go:171","msg":"trace[18947499] transaction","detail":"{read_only:false; response_revision:2058; number_of_response:1; }","duration":"153.195298ms","start":"2026-07-28T08:04:49.602707Z","end":"2026-07-28T08:04:49.755902Z","steps":["trace[18947499] 'process raft request' (duration: 152.497509ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:05:04.661109Z","caller":"traceutil/trace.go:171","msg":"trace[332594476] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2245; }","duration":"138.740183ms","start":"2026-07-28T08:05:04.522328Z","end":"2026-07-28T08:05:04.661068Z","steps":["trace[332594476] 'read index received' (duration: 138.47895ms)","trace[332594476] 'applied index is now lower than readState.Index' (duration: 259.503µs)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:05:04.661241Z","caller":"traceutil/trace.go:171","msg":"trace[655854947] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"145.528957ms","start":"2026-07-28T08:05:04.515656Z","end":"2026-07-28T08:05:04.661185Z","steps":["trace[655854947] 'process raft request' (duration: 145.157851ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:05:04.661539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.177509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-28T08:05:04.661875Z","caller":"traceutil/trace.go:171","msg":"trace[1677241250] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2155; }","duration":"139.570494ms","start":"2026-07-28T08:05:04.522254Z","end":"2026-07-28T08:05:04.661824Z","steps":["trace[1677241250] 'agreement among raft nodes before linearized reading' (duration: 138.971307ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:05:04.671022Z","caller":"traceutil/trace.go:171","msg":"trace[1355839169] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"126.659506ms","start":"2026-07-28T08:05:04.544349Z","end":"2026-07-28T08:05:04.671008Z","steps":["trace[1355839169] 'process raft request' (duration: 126.506014ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:05:06.346196Z","caller":"traceutil/trace.go:171","msg":"trace[1888143824] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"137.490471ms","start":"2026-07-28T08:05:06.208679Z","end":"2026-07-28T08:05:06.34617Z","steps":["trace[1888143824] 'process raft request' (duration: 137.346519ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:06:29.200356Z","caller":"traceutil/trace.go:171","msg":"trace[256706887] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"134.283851ms","start":"2026-07-28T08:06:29.066046Z","end":"2026-07-28T08:06:29.20033Z","steps":["trace[256706887] 'process raft request' (duration: 98.196369ms)","trace[256706887] 'compare' (duration: 35.826244ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:06:34.581778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.015429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:06:34.581897Z","caller":"traceutil/trace.go:171","msg":"trace[441342279] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2748; }","duration":"118.239085ms","start":"2026-07-28T08:06:34.463629Z","end":"2026-07-28T08:06:34.581869Z","steps":["trace[441342279] 'count revisions from in-memory index tree' (duration: 117.899296ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:06:35.185384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.707619ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-28T08:06:35.185809Z","caller":"traceutil/trace.go:171","msg":"trace[1771131265] transaction","detail":"{read_only:false; response_revision:2750; number_of_response:1; }","duration":"367.519693ms","start":"2026-07-28T08:06:34.818268Z","end":"2026-07-28T08:06:35.185788Z","steps":["trace[1771131265] 'process raft request' (duration: 236.228298ms)","trace[1771131265] 'compare' (duration: 130.583495ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:06:35.185914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:06:34.818229Z","time spent":"367.650577ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T08:06:35.212327Z","caller":"traceutil/trace.go:171","msg":"trace[1317134969] transaction","detail":"{read_only:false; response_revision:2752; number_of_response:1; }","duration":"361.022763ms","start":"2026-07-28T08:06:34.851276Z","end":"2026-07-28T08:06:35.212299Z","steps":["trace[1317134969] 'process raft request' (duration: 360.913759ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:06:35.212351Z","caller":"traceutil/trace.go:171","msg":"trace[773970873] transaction","detail":"{read_only:false; response_revision:2751; number_of_response:1; }","duration":"377.690963ms","start":"2026-07-28T08:06:34.834612Z","end":"2026-07-28T08:06:35.212303Z","steps":["trace[773970873] 'process raft request' (duration: 377.443126ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:06:35.212779Z","caller":"traceutil/trace.go:171","msg":"trace[1950273009] linearizableReadLoop","detail":"{readStateIndex:2864; appliedIndex:2861; }","duration":"353.682593ms","start":"2026-07-28T08:06:34.859077Z","end":"2026-07-28T08:06:35.212759Z","steps":["trace[1950273009] 'read index received' (duration: 192.827408ms)","trace[1950273009] 'applied index is now lower than readState.Index' (duration: 160.852995ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:06:35.212882Z","caller":"traceutil/trace.go:171","msg":"trace[1207094457] transaction","detail":"{read_only:false; response_revision:2753; number_of_response:1; }","duration":"195.382595ms","start":"2026-07-28T08:06:35.017414Z","end":"2026-07-28T08:06:35.212796Z","steps":["trace[1207094457] 'process raft request' (duration: 194.839278ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:06:35.213302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:06:34.851244Z","time spent":"361.177237ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T08:06:35.213322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.221248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:06:35.213507Z","caller":"traceutil/trace.go:171","msg":"trace[807231544] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2753; }","duration":"354.415274ms","start":"2026-07-28T08:06:34.859025Z","end":"2026-07-28T08:06:35.21344Z","steps":["trace[807231544] 'agreement among raft nodes before linearized reading' (duration: 354.230339ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:06:35.213747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:06:34.858984Z","time spent":"354.744963ms","remote":"127.0.0.1:51422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-28T08:06:35.214004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:06:34.834594Z","time spent":"377.844367ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T08:10:56.736454Z","caller":"traceutil/trace.go:171","msg":"trace[165246016] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"105.163222ms","start":"2026-07-28T08:10:56.631266Z","end":"2026-07-28T08:10:56.736429Z","steps":["trace[165246016] 'process raft request' (duration: 104.949909ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:10:59.945972Z","caller":"traceutil/trace.go:171","msg":"trace[1443834146] linearizableReadLoop","detail":"{readStateIndex:4940; appliedIndex:4939; }","duration":"312.755214ms","start":"2026-07-28T08:10:59.633193Z","end":"2026-07-28T08:10:59.945948Z","steps":["trace[1443834146] 'read index received' (duration: 312.638192ms)","trace[1443834146] 'applied index is now lower than readState.Index' (duration: 115.952µs)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:10:59.946023Z","caller":"traceutil/trace.go:171","msg":"trace[1479270174] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"325.101061ms","start":"2026-07-28T08:10:59.620898Z","end":"2026-07-28T08:10:59.945999Z","steps":["trace[1479270174] 'process raft request' (duration: 324.885458ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:10:59.946195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.982808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7393"} {"level":"info","ts":"2026-07-28T08:10:59.946237Z","caller":"traceutil/trace.go:171","msg":"trace[1465811398] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4752; }","duration":"313.042068ms","start":"2026-07-28T08:10:59.633184Z","end":"2026-07-28T08:10:59.946226Z","steps":["trace[1465811398] 'agreement among raft nodes before linearized reading' (duration: 312.886286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:10:59.946481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:10:59.633155Z","time spent":"313.316782ms","remote":"127.0.0.1:59602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":7415,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-07-28T08:10:59.946482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:10:59.620881Z","time spent":"325.195242ms","remote":"127.0.0.1:51738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3876,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T08:11:00.061951Z","caller":"traceutil/trace.go:171","msg":"trace[865098929] linearizableReadLoop","detail":"{readStateIndex:4941; appliedIndex:4940; }","duration":"115.8885ms","start":"2026-07-28T08:10:59.946043Z","end":"2026-07-28T08:11:00.061931Z","steps":["trace[865098929] 'read index received' (duration: 40.579397ms)","trace[865098929] 'applied index is now lower than readState.Index' (duration: 75.308233ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:00.062113Z","caller":"traceutil/trace.go:171","msg":"trace[830886907] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"394.695878ms","start":"2026-07-28T08:10:59.667376Z","end":"2026-07-28T08:11:00.062071Z","steps":["trace[830886907] 'process raft request' (duration: 319.323413ms)","trace[830886907] 'compare' (duration: 75.12942ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:11:00.062538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:10:59.667339Z","time spent":"394.882271ms","remote":"127.0.0.1:43912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2230,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-28T08:11:00.063038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-07-28T08:11:00.063106Z","caller":"traceutil/trace.go:171","msg":"trace[1035665779] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4753; }","duration":"139.626851ms","start":"2026-07-28T08:10:59.923466Z","end":"2026-07-28T08:11:00.063093Z","steps":["trace[1035665779] 'agreement among raft nodes before linearized reading' (duration: 138.622856ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:00.240264Z","caller":"traceutil/trace.go:171","msg":"trace[165046184] linearizableReadLoop","detail":"{readStateIndex:4942; appliedIndex:4941; }","duration":"153.369608ms","start":"2026-07-28T08:11:00.086866Z","end":"2026-07-28T08:11:00.240236Z","steps":["trace[165046184] 'read index received' (duration: 147.103604ms)","trace[165046184] 'applied index is now lower than readState.Index' (duration: 6.264274ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:00.240312Z","caller":"traceutil/trace.go:171","msg":"trace[676324473] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"172.140543ms","start":"2026-07-28T08:11:00.068142Z","end":"2026-07-28T08:11:00.240282Z","steps":["trace[676324473] 'process raft request' (duration: 165.876578ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:00.240564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.681914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-07-28T08:11:00.240782Z","caller":"traceutil/trace.go:171","msg":"trace[366935825] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4754; }","duration":"153.779845ms","start":"2026-07-28T08:11:00.086825Z","end":"2026-07-28T08:11:00.240604Z","steps":["trace[366935825] 'agreement among raft nodes before linearized reading' (duration: 153.502671ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:00.823192Z","caller":"traceutil/trace.go:171","msg":"trace[1514056718] transaction","detail":"{read_only:false; response_revision:4761; number_of_response:1; }","duration":"152.918722ms","start":"2026-07-28T08:11:00.670251Z","end":"2026-07-28T08:11:00.82317Z","steps":["trace[1514056718] 'process raft request' (duration: 152.77821ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:00.971217Z","caller":"traceutil/trace.go:171","msg":"trace[1815744167] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"187.804341ms","start":"2026-07-28T08:11:00.783377Z","end":"2026-07-28T08:11:00.971182Z","steps":["trace[1815744167] 'process raft request' (duration: 187.373255ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:00.971271Z","caller":"traceutil/trace.go:171","msg":"trace[1638381373] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"225.725558ms","start":"2026-07-28T08:11:00.745516Z","end":"2026-07-28T08:11:00.971242Z","steps":["trace[1638381373] 'process raft request' (duration: 152.09624ms)","trace[1638381373] 'compare' (duration: 72.686694ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:06.16854Z","caller":"traceutil/trace.go:171","msg":"trace[34768798] transaction","detail":"{read_only:false; response_revision:4864; number_of_response:1; }","duration":"141.13405ms","start":"2026-07-28T08:11:06.027376Z","end":"2026-07-28T08:11:06.16851Z","steps":["trace[34768798] 'process raft request' (duration: 139.661878ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:06.394947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.165683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-28T08:11:06.395034Z","caller":"traceutil/trace.go:171","msg":"trace[355989902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4864; }","duration":"112.308685ms","start":"2026-07-28T08:11:06.282703Z","end":"2026-07-28T08:11:06.395012Z","steps":["trace[355989902] 'range keys from in-memory index tree' (duration: 112.030971ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:06.39557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.865215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-07-28T08:11:06.395639Z","caller":"traceutil/trace.go:171","msg":"trace[566892972] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4864; }","duration":"128.961287ms","start":"2026-07-28T08:11:06.266663Z","end":"2026-07-28T08:11:06.395624Z","steps":["trace[566892972] 'range keys from in-memory index tree' (duration: 128.099654ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:06.884001Z","caller":"traceutil/trace.go:171","msg":"trace[284511427] linearizableReadLoop","detail":"{readStateIndex:5061; appliedIndex:5060; }","duration":"141.341294ms","start":"2026-07-28T08:11:06.74263Z","end":"2026-07-28T08:11:06.883972Z","steps":["trace[284511427] 'read index received' (duration: 105.834678ms)","trace[284511427] 'applied index is now lower than readState.Index' (duration: 35.505416ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:06.884087Z","caller":"traceutil/trace.go:171","msg":"trace[163055636] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"142.730794ms","start":"2026-07-28T08:11:06.741307Z","end":"2026-07-28T08:11:06.884038Z","steps":["trace[163055636] 'process raft request' (duration: 107.153517ms)","trace[163055636] 'compare' (duration: 35.339943ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:11:06.884224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.575967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-28T08:11:06.884275Z","caller":"traceutil/trace.go:171","msg":"trace[1922675117] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4868; }","duration":"141.677459ms","start":"2026-07-28T08:11:06.742586Z","end":"2026-07-28T08:11:06.884263Z","steps":["trace[1922675117] 'agreement among raft nodes before linearized reading' (duration: 141.489306ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:06.973023Z","caller":"traceutil/trace.go:171","msg":"trace[2116411821] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"227.551285ms","start":"2026-07-28T08:11:06.745449Z","end":"2026-07-28T08:11:06.973Z","steps":["trace[2116411821] 'process raft request' (duration: 227.356231ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:06.973219Z","caller":"traceutil/trace.go:171","msg":"trace[1295257879] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"138.46313ms","start":"2026-07-28T08:11:06.834747Z","end":"2026-07-28T08:11:06.973211Z","steps":["trace[1295257879] 'process raft request' (duration: 138.194106ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:07.145784Z","caller":"traceutil/trace.go:171","msg":"trace[631432301] linearizableReadLoop","detail":"{readStateIndex:5064; appliedIndex:5063; }","duration":"116.596477ms","start":"2026-07-28T08:11:07.029159Z","end":"2026-07-28T08:11:07.145756Z","steps":["trace[631432301] 'read index received' (duration: 33.931221ms)","trace[631432301] 'applied index is now lower than readState.Index' (duration: 82.663516ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:11:07.145911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.743139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:11:07.145907Z","caller":"traceutil/trace.go:171","msg":"trace[818893557] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"149.780969ms","start":"2026-07-28T08:11:06.996088Z","end":"2026-07-28T08:11:07.145868Z","steps":["trace[818893557] 'process raft request' (duration: 66.971091ms)","trace[818893557] 'compare' (duration: 82.555954ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:07.145943Z","caller":"traceutil/trace.go:171","msg":"trace[1907109404] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4871; }","duration":"116.818341ms","start":"2026-07-28T08:11:07.029115Z","end":"2026-07-28T08:11:07.145933Z","steps":["trace[1907109404] 'agreement among raft nodes before linearized reading' (duration: 116.74417ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:07.299627Z","caller":"traceutil/trace.go:171","msg":"trace[1068008341] linearizableReadLoop","detail":"{readStateIndex:5066; appliedIndex:5064; }","duration":"149.84697ms","start":"2026-07-28T08:11:07.14976Z","end":"2026-07-28T08:11:07.299607Z","steps":["trace[1068008341] 'read index received' (duration: 131.829768ms)","trace[1068008341] 'applied index is now lower than readState.Index' (duration: 18.016082ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:07.299677Z","caller":"traceutil/trace.go:171","msg":"trace[1900240254] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"249.34068ms","start":"2026-07-28T08:11:07.050276Z","end":"2026-07-28T08:11:07.299617Z","steps":["trace[1900240254] 'process raft request' (duration: 231.333069ms)","trace[1900240254] 'compare' (duration: 17.846959ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:07.299754Z","caller":"traceutil/trace.go:171","msg":"trace[1214508895] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"156.297887ms","start":"2026-07-28T08:11:07.143445Z","end":"2026-07-28T08:11:07.299743Z","steps":["trace[1214508895] 'process raft request' (duration: 156.122174ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:07.299961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.186085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:11:07.300004Z","caller":"traceutil/trace.go:171","msg":"trace[1745301642] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4873; }","duration":"150.240676ms","start":"2026-07-28T08:11:07.149753Z","end":"2026-07-28T08:11:07.299994Z","steps":["trace[1745301642] 'agreement among raft nodes before linearized reading' (duration: 150.174125ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:09.935599Z","caller":"traceutil/trace.go:171","msg":"trace[1762704789] transaction","detail":"{read_only:false; response_revision:4948; number_of_response:1; }","duration":"199.115587ms","start":"2026-07-28T08:11:09.736461Z","end":"2026-07-28T08:11:09.935576Z","steps":["trace[1762704789] 'process raft request' (duration: 198.798973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:10.307323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.894747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:11:10.307423Z","caller":"traceutil/trace.go:171","msg":"trace[1522252586] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:4948; }","duration":"204.066999ms","start":"2026-07-28T08:11:10.103328Z","end":"2026-07-28T08:11:10.307395Z","steps":["trace[1522252586] 'count revisions from in-memory index tree' (duration: 203.632472ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:10.307421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.482209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:11:10.307516Z","caller":"traceutil/trace.go:171","msg":"trace[70159543] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4948; }","duration":"173.618171ms","start":"2026-07-28T08:11:10.133877Z","end":"2026-07-28T08:11:10.307495Z","steps":["trace[70159543] 'range keys from in-memory index tree' (duration: 173.414978ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:14.565033Z","caller":"traceutil/trace.go:171","msg":"trace[421307359] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"270.720546ms","start":"2026-07-28T08:11:14.294282Z","end":"2026-07-28T08:11:14.565003Z","steps":["trace[421307359] 'process raft request' (duration: 186.673377ms)","trace[421307359] 'compare' (duration: 83.700014ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:14.565313Z","caller":"traceutil/trace.go:171","msg":"trace[1323403646] linearizableReadLoop","detail":"{readStateIndex:5193; appliedIndex:5192; }","duration":"214.21737ms","start":"2026-07-28T08:11:14.351015Z","end":"2026-07-28T08:11:14.565232Z","steps":["trace[1323403646] 'read index received' (duration: 129.977518ms)","trace[1323403646] 'applied index is now lower than readState.Index' (duration: 84.238632ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:11:14.565767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.743748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.129\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-28T08:11:14.565829Z","caller":"traceutil/trace.go:171","msg":"trace[1287203949] range","detail":"{range_begin:/registry/masterleases/199.204.45.129; range_end:; response_count:1; response_revision:4999; }","duration":"214.847379ms","start":"2026-07-28T08:11:14.350969Z","end":"2026-07-28T08:11:14.565817Z","steps":["trace[1287203949] 'agreement among raft nodes before linearized reading' (duration: 214.489174ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:14.796756Z","caller":"traceutil/trace.go:171","msg":"trace[1281877644] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"228.055637ms","start":"2026-07-28T08:11:14.568673Z","end":"2026-07-28T08:11:14.796728Z","steps":["trace[1281877644] 'process raft request' (duration: 227.695872ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:14.796925Z","caller":"traceutil/trace.go:171","msg":"trace[1955757966] transaction","detail":"{read_only:false; response_revision:5001; number_of_response:1; }","duration":"221.251555ms","start":"2026-07-28T08:11:14.575631Z","end":"2026-07-28T08:11:14.796883Z","steps":["trace[1955757966] 'process raft request' (duration: 220.972691ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:14.797234Z","caller":"traceutil/trace.go:171","msg":"trace[1264104821] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"113.898346ms","start":"2026-07-28T08:11:14.683085Z","end":"2026-07-28T08:11:14.796983Z","steps":["trace[1264104821] 'process raft request' (duration: 113.733513ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:16.924794Z","caller":"traceutil/trace.go:171","msg":"trace[122246236] transaction","detail":"{read_only:false; response_revision:5031; number_of_response:1; }","duration":"119.938024ms","start":"2026-07-28T08:11:16.804832Z","end":"2026-07-28T08:11:16.92477Z","steps":["trace[122246236] 'process raft request' (duration: 119.706941ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:16.937158Z","caller":"traceutil/trace.go:171","msg":"trace[1989157187] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"130.573902ms","start":"2026-07-28T08:11:16.806565Z","end":"2026-07-28T08:11:16.937139Z","steps":["trace[1989157187] 'process raft request' (duration: 130.46923ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:23.465511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.73257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:11:23.465622Z","caller":"traceutil/trace.go:171","msg":"trace[1420907997] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:5074; }","duration":"158.901113ms","start":"2026-07-28T08:11:23.306701Z","end":"2026-07-28T08:11:23.465602Z","steps":["trace[1420907997] 'count revisions from in-memory index tree' (duration: 158.639168ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:23.843723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.79642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-28T08:11:23.844158Z","caller":"traceutil/trace.go:171","msg":"trace[764859468] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"322.525514ms","start":"2026-07-28T08:11:23.521611Z","end":"2026-07-28T08:11:23.844136Z","steps":["trace[764859468] 'process raft request' (duration: 194.248437ms)","trace[764859468] 'compare' (duration: 127.700719ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:11:23.8444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:11:23.521587Z","time spent":"322.778668ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T08:11:23.844251Z","caller":"traceutil/trace.go:171","msg":"trace[912858137] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"322.064658ms","start":"2026-07-28T08:11:23.522153Z","end":"2026-07-28T08:11:23.844217Z","steps":["trace[912858137] 'process raft request' (duration: 321.871745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:23.845151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T08:11:23.522144Z","time spent":"322.731737ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T08:11:24.034883Z","caller":"traceutil/trace.go:171","msg":"trace[1573213851] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"176.316151ms","start":"2026-07-28T08:11:23.858545Z","end":"2026-07-28T08:11:24.034861Z","steps":["trace[1573213851] 'process raft request' (duration: 123.769ms)","trace[1573213851] 'compare' (duration: 52.393309ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:24.034874Z","caller":"traceutil/trace.go:171","msg":"trace[234514184] linearizableReadLoop","detail":"{readStateIndex:5277; appliedIndex:5276; }","duration":"173.468909ms","start":"2026-07-28T08:11:23.861375Z","end":"2026-07-28T08:11:24.034844Z","steps":["trace[234514184] 'read index received' (duration: 120.858007ms)","trace[234514184] 'applied index is now lower than readState.Index' (duration: 52.609482ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:11:24.035091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.698432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-07-28T08:11:24.035452Z","caller":"traceutil/trace.go:171","msg":"trace[221875541] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5080; }","duration":"173.829564ms","start":"2026-07-28T08:11:23.861313Z","end":"2026-07-28T08:11:24.035143Z","steps":["trace[221875541] 'agreement among raft nodes before linearized reading' (duration: 173.610351ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:11:24.035948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.678091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-28T08:11:24.036189Z","caller":"traceutil/trace.go:171","msg":"trace[1634932453] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5080; }","duration":"103.957106ms","start":"2026-07-28T08:11:23.932209Z","end":"2026-07-28T08:11:24.036166Z","steps":["trace[1634932453] 'agreement among raft nodes before linearized reading' (duration: 102.875869ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:25.669963Z","caller":"traceutil/trace.go:171","msg":"trace[1525141911] transaction","detail":"{read_only:false; response_revision:5101; number_of_response:1; }","duration":"106.594462ms","start":"2026-07-28T08:11:25.563327Z","end":"2026-07-28T08:11:25.669921Z","steps":["trace[1525141911] 'process raft request' (duration: 95.325845ms)","trace[1525141911] 'compare' (duration: 10.684579ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T08:11:49.124666Z","caller":"traceutil/trace.go:171","msg":"trace[1930083390] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"250.083514ms","start":"2026-07-28T08:11:48.874563Z","end":"2026-07-28T08:11:49.124647Z","steps":["trace[1930083390] 'process raft request' (duration: 249.983322ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:11:49.124731Z","caller":"traceutil/trace.go:171","msg":"trace[1985478908] linearizableReadLoop","detail":"{readStateIndex:5511; appliedIndex:5511; }","duration":"190.095429ms","start":"2026-07-28T08:11:48.934614Z","end":"2026-07-28T08:11:49.124709Z","steps":["trace[1985478908] 'read index received' (duration: 190.083738ms)","trace[1985478908] 'applied index is now lower than readState.Index' (duration: 10.301µs)"],"step_count":2} {"level":"warn","ts":"2026-07-28T08:11:49.124857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.231541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/openstack/keystone-api\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T08:11:49.12489Z","caller":"traceutil/trace.go:171","msg":"trace[1795207476] range","detail":"{range_begin:/registry/poddisruptionbudgets/openstack/keystone-api; range_end:; response_count:0; response_revision:5306; }","duration":"190.317983ms","start":"2026-07-28T08:11:48.934564Z","end":"2026-07-28T08:11:49.124882Z","steps":["trace[1795207476] 'agreement among raft nodes before linearized reading' (duration: 190.250241ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:12:01.166722Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886} {"level":"info","ts":"2026-07-28T08:12:01.294008Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"125.296701ms","hash":2751401495,"current-db-size-bytes":53301248,"current-db-size":"53 MB","current-db-size-in-use-bytes":28508160,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-28T08:12:01.294064Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2751401495,"revision":2886,"compact-revision":-1} {"level":"info","ts":"2026-07-28T08:12:15.68193Z","caller":"traceutil/trace.go:171","msg":"trace[534283545] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"101.489145ms","start":"2026-07-28T08:12:15.580413Z","end":"2026-07-28T08:12:15.681902Z","steps":["trace[534283545] 'process raft request' (duration: 101.328403ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T08:12:36.71279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.217586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-28T08:12:36.712888Z","caller":"traceutil/trace.go:171","msg":"trace[324747188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5737; }","duration":"164.363538ms","start":"2026-07-28T08:12:36.548503Z","end":"2026-07-28T08:12:36.712866Z","steps":["trace[324747188] 'range keys from in-memory index tree' (duration: 164.031043ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T08:17:01.172741Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5470} {"level":"info","ts":"2026-07-28T08:17:01.256624Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5470,"took":"82.030015ms","hash":1223701383,"current-db-size-bytes":53301248,"current-db-size":"53 MB","current-db-size-in-use-bytes":18771968,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-28T08:17:01.256821Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1223701383,"revision":5470,"compact-revision":2886}