{"level":"warn","ts":"2026-05-11T10:47:56.710251Z","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-11T10:47:56.710416Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.246:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.246:2380","--initial-cluster=instance=https://199.204.45.246:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.246:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.246:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-11T10:47:56.710504Z","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-11T10:47:56.710522Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-05-11T10:47:56.710544Z","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-11T10:47:56.711424Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"]} {"level":"info","ts":"2026-05-11T10:47:56.711524Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.246:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-11T10:47:56.717153Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.321815ms"} {"level":"info","ts":"2026-05-11T10:47:56.723313Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ab97322ebdd79664","cluster-id":"87bc89380c3dc2c"} {"level":"info","ts":"2026-05-11T10:47:56.723393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T10:47:56.723412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 0"} {"level":"info","ts":"2026-05-11T10:47:56.723425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ab97322ebdd79664 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T10:47:56.723436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became follower at term 1"} {"level":"info","ts":"2026-05-11T10:47:56.723486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"warn","ts":"2026-05-11T10:47:56.730567Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T10:47:56.73182Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T10:47:56.733069Z","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-11T10:47:56.73645Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ab97322ebdd79664","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T10:47:56.736721Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ab97322ebdd79664","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T10:47:56.736905Z","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-11T10:47:56.736988Z","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-11T10:47:56.73702Z","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-11T10:47:56.73894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 switched to configuration voters=(12364406478303893092)"} {"level":"info","ts":"2026-05-11T10:47:56.739328Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","added-peer-id":"ab97322ebdd79664","added-peer-peer-urls":["https://199.204.45.246:2380"]} {"level":"info","ts":"2026-05-11T10:47:56.741061Z","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-11T10:47:56.741195Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-05-11T10:47:56.741293Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.246:2380"} {"level":"info","ts":"2026-05-11T10:47:56.741406Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ab97322ebdd79664","initial-advertise-peer-urls":["https://199.204.45.246:2380"],"listen-peer-urls":["https://199.204.45.246:2380"],"advertise-client-urls":["https://199.204.45.246:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.246:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T10:47:56.741461Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T10:47:57.624014Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T10:47:57.62409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T10:47:57.624125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgPreVoteResp from ab97322ebdd79664 at term 1"} {"level":"info","ts":"2026-05-11T10:47:57.624178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became candidate at term 2"} {"level":"info","ts":"2026-05-11T10:47:57.624191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 received MsgVoteResp from ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-05-11T10:47:57.624207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ab97322ebdd79664 became leader at term 2"} {"level":"info","ts":"2026-05-11T10:47:57.624355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ab97322ebdd79664 elected leader ab97322ebdd79664 at term 2"} {"level":"info","ts":"2026-05-11T10:47:57.625418Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ab97322ebdd79664","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.246:2379]}","request-path":"/0/members/ab97322ebdd79664/attributes","cluster-id":"87bc89380c3dc2c","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T10:47:57.625518Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:47:57.625632Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:47:57.625707Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:47:57.626591Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87bc89380c3dc2c","local-member-id":"ab97322ebdd79664","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:47:57.626723Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:47:57.626768Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:47:57.628777Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.246:2379"} {"level":"info","ts":"2026-05-11T10:47:57.629384Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T10:47:57.629437Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T10:47:57.629553Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-11T10:48:27.310598Z","caller":"traceutil/trace.go:171","msg":"trace[1170544943] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"105.094539ms","start":"2026-05-11T10:48:27.205455Z","end":"2026-05-11T10:48:27.31055Z","steps":["trace[1170544943] 'process raft request' (duration: 104.867726ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:27.31125Z","caller":"traceutil/trace.go:171","msg":"trace[891846005] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"104.923617ms","start":"2026-05-11T10:48:27.205681Z","end":"2026-05-11T10:48:27.310605Z","steps":["trace[891846005] 'process raft request' (duration: 104.773105ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:27.601095Z","caller":"traceutil/trace.go:171","msg":"trace[886512739] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"160.583747ms","start":"2026-05-11T10:48:27.440471Z","end":"2026-05-11T10:48:27.601055Z","steps":["trace[886512739] 'process raft request' (duration: 150.001353ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:27.601142Z","caller":"traceutil/trace.go:171","msg":"trace[1180897741] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"116.828104ms","start":"2026-05-11T10:48:27.484289Z","end":"2026-05-11T10:48:27.601117Z","steps":["trace[1180897741] 'process raft request' (duration: 116.764943ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:27.60131Z","caller":"traceutil/trace.go:171","msg":"trace[1039699442] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"117.891782ms","start":"2026-05-11T10:48:27.483382Z","end":"2026-05-11T10:48:27.601274Z","steps":["trace[1039699442] 'process raft request' (duration: 117.567727ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:33.512502Z","caller":"traceutil/trace.go:171","msg":"trace[2073417106] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"110.093219ms","start":"2026-05-11T10:48:33.402367Z","end":"2026-05-11T10:48:33.51246Z","steps":["trace[2073417106] 'process raft request' (duration: 109.864745ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:33.525763Z","caller":"traceutil/trace.go:171","msg":"trace[1916183951] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"114.036283ms","start":"2026-05-11T10:48:33.411688Z","end":"2026-05-11T10:48:33.525724Z","steps":["trace[1916183951] 'process raft request' (duration: 113.720096ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:48:34.004951Z","caller":"traceutil/trace.go:171","msg":"trace[955840131] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"264.195244ms","start":"2026-05-11T10:48:33.740723Z","end":"2026-05-11T10:48:34.004918Z","steps":["trace[955840131] 'process raft request' (duration: 263.260426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:48:34.480893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.561419ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:48:34.481064Z","caller":"traceutil/trace.go:171","msg":"trace[941115822] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"416.918453ms","start":"2026-05-11T10:48:34.064119Z","end":"2026-05-11T10:48:34.481038Z","steps":["trace[941115822] 'process raft request' (duration: 265.297185ms)","trace[941115822] 'compare' (duration: 149.845515ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:48:34.481471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:48:34.064092Z","time spent":"417.175367ms","remote":"127.0.0.1:43476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:48:51.085737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.412903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:48:51.085873Z","caller":"traceutil/trace.go:171","msg":"trace[1250732473] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"105.623586ms","start":"2026-05-11T10:48:50.980224Z","end":"2026-05-11T10:48:51.085848Z","steps":["trace[1250732473] 'range keys from in-memory index tree' (duration: 105.199408ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:52:23.309028Z","caller":"traceutil/trace.go:171","msg":"trace[545753706] transaction","detail":"{read_only:false; response_revision:2847; number_of_response:1; }","duration":"132.107608ms","start":"2026-05-11T10:52:23.176874Z","end":"2026-05-11T10:52:23.308981Z","steps":["trace[545753706] 'process raft request' (duration: 116.951757ms)","trace[545753706] 'compare' (duration: 15.015559ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:55:00.123917Z","caller":"traceutil/trace.go:171","msg":"trace[1615160978] transaction","detail":"{read_only:false; response_revision:3873; number_of_response:1; }","duration":"117.197471ms","start":"2026-05-11T10:55:00.006687Z","end":"2026-05-11T10:55:00.123885Z","steps":["trace[1615160978] 'process raft request' (duration: 117.016667ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:55:00.273631Z","caller":"traceutil/trace.go:171","msg":"trace[556323776] linearizableReadLoop","detail":"{readStateIndex:4014; appliedIndex:4013; }","duration":"137.958992ms","start":"2026-05-11T10:55:00.135627Z","end":"2026-05-11T10:55:00.273586Z","steps":["trace[556323776] 'read index received' (duration: 119.898072ms)","trace[556323776] 'applied index is now lower than readState.Index' (duration: 18.05791ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:55:00.274095Z","caller":"traceutil/trace.go:171","msg":"trace[135331722] transaction","detail":"{read_only:false; response_revision:3874; number_of_response:1; }","duration":"210.236575ms","start":"2026-05-11T10:55:00.063815Z","end":"2026-05-11T10:55:00.274052Z","steps":["trace[135331722] 'process raft request' (duration: 191.780797ms)","trace[135331722] 'compare' (duration: 16.42973ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:55:00.274486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.819569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:55:00.274525Z","caller":"traceutil/trace.go:171","msg":"trace[277531802] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:3874; }","duration":"138.923551ms","start":"2026-05-11T10:55:00.13559Z","end":"2026-05-11T10:55:00.274514Z","steps":["trace[277531802] 'agreement among raft nodes before linearized reading' (duration: 138.804598ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:26.377678Z","caller":"traceutil/trace.go:171","msg":"trace[1573364786] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"113.621951ms","start":"2026-05-11T10:56:26.264013Z","end":"2026-05-11T10:56:26.377635Z","steps":["trace[1573364786] 'process raft request' (duration: 102.504411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:56:26.377997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.339107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11455"} {"level":"warn","ts":"2026-05-11T10:56:26.378018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.291297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-05-11T10:56:26.378117Z","caller":"traceutil/trace.go:171","msg":"trace[1467499628] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4928; }","duration":"111.519241ms","start":"2026-05-11T10:56:26.266568Z","end":"2026-05-11T10:56:26.378088Z","steps":["trace[1467499628] 'agreement among raft nodes before linearized reading' (duration: 111.104513ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:26.378133Z","caller":"traceutil/trace.go:171","msg":"trace[1559614022] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4928; }","duration":"111.444259ms","start":"2026-05-11T10:56:26.266661Z","end":"2026-05-11T10:56:26.378106Z","steps":["trace[1559614022] 'agreement among raft nodes before linearized reading' (duration: 111.035322ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:41.757644Z","caller":"traceutil/trace.go:171","msg":"trace[882339474] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"112.106422ms","start":"2026-05-11T10:56:41.645509Z","end":"2026-05-11T10:56:41.757616Z","steps":["trace[882339474] 'process raft request' (duration: 111.721414ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:49.414758Z","caller":"traceutil/trace.go:171","msg":"trace[102546482] transaction","detail":"{read_only:false; response_revision:5470; number_of_response:1; }","duration":"101.876949ms","start":"2026-05-11T10:56:49.312827Z","end":"2026-05-11T10:56:49.414704Z","steps":["trace[102546482] 'process raft request' (duration: 101.048714ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:49.605126Z","caller":"traceutil/trace.go:171","msg":"trace[58938794] transaction","detail":"{read_only:false; response_revision:5471; number_of_response:1; }","duration":"178.626445ms","start":"2026-05-11T10:56:49.426449Z","end":"2026-05-11T10:56:49.605076Z","steps":["trace[58938794] 'process raft request' (duration: 88.858094ms)","trace[58938794] 'compare' (duration: 89.490836ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:56:49.841497Z","caller":"traceutil/trace.go:171","msg":"trace[1957183558] transaction","detail":"{read_only:false; response_revision:5472; number_of_response:1; }","duration":"228.066698ms","start":"2026-05-11T10:56:49.613394Z","end":"2026-05-11T10:56:49.84146Z","steps":["trace[1957183558] 'process raft request' (duration: 158.551028ms)","trace[1957183558] 'compare' (duration: 69.217455ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:56:49.841562Z","caller":"traceutil/trace.go:171","msg":"trace[2066031280] transaction","detail":"{read_only:false; response_revision:5473; number_of_response:1; }","duration":"228.034457ms","start":"2026-05-11T10:56:49.613484Z","end":"2026-05-11T10:56:49.841519Z","steps":["trace[2066031280] 'process raft request' (duration: 227.883694ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:49.84189Z","caller":"traceutil/trace.go:171","msg":"trace[1059256624] transaction","detail":"{read_only:false; response_revision:5474; number_of_response:1; }","duration":"228.306883ms","start":"2026-05-11T10:56:49.613545Z","end":"2026-05-11T10:56:49.841852Z","steps":["trace[1059256624] 'process raft request' (duration: 227.900895ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:49.841954Z","caller":"traceutil/trace.go:171","msg":"trace[721159372] linearizableReadLoop","detail":"{readStateIndex:5673; appliedIndex:5667; }","duration":"206.294368ms","start":"2026-05-11T10:56:49.635623Z","end":"2026-05-11T10:56:49.841918Z","steps":["trace[721159372] 'read index received' (duration: 136.33711ms)","trace[721159372] 'applied index is now lower than readState.Index' (duration: 69.955638ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:56:49.842069Z","caller":"traceutil/trace.go:171","msg":"trace[1107723323] transaction","detail":"{read_only:false; response_revision:5477; number_of_response:1; }","duration":"228.070268ms","start":"2026-05-11T10:56:49.613985Z","end":"2026-05-11T10:56:49.842055Z","steps":["trace[1107723323] 'process raft request' (duration: 227.868334ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:49.842055Z","caller":"traceutil/trace.go:171","msg":"trace[978581658] transaction","detail":"{read_only:false; response_revision:5476; number_of_response:1; }","duration":"228.029997ms","start":"2026-05-11T10:56:49.613978Z","end":"2026-05-11T10:56:49.842008Z","steps":["trace[978581658] 'process raft request' (duration: 227.826872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:56:49.842136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.498782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:56:49.84218Z","caller":"traceutil/trace.go:171","msg":"trace[1192341677] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:5477; }","duration":"206.600034ms","start":"2026-05-11T10:56:49.635568Z","end":"2026-05-11T10:56:49.842168Z","steps":["trace[1192341677] 'agreement among raft nodes before linearized reading' (duration: 206.500912ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:56:49.842321Z","caller":"traceutil/trace.go:171","msg":"trace[798800625] transaction","detail":"{read_only:false; response_revision:5475; number_of_response:1; }","duration":"228.409434ms","start":"2026-05-11T10:56:49.61386Z","end":"2026-05-11T10:56:49.842269Z","steps":["trace[798800625] 'process raft request' (duration: 227.814552ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:57:57.656937Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3038} {"level":"info","ts":"2026-05-11T10:57:57.74232Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3038,"took":"83.375398ms","hash":944482425,"current-db-size-bytes":57110528,"current-db-size":"57 MB","current-db-size-in-use-bytes":31268864,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-05-11T10:57:57.742411Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":944482425,"revision":3038,"compact-revision":-1} {"level":"info","ts":"2026-05-11T11:02:57.66315Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6094} {"level":"info","ts":"2026-05-11T11:02:57.764879Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6094,"took":"99.069719ms","hash":1414743317,"current-db-size-bytes":57110528,"current-db-size":"57 MB","current-db-size-in-use-bytes":21364736,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-05-11T11:02:57.764972Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1414743317,"revision":6094,"compact-revision":3038} {"level":"warn","ts":"2026-05-11T11:03:39.105923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.031792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:03:39.106044Z","caller":"traceutil/trace.go:171","msg":"trace[17292974] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8522; }","duration":"241.209325ms","start":"2026-05-11T11:03:38.86481Z","end":"2026-05-11T11:03:39.10602Z","steps":["trace[17292974] 'range keys from in-memory index tree' (duration: 240.96716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:03:39.106196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.438112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.106344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.576236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.106302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.736335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.106468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.4991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.106448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.01368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.106441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.786965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.10665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.26053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.106669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.730706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.10669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.677424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:03:39.1067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.591242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:03:39.106715Z","caller":"traceutil/trace.go:171","msg":"trace[469457929] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8522; }","duration":"224.805218ms","start":"2026-05-11T11:03:38.881898Z","end":"2026-05-11T11:03:39.106703Z","steps":["trace[469457929] 'range keys from in-memory index tree' (duration: 224.645755ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106716Z","caller":"traceutil/trace.go:171","msg":"trace[1436607929] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8522; }","duration":"206.352102ms","start":"2026-05-11T11:03:38.900347Z","end":"2026-05-11T11:03:39.106699Z","steps":["trace[1436607929] 'range keys from in-memory index tree' (duration: 206.166558ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:03:39.106694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.551801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:03:39.106744Z","caller":"traceutil/trace.go:171","msg":"trace[1704280370] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8522; }","duration":"290.637823ms","start":"2026-05-11T11:03:38.816095Z","end":"2026-05-11T11:03:39.106732Z","steps":["trace[1704280370] 'range keys from in-memory index tree' (duration: 290.549552ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106755Z","caller":"traceutil/trace.go:171","msg":"trace[229341743] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8522; }","duration":"225.744995ms","start":"2026-05-11T11:03:38.880986Z","end":"2026-05-11T11:03:39.106731Z","steps":["trace[229341743] 'range keys from in-memory index tree' (duration: 225.626172ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106776Z","caller":"traceutil/trace.go:171","msg":"trace[355274439] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8522; }","duration":"225.639643ms","start":"2026-05-11T11:03:38.881112Z","end":"2026-05-11T11:03:39.106752Z","steps":["trace[355274439] 'count revisions from in-memory index tree' (duration: 225.444659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:03:39.106629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.195426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:03:39.107407Z","caller":"traceutil/trace.go:171","msg":"trace[306156053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8522; }","duration":"127.944929ms","start":"2026-05-11T11:03:38.979328Z","end":"2026-05-11T11:03:39.107273Z","steps":["trace[306156053] 'range keys from in-memory index tree' (duration: 126.952502ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106507Z","caller":"traceutil/trace.go:171","msg":"trace[604849922] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8522; }","duration":"242.588021ms","start":"2026-05-11T11:03:38.863907Z","end":"2026-05-11T11:03:39.106495Z","steps":["trace[604849922] 'count revisions from in-memory index tree' (duration: 242.372496ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106804Z","caller":"traceutil/trace.go:171","msg":"trace[217107986] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8522; }","duration":"291.150882ms","start":"2026-05-11T11:03:38.815524Z","end":"2026-05-11T11:03:39.106675Z","steps":["trace[217107986] 'count revisions from in-memory index tree' (duration: 290.687013ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:03:39.106574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.281746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:03:39.10779Z","caller":"traceutil/trace.go:171","msg":"trace[705303149] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8522; }","duration":"274.543301ms","start":"2026-05-11T11:03:38.833226Z","end":"2026-05-11T11:03:39.107769Z","steps":["trace[705303149] 'range keys from in-memory index tree' (duration: 273.198785ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:03:39.106413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.721815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:03:39.107884Z","caller":"traceutil/trace.go:171","msg":"trace[1148761088] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8522; }","duration":"275.190953ms","start":"2026-05-11T11:03:38.832671Z","end":"2026-05-11T11:03:39.107862Z","steps":["trace[1148761088] 'count revisions from in-memory index tree' (duration: 273.615893ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106416Z","caller":"traceutil/trace.go:171","msg":"trace[1259483947] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8522; }","duration":"206.706618ms","start":"2026-05-11T11:03:38.899661Z","end":"2026-05-11T11:03:39.106368Z","steps":["trace[1259483947] 'range keys from in-memory index tree' (duration: 206.377771ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106623Z","caller":"traceutil/trace.go:171","msg":"trace[1016599314] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8522; }","duration":"291.259494ms","start":"2026-05-11T11:03:38.815336Z","end":"2026-05-11T11:03:39.106595Z","steps":["trace[1016599314] 'range keys from in-memory index tree' (duration: 290.889757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:03:39.106584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.726584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:03:39.108116Z","caller":"traceutil/trace.go:171","msg":"trace[140720029] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8522; }","duration":"244.305833ms","start":"2026-05-11T11:03:38.863798Z","end":"2026-05-11T11:03:39.108104Z","steps":["trace[140720029] 'range keys from in-memory index tree' (duration: 242.609142ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106408Z","caller":"traceutil/trace.go:171","msg":"trace[1868597184] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:8522; }","duration":"206.666707ms","start":"2026-05-11T11:03:38.899724Z","end":"2026-05-11T11:03:39.10639Z","steps":["trace[1868597184] 'count revisions from in-memory index tree' (duration: 206.495774ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:03:39.106543Z","caller":"traceutil/trace.go:171","msg":"trace[1103681385] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8522; }","duration":"274.084152ms","start":"2026-05-11T11:03:38.832418Z","end":"2026-05-11T11:03:39.106479Z","steps":["trace[1103681385] 'range keys from in-memory index tree' (duration: 273.633863ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:04:08.989348Z","caller":"traceutil/trace.go:171","msg":"trace[543142408] transaction","detail":"{read_only:false; response_revision:8737; number_of_response:1; }","duration":"166.598395ms","start":"2026-05-11T11:04:08.822726Z","end":"2026-05-11T11:04:08.989325Z","steps":["trace[543142408] 'process raft request' (duration: 166.428472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:04:12.822177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.832652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-q26lf\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-05-11T11:04:12.822302Z","caller":"traceutil/trace.go:171","msg":"trace[2121205244] range","detail":"{range_begin:/registry/pods/openstack/keepalived-q26lf; range_end:; response_count:1; response_revision:8758; }","duration":"165.030606ms","start":"2026-05-11T11:04:12.657241Z","end":"2026-05-11T11:04:12.822272Z","steps":["trace[2121205244] 'range keys from in-memory index tree' (duration: 164.584978ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:04:21.54374Z","caller":"traceutil/trace.go:171","msg":"trace[2098486013] linearizableReadLoop","detail":"{readStateIndex:9152; appliedIndex:9151; }","duration":"158.188127ms","start":"2026-05-11T11:04:21.385517Z","end":"2026-05-11T11:04:21.543705Z","steps":["trace[2098486013] 'read index received' (duration: 158.164277ms)","trace[2098486013] 'applied index is now lower than readState.Index' (duration: 22.66µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:04:21.54389Z","caller":"traceutil/trace.go:171","msg":"trace[784752627] transaction","detail":"{read_only:false; response_revision:8844; number_of_response:1; }","duration":"159.623404ms","start":"2026-05-11T11:04:21.384251Z","end":"2026-05-11T11:04:21.543874Z","steps":["trace[784752627] 'process raft request' (duration: 159.277578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:04:21.544009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.480753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:04:21.544087Z","caller":"traceutil/trace.go:171","msg":"trace[200987238] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8844; }","duration":"158.611696ms","start":"2026-05-11T11:04:21.385458Z","end":"2026-05-11T11:04:21.544069Z","steps":["trace[200987238] 'agreement among raft nodes before linearized reading' (duration: 158.487143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:04:21.738387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.899342ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-11T11:04:21.73852Z","caller":"traceutil/trace.go:171","msg":"trace[1126640189] linearizableReadLoop","detail":"{readStateIndex:9153; appliedIndex:9152; }","duration":"194.661332ms","start":"2026-05-11T11:04:21.543834Z","end":"2026-05-11T11:04:21.738495Z","steps":["trace[1126640189] 'read index received' (duration: 68.376754ms)","trace[1126640189] 'applied index is now lower than readState.Index' (duration: 126.283098ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:04:21.738595Z","caller":"traceutil/trace.go:171","msg":"trace[327629424] transaction","detail":"{read_only:false; response_revision:8845; number_of_response:1; }","duration":"262.778299ms","start":"2026-05-11T11:04:21.475803Z","end":"2026-05-11T11:04:21.738582Z","steps":["trace[327629424] 'process raft request' (duration: 136.436279ms)","trace[327629424] 'compare' (duration: 125.734889ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:04:21.738842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.194853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:04:21.738882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.4933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-11T11:04:21.738942Z","caller":"traceutil/trace.go:171","msg":"trace[1845154464] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8845; }","duration":"346.620302ms","start":"2026-05-11T11:04:21.392308Z","end":"2026-05-11T11:04:21.738928Z","steps":["trace[1845154464] 'agreement among raft nodes before linearized reading' (duration: 346.363938ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:04:21.738945Z","caller":"traceutil/trace.go:171","msg":"trace[361899323] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:8845; }","duration":"259.341615ms","start":"2026-05-11T11:04:21.479581Z","end":"2026-05-11T11:04:21.738922Z","steps":["trace[361899323] 'agreement among raft nodes before linearized reading' (duration: 259.06616ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:04:21.738927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.153566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-jlpxs\" ","response":"range_response_count:1 size:4648"} {"level":"warn","ts":"2026-05-11T11:04:21.738986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:04:21.392285Z","time spent":"346.691814ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-11T11:04:21.739236Z","caller":"traceutil/trace.go:171","msg":"trace[1047751358] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-jlpxs; range_end:; response_count:1; response_revision:8845; }","duration":"263.323761ms","start":"2026-05-11T11:04:21.475684Z","end":"2026-05-11T11:04:21.739008Z","steps":["trace[1047751358] 'agreement among raft nodes before linearized reading' (duration: 262.905522ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:04:21.793103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.087288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:04:21.793114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.434047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:04:21.793168Z","caller":"traceutil/trace.go:171","msg":"trace[1007424715] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8849; }","duration":"245.19442ms","start":"2026-05-11T11:04:21.547955Z","end":"2026-05-11T11:04:21.793149Z","steps":["trace[1007424715] 'agreement among raft nodes before linearized reading' (duration: 245.078158ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:04:21.793187Z","caller":"traceutil/trace.go:171","msg":"trace[1185479293] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:8849; }","duration":"235.538619ms","start":"2026-05-11T11:04:21.557626Z","end":"2026-05-11T11:04:21.793164Z","steps":["trace[1185479293] 'agreement among raft nodes before linearized reading' (duration: 235.394126ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:04:22.338251Z","caller":"traceutil/trace.go:171","msg":"trace[1252631015] linearizableReadLoop","detail":"{readStateIndex:9162; appliedIndex:9161; }","duration":"116.70611ms","start":"2026-05-11T11:04:22.221512Z","end":"2026-05-11T11:04:22.338219Z","steps":["trace[1252631015] 'read index received' (duration: 57.634611ms)","trace[1252631015] 'applied index is now lower than readState.Index' (duration: 59.070169ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:04:22.3384Z","caller":"traceutil/trace.go:171","msg":"trace[1611018441] transaction","detail":"{read_only:false; response_revision:8854; number_of_response:1; }","duration":"118.120596ms","start":"2026-05-11T11:04:22.220228Z","end":"2026-05-11T11:04:22.338348Z","steps":["trace[1611018441] 'process raft request' (duration: 58.929305ms)","trace[1611018441] 'compare' (duration: 58.914055ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:04:22.338494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.956064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-05-11T11:04:22.338529Z","caller":"traceutil/trace.go:171","msg":"trace[1076566385] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:8854; }","duration":"117.063756ms","start":"2026-05-11T11:04:22.221457Z","end":"2026-05-11T11:04:22.33852Z","steps":["trace[1076566385] 'agreement among raft nodes before linearized reading' (duration: 116.873573ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:04:22.566264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.625149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2213919"} {"level":"info","ts":"2026-05-11T11:04:22.566384Z","caller":"traceutil/trace.go:171","msg":"trace[1315399426] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8854; }","duration":"123.810012ms","start":"2026-05-11T11:04:22.44255Z","end":"2026-05-11T11:04:22.56636Z","steps":["trace[1315399426] 'range keys from in-memory index tree' (duration: 122.193433ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:04:38.288266Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002462.wal"} {"level":"info","ts":"2026-05-11T11:05:28.136757Z","caller":"traceutil/trace.go:171","msg":"trace[1194026441] transaction","detail":"{read_only:false; response_revision:9537; number_of_response:1; }","duration":"102.417382ms","start":"2026-05-11T11:05:28.034309Z","end":"2026-05-11T11:05:28.136727Z","steps":["trace[1194026441] 'process raft request' (duration: 102.211538ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:05:28.138035Z","caller":"traceutil/trace.go:171","msg":"trace[1832726028] transaction","detail":"{read_only:false; response_revision:9538; number_of_response:1; }","duration":"101.620708ms","start":"2026-05-11T11:05:28.036398Z","end":"2026-05-11T11:05:28.138018Z","steps":["trace[1832726028] 'process raft request' (duration: 101.534706ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:05:40.294575Z","caller":"traceutil/trace.go:171","msg":"trace[2014046072] transaction","detail":"{read_only:false; response_revision:9606; number_of_response:1; }","duration":"102.129257ms","start":"2026-05-11T11:05:40.192411Z","end":"2026-05-11T11:05:40.294541Z","steps":["trace[2014046072] 'process raft request' (duration: 101.719299ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:05:40.612189Z","caller":"traceutil/trace.go:171","msg":"trace[1591411697] transaction","detail":"{read_only:false; response_revision:9608; number_of_response:1; }","duration":"267.847656ms","start":"2026-05-11T11:05:40.344284Z","end":"2026-05-11T11:05:40.612131Z","steps":["trace[1591411697] 'process raft request' (duration: 250.46319ms)","trace[1591411697] 'compare' (duration: 17.249294ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:05:40.750852Z","caller":"traceutil/trace.go:171","msg":"trace[402432962] transaction","detail":"{read_only:false; response_revision:9610; number_of_response:1; }","duration":"103.028373ms","start":"2026-05-11T11:05:40.647782Z","end":"2026-05-11T11:05:40.75081Z","steps":["trace[402432962] 'process raft request' (duration: 71.38832ms)","trace[402432962] 'compare' (duration: 31.398209ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:05:47.491995Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-11T11:05:47.496599Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-11T11:05:47.496697Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-05-11T11:07:57.674565Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8129} {"level":"info","ts":"2026-05-11T11:07:57.737992Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8129,"took":"60.700157ms","hash":3346158393,"current-db-size-bytes":57110528,"current-db-size":"57 MB","current-db-size-in-use-bytes":27873280,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-11T11:07:57.73808Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3346158393,"revision":8129,"compact-revision":6094} {"level":"info","ts":"2026-05-11T11:11:17.559954Z","caller":"traceutil/trace.go:171","msg":"trace[1098558699] transaction","detail":"{read_only:false; response_revision:12034; number_of_response:1; }","duration":"155.275428ms","start":"2026-05-11T11:11:17.404649Z","end":"2026-05-11T11:11:17.559924Z","steps":["trace[1098558699] 'process raft request' (duration: 155.089745ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:11:17.826056Z","caller":"traceutil/trace.go:171","msg":"trace[4982831] linearizableReadLoop","detail":"{readStateIndex:12444; appliedIndex:12442; }","duration":"135.086526ms","start":"2026-05-11T11:11:17.690945Z","end":"2026-05-11T11:11:17.826032Z","steps":["trace[4982831] 'read index received' (duration: 116.484444ms)","trace[4982831] 'applied index is now lower than readState.Index' (duration: 18.600592ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:11:17.826065Z","caller":"traceutil/trace.go:171","msg":"trace[835170291] transaction","detail":"{read_only:false; response_revision:12035; number_of_response:1; }","duration":"254.252019ms","start":"2026-05-11T11:11:17.571776Z","end":"2026-05-11T11:11:17.826028Z","steps":["trace[835170291] 'process raft request' (duration: 235.532105ms)","trace[835170291] 'compare' (duration: 18.514781ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:11:17.826204Z","caller":"traceutil/trace.go:171","msg":"trace[413167764] transaction","detail":"{read_only:false; response_revision:12036; number_of_response:1; }","duration":"252.231493ms","start":"2026-05-11T11:11:17.573952Z","end":"2026-05-11T11:11:17.826183Z","steps":["trace[413167764] 'process raft request' (duration: 252.022719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:11:17.826271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.315841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-11T11:11:17.826317Z","caller":"traceutil/trace.go:171","msg":"trace[1133780556] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:12036; }","duration":"135.458813ms","start":"2026-05-11T11:11:17.690846Z","end":"2026-05-11T11:11:17.826305Z","steps":["trace[1133780556] 'agreement among raft nodes before linearized reading' (duration: 135.283839ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:12:57.681373Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10537} {"level":"info","ts":"2026-05-11T11:12:57.76489Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10537,"took":"80.340947ms","hash":2442111694,"current-db-size-bytes":57110528,"current-db-size":"57 MB","current-db-size-in-use-bytes":25849856,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-11T11:12:57.765055Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2442111694,"revision":10537,"compact-revision":8129} {"level":"info","ts":"2026-05-11T11:17:21.434034Z","caller":"traceutil/trace.go:171","msg":"trace[937897335] transaction","detail":"{read_only:false; response_revision:14495; number_of_response:1; }","duration":"129.69398ms","start":"2026-05-11T11:17:21.304311Z","end":"2026-05-11T11:17:21.434005Z","steps":["trace[937897335] 'process raft request' (duration: 128.391076ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:17:21.434964Z","caller":"traceutil/trace.go:171","msg":"trace[724606396] transaction","detail":"{read_only:false; response_revision:14496; number_of_response:1; }","duration":"128.919375ms","start":"2026-05-11T11:17:21.306007Z","end":"2026-05-11T11:17:21.434926Z","steps":["trace[724606396] 'process raft request' (duration: 128.636639ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:17:57.126408Z","caller":"traceutil/trace.go:171","msg":"trace[1619898673] transaction","detail":"{read_only:false; response_revision:14698; number_of_response:1; }","duration":"230.641784ms","start":"2026-05-11T11:17:56.895732Z","end":"2026-05-11T11:17:57.126374Z","steps":["trace[1619898673] 'process raft request' (duration: 230.43455ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:17:57.689859Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12701} {"level":"info","ts":"2026-05-11T11:17:57.771129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12701,"took":"77.638692ms","hash":1727912826,"current-db-size-bytes":57110528,"current-db-size":"57 MB","current-db-size-in-use-bytes":27107328,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-05-11T11:17:57.771223Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1727912826,"revision":12701,"compact-revision":10537} {"level":"warn","ts":"2026-05-11T11:18:20.355999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.214655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T11:18:20.356003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.848409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T11:18:20.356138Z","caller":"traceutil/trace.go:171","msg":"trace[83660328] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:15016; }","duration":"238.402979ms","start":"2026-05-11T11:18:20.117704Z","end":"2026-05-11T11:18:20.356107Z","steps":["trace[83660328] 'count revisions from in-memory index tree' (duration: 238.136704ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:18:20.356206Z","caller":"traceutil/trace.go:171","msg":"trace[1139359967] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:15016; }","duration":"268.142436ms","start":"2026-05-11T11:18:20.088031Z","end":"2026-05-11T11:18:20.356174Z","steps":["trace[1139359967] 'count revisions from in-memory index tree' (duration: 267.574855ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:19:47.200027Z","caller":"traceutil/trace.go:171","msg":"trace[651157682] transaction","detail":"{read_only:false; response_revision:15829; number_of_response:1; }","duration":"108.092992ms","start":"2026-05-11T11:19:47.091903Z","end":"2026-05-11T11:19:47.199996Z","steps":["trace[651157682] 'process raft request' (duration: 107.862618ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:22:57.696523Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14710} {"level":"info","ts":"2026-05-11T11:22:57.775565Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14710,"took":"74.936213ms","hash":2795367224,"current-db-size-bytes":57110528,"current-db-size":"57 MB","current-db-size-in-use-bytes":33669120,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-11T11:22:57.775643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2795367224,"revision":14710,"compact-revision":12701} {"level":"warn","ts":"2026-05-11T11:25:48.762934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.659789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18620"} {"level":"info","ts":"2026-05-11T11:25:48.763036Z","caller":"traceutil/trace.go:171","msg":"trace[1965641241] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:18489; }","duration":"214.815722ms","start":"2026-05-11T11:25:48.548195Z","end":"2026-05-11T11:25:48.763011Z","steps":["trace[1965641241] 'range keys from in-memory index tree' (duration: 214.422455ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:25:59.567524Z","caller":"traceutil/trace.go:171","msg":"trace[256889568] transaction","detail":"{read_only:false; response_revision:18636; number_of_response:1; }","duration":"101.005151ms","start":"2026-05-11T11:25:59.466489Z","end":"2026-05-11T11:25:59.567495Z","steps":["trace[256889568] 'process raft request' (duration: 100.882199ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:25:59.592488Z","caller":"traceutil/trace.go:171","msg":"trace[1184342881] transaction","detail":"{read_only:false; response_revision:18637; number_of_response:1; }","duration":"119.937236ms","start":"2026-05-11T11:25:59.472514Z","end":"2026-05-11T11:25:59.592451Z","steps":["trace[1184342881] 'process raft request' (duration: 115.106465ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:25:59.592776Z","caller":"traceutil/trace.go:171","msg":"trace[1828740806] transaction","detail":"{read_only:false; response_revision:18638; number_of_response:1; }","duration":"120.190891ms","start":"2026-05-11T11:25:59.472579Z","end":"2026-05-11T11:25:59.59277Z","steps":["trace[1828740806] 'process raft request' (duration: 119.817704ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:27:13.855234Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-11T11:27:13.860983Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-05-11T11:27:13.861234Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-05-11T11:27:57.702196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17373} {"level":"info","ts":"2026-05-11T11:27:57.806433Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17373,"took":"99.153407ms","hash":796028006,"current-db-size-bytes":57110528,"current-db-size":"57 MB","current-db-size-in-use-bytes":34111488,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-11T11:27:57.806494Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":796028006,"revision":17373,"compact-revision":14710} {"level":"info","ts":"2026-05-11T11:31:21.111706Z","caller":"traceutil/trace.go:171","msg":"trace[1473551608] linearizableReadLoop","detail":"{readStateIndex:21819; appliedIndex:21818; }","duration":"123.409962ms","start":"2026-05-11T11:31:20.988272Z","end":"2026-05-11T11:31:21.111682Z","steps":["trace[1473551608] 'read index received' (duration: 123.197767ms)","trace[1473551608] 'applied index is now lower than readState.Index' (duration: 211.185µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:31:21.111827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.556254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:31:21.111862Z","caller":"traceutil/trace.go:171","msg":"trace[2019685348] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21101; }","duration":"123.664477ms","start":"2026-05-11T11:31:20.988186Z","end":"2026-05-11T11:31:21.11185Z","steps":["trace[2019685348] 'agreement among raft nodes before linearized reading' (duration: 123.592466ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:31:21.111844Z","caller":"traceutil/trace.go:171","msg":"trace[620764516] transaction","detail":"{read_only:false; response_revision:21101; number_of_response:1; }","duration":"128.466176ms","start":"2026-05-11T11:31:20.983348Z","end":"2026-05-11T11:31:21.111815Z","steps":["trace[620764516] 'process raft request' (duration: 128.1942ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:31:21.112757Z","caller":"traceutil/trace.go:171","msg":"trace[1418966658] transaction","detail":"{read_only:false; response_revision:21102; number_of_response:1; }","duration":"118.512639ms","start":"2026-05-11T11:31:20.994215Z","end":"2026-05-11T11:31:21.112727Z","steps":["trace[1418966658] 'process raft request' (duration: 118.380366ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:31:42.933796Z","caller":"traceutil/trace.go:171","msg":"trace[1657669115] transaction","detail":"{read_only:false; response_revision:21211; number_of_response:1; }","duration":"213.675461ms","start":"2026-05-11T11:31:42.720089Z","end":"2026-05-11T11:31:42.933765Z","steps":["trace[1657669115] 'process raft request' (duration: 213.526289ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:31:43.043718Z","caller":"traceutil/trace.go:171","msg":"trace[2044298289] transaction","detail":"{read_only:false; response_revision:21212; number_of_response:1; }","duration":"321.288378ms","start":"2026-05-11T11:31:42.722405Z","end":"2026-05-11T11:31:43.043693Z","steps":["trace[2044298289] 'process raft request' (duration: 316.10133ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:31:43.044044Z","caller":"traceutil/trace.go:171","msg":"trace[1608070451] transaction","detail":"{read_only:false; response_revision:21213; number_of_response:1; }","duration":"178.725848ms","start":"2026-05-11T11:31:42.865284Z","end":"2026-05-11T11:31:43.04401Z","steps":["trace[1608070451] 'process raft request' (duration: 178.361011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:31:43.044422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:31:42.722389Z","time spent":"321.456931ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:31:43.052684Z","caller":"traceutil/trace.go:171","msg":"trace[1303658052] transaction","detail":"{read_only:false; response_revision:21214; number_of_response:1; }","duration":"118.243244ms","start":"2026-05-11T11:31:42.93442Z","end":"2026-05-11T11:31:43.052663Z","steps":["trace[1303658052] 'process raft request' (duration: 118.122152ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:31:43.350707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.495118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-05-11T11:31:43.35079Z","caller":"traceutil/trace.go:171","msg":"trace[1974347620] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:21214; }","duration":"190.655521ms","start":"2026-05-11T11:31:43.160119Z","end":"2026-05-11T11:31:43.350774Z","steps":["trace[1974347620] 'count revisions from in-memory index tree' (duration: 190.386246ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:31:43.351026Z","caller":"traceutil/trace.go:171","msg":"trace[833574475] transaction","detail":"{read_only:false; response_revision:21215; number_of_response:1; }","duration":"146.269369ms","start":"2026-05-11T11:31:43.204696Z","end":"2026-05-11T11:31:43.350966Z","steps":["trace[833574475] 'process raft request' (duration: 48.874006ms)","trace[833574475] 'compare' (duration: 96.073558ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:31:43.351137Z","caller":"traceutil/trace.go:171","msg":"trace[101800250] linearizableReadLoop","detail":"{readStateIndex:21938; appliedIndex:21937; }","duration":"136.502846ms","start":"2026-05-11T11:31:43.214608Z","end":"2026-05-11T11:31:43.351111Z","steps":["trace[101800250] 'read index received' (duration: 38.908669ms)","trace[101800250] 'applied index is now lower than readState.Index' (duration: 97.589707ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:31:43.351342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.717861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-05-11T11:31:43.351398Z","caller":"traceutil/trace.go:171","msg":"trace[2078539367] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21215; }","duration":"136.810433ms","start":"2026-05-11T11:31:43.214574Z","end":"2026-05-11T11:31:43.351384Z","steps":["trace[2078539367] 'agreement among raft nodes before linearized reading' (duration: 136.619218ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:31:43.550794Z","caller":"traceutil/trace.go:171","msg":"trace[1940151086] transaction","detail":"{read_only:false; response_revision:21216; number_of_response:1; }","duration":"194.88575ms","start":"2026-05-11T11:31:43.355886Z","end":"2026-05-11T11:31:43.550771Z","steps":["trace[1940151086] 'process raft request' (duration: 183.302003ms)","trace[1940151086] 'compare' (duration: 11.251051ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:32:57.708803Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19677} {"level":"info","ts":"2026-05-11T11:32:57.824195Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19677,"took":"111.386015ms","hash":2297602851,"current-db-size-bytes":57110528,"current-db-size":"57 MB","current-db-size-in-use-bytes":29380608,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-11T11:32:57.824268Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2297602851,"revision":19677,"compact-revision":17373} {"level":"info","ts":"2026-05-11T11:35:32.359909Z","caller":"traceutil/trace.go:171","msg":"trace[1434569530] transaction","detail":"{read_only:false; response_revision:23642; number_of_response:1; }","duration":"109.670339ms","start":"2026-05-11T11:35:32.250212Z","end":"2026-05-11T11:35:32.359882Z","steps":["trace[1434569530] 'process raft request' (duration: 109.178109ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:35:32.629052Z","caller":"traceutil/trace.go:171","msg":"trace[352630299] linearizableReadLoop","detail":"{readStateIndex:24439; appliedIndex:24438; }","duration":"138.194433ms","start":"2026-05-11T11:35:32.490824Z","end":"2026-05-11T11:35:32.629018Z","steps":["trace[352630299] 'read index received' (duration: 137.882387ms)","trace[352630299] 'applied index is now lower than readState.Index' (duration: 310.976µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:35:32.629301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.437417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-11T11:35:32.629337Z","caller":"traceutil/trace.go:171","msg":"trace[293762226] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:23643; }","duration":"138.55994ms","start":"2026-05-11T11:35:32.490769Z","end":"2026-05-11T11:35:32.629329Z","steps":["trace[293762226] 'agreement among raft nodes before linearized reading' (duration: 138.389896ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:35:32.629657Z","caller":"traceutil/trace.go:171","msg":"trace[1331328757] transaction","detail":"{read_only:false; response_revision:23643; number_of_response:1; }","duration":"203.801513ms","start":"2026-05-11T11:35:32.425815Z","end":"2026-05-11T11:35:32.629616Z","steps":["trace[1331328757] 'process raft request' (duration: 203.003558ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:35:32.681135Z","caller":"traceutil/trace.go:171","msg":"trace[164160847] transaction","detail":"{read_only:false; response_revision:23644; number_of_response:1; }","duration":"153.304327ms","start":"2026-05-11T11:35:32.527796Z","end":"2026-05-11T11:35:32.6811Z","steps":["trace[164160847] 'process raft request' (duration: 153.115744ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:37:57.715818Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21898} {"level":"info","ts":"2026-05-11T11:37:57.83509Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21898,"took":"115.660181ms","hash":1908983529,"current-db-size-bytes":58376192,"current-db-size":"58 MB","current-db-size-in-use-bytes":42975232,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-05-11T11:37:57.835159Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1908983529,"revision":21898,"compact-revision":19677} {"level":"info","ts":"2026-05-11T11:39:07.676311Z","caller":"traceutil/trace.go:171","msg":"trace[845188108] transaction","detail":"{read_only:false; response_revision:25765; number_of_response:1; }","duration":"131.643889ms","start":"2026-05-11T11:39:07.544627Z","end":"2026-05-11T11:39:07.676271Z","steps":["trace[845188108] 'process raft request' (duration: 131.352404ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:12.290319Z","caller":"traceutil/trace.go:171","msg":"trace[461048830] transaction","detail":"{read_only:false; response_revision:25797; number_of_response:1; }","duration":"115.833403ms","start":"2026-05-11T11:39:12.174454Z","end":"2026-05-11T11:39:12.290288Z","steps":["trace[461048830] 'process raft request' (duration: 109.679357ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:13.557255Z","caller":"traceutil/trace.go:171","msg":"trace[684535904] transaction","detail":"{read_only:false; response_revision:25810; number_of_response:1; }","duration":"192.001363ms","start":"2026-05-11T11:39:13.365229Z","end":"2026-05-11T11:39:13.55723Z","steps":["trace[684535904] 'process raft request' (duration: 191.804259ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:13.653391Z","caller":"traceutil/trace.go:171","msg":"trace[2052561765] transaction","detail":"{read_only:false; response_revision:25811; number_of_response:1; }","duration":"249.147875ms","start":"2026-05-11T11:39:13.404218Z","end":"2026-05-11T11:39:13.653365Z","steps":["trace[2052561765] 'process raft request' (duration: 248.197828ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:13.801884Z","caller":"traceutil/trace.go:171","msg":"trace[2063950790] transaction","detail":"{read_only:false; response_revision:25812; number_of_response:1; }","duration":"101.560085ms","start":"2026-05-11T11:39:13.700281Z","end":"2026-05-11T11:39:13.801841Z","steps":["trace[2063950790] 'process raft request' (duration: 97.481978ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:18.152753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.571685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-11T11:39:18.15289Z","caller":"traceutil/trace.go:171","msg":"trace[1578549399] linearizableReadLoop","detail":"{readStateIndex:26704; appliedIndex:26703; }","duration":"173.360382ms","start":"2026-05-11T11:39:17.979509Z","end":"2026-05-11T11:39:18.152869Z","steps":["trace[1578549399] 'read index received' (duration: 38.594634ms)","trace[1578549399] 'applied index is now lower than readState.Index' (duration: 134.764368ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:18.152928Z","caller":"traceutil/trace.go:171","msg":"trace[1150380957] transaction","detail":"{read_only:false; response_revision:25847; number_of_response:1; }","duration":"265.594884ms","start":"2026-05-11T11:39:17.887297Z","end":"2026-05-11T11:39:18.152891Z","steps":["trace[1150380957] 'process raft request' (duration: 130.775454ms)","trace[1150380957] 'compare' (duration: 134.355191ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:18.153015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.515406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:39:18.153046Z","caller":"traceutil/trace.go:171","msg":"trace[244580024] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25847; }","duration":"173.543846ms","start":"2026-05-11T11:39:17.979491Z","end":"2026-05-11T11:39:18.153035Z","steps":["trace[244580024] 'agreement among raft nodes before linearized reading' (duration: 173.482885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:18.153167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.050047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:39:18.153285Z","caller":"traceutil/trace.go:171","msg":"trace[1745169953] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:25847; }","duration":"157.195389ms","start":"2026-05-11T11:39:17.996061Z","end":"2026-05-11T11:39:18.153256Z","steps":["trace[1745169953] 'agreement among raft nodes before linearized reading' (duration: 156.999436ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:18.442656Z","caller":"traceutil/trace.go:171","msg":"trace[1390092102] transaction","detail":"{read_only:false; response_revision:25848; number_of_response:1; }","duration":"246.910502ms","start":"2026-05-11T11:39:18.195724Z","end":"2026-05-11T11:39:18.442635Z","steps":["trace[1390092102] 'process raft request' (duration: 246.734429ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:18.457849Z","caller":"traceutil/trace.go:171","msg":"trace[242851585] transaction","detail":"{read_only:false; response_revision:25849; number_of_response:1; }","duration":"218.400157ms","start":"2026-05-11T11:39:18.239385Z","end":"2026-05-11T11:39:18.457785Z","steps":["trace[242851585] 'process raft request' (duration: 218.080161ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:18.458157Z","caller":"traceutil/trace.go:171","msg":"trace[723173013] linearizableReadLoop","detail":"{readStateIndex:26706; appliedIndex:26704; }","duration":"140.582389ms","start":"2026-05-11T11:39:18.317385Z","end":"2026-05-11T11:39:18.457967Z","steps":["trace[723173013] 'read index received' (duration: 125.093638ms)","trace[723173013] 'applied index is now lower than readState.Index' (duration: 15.486751ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:18.458432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.016866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-05-11T11:39:18.458529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.029847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-05-11T11:39:18.458542Z","caller":"traceutil/trace.go:171","msg":"trace[1634901838] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25851; }","duration":"141.20263ms","start":"2026-05-11T11:39:18.317314Z","end":"2026-05-11T11:39:18.458516Z","steps":["trace[1634901838] 'agreement among raft nodes before linearized reading' (duration: 140.814003ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:18.458575Z","caller":"traceutil/trace.go:171","msg":"trace[2034906807] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25851; }","duration":"108.140838ms","start":"2026-05-11T11:39:18.350421Z","end":"2026-05-11T11:39:18.458562Z","steps":["trace[2034906807] 'agreement among raft nodes before linearized reading' (duration: 107.949025ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:18.621366Z","caller":"traceutil/trace.go:171","msg":"trace[1999704148] transaction","detail":"{read_only:false; response_revision:25852; number_of_response:1; }","duration":"151.89301ms","start":"2026-05-11T11:39:18.469432Z","end":"2026-05-11T11:39:18.621325Z","steps":["trace[1999704148] 'process raft request' (duration: 120.554962ms)","trace[1999704148] 'compare' (duration: 31.138844ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:18.662599Z","caller":"traceutil/trace.go:171","msg":"trace[519819552] transaction","detail":"{read_only:false; response_revision:25854; number_of_response:1; }","duration":"187.165202ms","start":"2026-05-11T11:39:18.475408Z","end":"2026-05-11T11:39:18.662573Z","steps":["trace[519819552] 'process raft request' (duration: 187.112061ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:18.662666Z","caller":"traceutil/trace.go:171","msg":"trace[1747040940] transaction","detail":"{read_only:false; response_revision:25853; number_of_response:1; }","duration":"187.330635ms","start":"2026-05-11T11:39:18.475297Z","end":"2026-05-11T11:39:18.662627Z","steps":["trace[1747040940] 'process raft request' (duration: 187.097381ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:18.90739Z","caller":"traceutil/trace.go:171","msg":"trace[1212503325] linearizableReadLoop","detail":"{readStateIndex:26713; appliedIndex:26712; }","duration":"113.690293ms","start":"2026-05-11T11:39:18.793671Z","end":"2026-05-11T11:39:18.907362Z","steps":["trace[1212503325] 'read index received' (duration: 112.756416ms)","trace[1212503325] 'applied index is now lower than readState.Index' (duration: 932.257µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:18.907517Z","caller":"traceutil/trace.go:171","msg":"trace[756690069] transaction","detail":"{read_only:false; response_revision:25856; number_of_response:1; }","duration":"121.729634ms","start":"2026-05-11T11:39:18.785775Z","end":"2026-05-11T11:39:18.907505Z","steps":["trace[756690069] 'process raft request' (duration: 120.689114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:18.907738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.03235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-11T11:39:18.907886Z","caller":"traceutil/trace.go:171","msg":"trace[377714329] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:25856; }","duration":"114.221012ms","start":"2026-05-11T11:39:18.793631Z","end":"2026-05-11T11:39:18.907852Z","steps":["trace[377714329] 'agreement among raft nodes before linearized reading' (duration: 113.960328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:19.210572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.681692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-11T11:39:19.211072Z","caller":"traceutil/trace.go:171","msg":"trace[813230958] linearizableReadLoop","detail":"{readStateIndex:26716; appliedIndex:26713; }","duration":"303.577826ms","start":"2026-05-11T11:39:18.907473Z","end":"2026-05-11T11:39:19.21105Z","steps":["trace[813230958] 'read index received' (duration: 148.192701ms)","trace[813230958] 'applied index is now lower than readState.Index' (duration: 155.381735ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:19.211249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.698821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:39:19.211205Z","caller":"traceutil/trace.go:171","msg":"trace[695994917] transaction","detail":"{read_only:false; response_revision:25859; number_of_response:1; }","duration":"306.218725ms","start":"2026-05-11T11:39:18.90495Z","end":"2026-05-11T11:39:19.211169Z","steps":["trace[695994917] 'process raft request' (duration: 306.045072ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:19.211294Z","caller":"traceutil/trace.go:171","msg":"trace[158549217] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:25859; }","duration":"414.797982ms","start":"2026-05-11T11:39:18.796484Z","end":"2026-05-11T11:39:19.211282Z","steps":["trace[158549217] 'agreement among raft nodes before linearized reading' (duration: 414.68193ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:19.211262Z","caller":"traceutil/trace.go:171","msg":"trace[553056193] transaction","detail":"{read_only:false; response_revision:25858; number_of_response:1; }","duration":"308.813164ms","start":"2026-05-11T11:39:18.902399Z","end":"2026-05-11T11:39:19.211212Z","steps":["trace[553056193] 'process raft request' (duration: 308.293394ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:19.211313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.22687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:39:19.211378Z","caller":"traceutil/trace.go:171","msg":"trace[1208854945] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25859; }","duration":"230.346212ms","start":"2026-05-11T11:39:18.981016Z","end":"2026-05-11T11:39:19.211362Z","steps":["trace[1208854945] 'agreement among raft nodes before linearized reading' (duration: 230.2328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:19.211384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:18.904914Z","time spent":"306.385869ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T11:39:19.21138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:18.796458Z","time spent":"414.863913ms","remote":"127.0.0.1:47238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-11T11:39:19.211521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:18.902382Z","time spent":"308.994898ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:39:19.211389Z","caller":"traceutil/trace.go:171","msg":"trace[1477269088] transaction","detail":"{read_only:false; response_revision:25857; number_of_response:1; }","duration":"316.095761ms","start":"2026-05-11T11:39:18.895137Z","end":"2026-05-11T11:39:19.211232Z","steps":["trace[1477269088] 'process raft request' (duration: 160.608263ms)","trace[1477269088] 'compare' (duration: 154.359586ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:19.211842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:18.895112Z","time spent":"316.56105ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:39:20.001319Z","caller":"traceutil/trace.go:171","msg":"trace[1436752775] transaction","detail":"{read_only:false; response_revision:25861; number_of_response:1; }","duration":"111.591714ms","start":"2026-05-11T11:39:19.889701Z","end":"2026-05-11T11:39:20.001292Z","steps":["trace[1436752775] 'process raft request' (duration: 111.41372ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:30.897898Z","caller":"traceutil/trace.go:171","msg":"trace[2023230692] linearizableReadLoop","detail":"{readStateIndex:26851; appliedIndex:26850; }","duration":"159.322949ms","start":"2026-05-11T11:39:30.738553Z","end":"2026-05-11T11:39:30.897876Z","steps":["trace[2023230692] 'read index received' (duration: 143.465901ms)","trace[2023230692] 'applied index is now lower than readState.Index' (duration: 15.855938ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:30.898089Z","caller":"traceutil/trace.go:171","msg":"trace[337271501] transaction","detail":"{read_only:false; response_revision:25992; number_of_response:1; }","duration":"160.94776ms","start":"2026-05-11T11:39:30.737127Z","end":"2026-05-11T11:39:30.898074Z","steps":["trace[337271501] 'process raft request' (duration: 144.829117ms)","trace[337271501] 'compare' (duration: 15.827398ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:30.898343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.768957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-05-11T11:39:30.898379Z","caller":"traceutil/trace.go:171","msg":"trace[129056919] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:25992; }","duration":"159.830579ms","start":"2026-05-11T11:39:30.738538Z","end":"2026-05-11T11:39:30.898369Z","steps":["trace[129056919] 'agreement among raft nodes before linearized reading' (duration: 159.717207ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:30.957291Z","caller":"traceutil/trace.go:171","msg":"trace[1776032397] transaction","detail":"{read_only:false; response_revision:25993; number_of_response:1; }","duration":"218.216235ms","start":"2026-05-11T11:39:30.739035Z","end":"2026-05-11T11:39:30.957252Z","steps":["trace[1776032397] 'process raft request' (duration: 217.888669ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:30.958243Z","caller":"traceutil/trace.go:171","msg":"trace[1080851734] transaction","detail":"{read_only:false; response_revision:25994; number_of_response:1; }","duration":"175.507913ms","start":"2026-05-11T11:39:30.782699Z","end":"2026-05-11T11:39:30.958207Z","steps":["trace[1080851734] 'process raft request' (duration: 174.735368ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:30.958331Z","caller":"traceutil/trace.go:171","msg":"trace[387414778] transaction","detail":"{read_only:false; response_revision:25995; number_of_response:1; }","duration":"126.781299ms","start":"2026-05-11T11:39:30.831492Z","end":"2026-05-11T11:39:30.958273Z","steps":["trace[387414778] 'process raft request' (duration: 126.643317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:30.958588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.096784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.246\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-05-11T11:39:30.958728Z","caller":"traceutil/trace.go:171","msg":"trace[2087894373] range","detail":"{range_begin:/registry/masterleases/199.204.45.246; range_end:; response_count:1; response_revision:25995; }","duration":"103.247777ms","start":"2026-05-11T11:39:30.855453Z","end":"2026-05-11T11:39:30.958701Z","steps":["trace[2087894373] 'agreement among raft nodes before linearized reading' (duration: 102.88614ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:30.959393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.847501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-05-11T11:39:30.959451Z","caller":"traceutil/trace.go:171","msg":"trace[55087999] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25995; }","duration":"214.919812ms","start":"2026-05-11T11:39:30.744515Z","end":"2026-05-11T11:39:30.959435Z","steps":["trace[55087999] 'agreement among raft nodes before linearized reading' (duration: 213.703979ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:31.899175Z","caller":"traceutil/trace.go:171","msg":"trace[2066296024] transaction","detail":"{read_only:false; response_revision:26004; number_of_response:1; }","duration":"158.536374ms","start":"2026-05-11T11:39:31.740609Z","end":"2026-05-11T11:39:31.899145Z","steps":["trace[2066296024] 'process raft request' (duration: 158.32829ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:31.920872Z","caller":"traceutil/trace.go:171","msg":"trace[64519842] transaction","detail":"{read_only:false; response_revision:26005; number_of_response:1; }","duration":"178.412467ms","start":"2026-05-11T11:39:31.74241Z","end":"2026-05-11T11:39:31.920822Z","steps":["trace[64519842] 'process raft request' (duration: 178.236524ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:32.709861Z","caller":"traceutil/trace.go:171","msg":"trace[793278856] linearizableReadLoop","detail":"{readStateIndex:26868; appliedIndex:26866; }","duration":"184.339669ms","start":"2026-05-11T11:39:32.525487Z","end":"2026-05-11T11:39:32.709827Z","steps":["trace[793278856] 'read index received' (duration: 85.83529ms)","trace[793278856] 'applied index is now lower than readState.Index' (duration: 98.502449ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:32.710104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.584574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-11T11:39:32.710133Z","caller":"traceutil/trace.go:171","msg":"trace[1792473161] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26008; }","duration":"184.663745ms","start":"2026-05-11T11:39:32.525461Z","end":"2026-05-11T11:39:32.710125Z","steps":["trace[1792473161] 'agreement among raft nodes before linearized reading' (duration: 184.471981ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:32.711309Z","caller":"traceutil/trace.go:171","msg":"trace[799430014] transaction","detail":"{read_only:false; response_revision:26008; number_of_response:1; }","duration":"184.578733ms","start":"2026-05-11T11:39:32.525302Z","end":"2026-05-11T11:39:32.709881Z","steps":["trace[799430014] 'process raft request' (duration: 172.119619ms)","trace[799430014] 'compare' (duration: 12.070167ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:32.881294Z","caller":"traceutil/trace.go:171","msg":"trace[1927405905] transaction","detail":"{read_only:false; response_revision:26009; number_of_response:1; }","duration":"167.015793ms","start":"2026-05-11T11:39:32.714256Z","end":"2026-05-11T11:39:32.881271Z","steps":["trace[1927405905] 'process raft request' (duration: 154.834526ms)","trace[1927405905] 'compare' (duration: 11.960263ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:32.881736Z","caller":"traceutil/trace.go:171","msg":"trace[1814543328] linearizableReadLoop","detail":"{readStateIndex:26869; appliedIndex:26868; }","duration":"143.059524ms","start":"2026-05-11T11:39:32.738137Z","end":"2026-05-11T11:39:32.881196Z","steps":["trace[1814543328] 'read index received' (duration: 130.969928ms)","trace[1814543328] 'applied index is now lower than readState.Index' (duration: 12.088546ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:32.881698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.524532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-11T11:39:32.881906Z","caller":"traceutil/trace.go:171","msg":"trace[1067228864] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26009; }","duration":"143.784618ms","start":"2026-05-11T11:39:32.73809Z","end":"2026-05-11T11:39:32.881874Z","steps":["trace[1067228864] 'agreement among raft nodes before linearized reading' (duration: 143.38821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:33.182808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.40525ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-11T11:39:33.18319Z","caller":"traceutil/trace.go:171","msg":"trace[1944225518] transaction","detail":"{read_only:false; response_revision:26011; number_of_response:1; }","duration":"264.412332ms","start":"2026-05-11T11:39:32.918731Z","end":"2026-05-11T11:39:33.183143Z","steps":["trace[1944225518] 'process raft request' (duration: 128.545133ms)","trace[1944225518] 'compare' (duration: 135.211396ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:33.183712Z","caller":"traceutil/trace.go:171","msg":"trace[1281109788] linearizableReadLoop","detail":"{readStateIndex:26871; appliedIndex:26870; }","duration":"221.404884ms","start":"2026-05-11T11:39:32.962243Z","end":"2026-05-11T11:39:33.183648Z","steps":["trace[1281109788] 'read index received' (duration: 85.047046ms)","trace[1281109788] 'applied index is now lower than readState.Index' (duration: 136.353438ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:33.183808Z","caller":"traceutil/trace.go:171","msg":"trace[1464941847] transaction","detail":"{read_only:false; response_revision:26012; number_of_response:1; }","duration":"219.166372ms","start":"2026-05-11T11:39:32.964612Z","end":"2026-05-11T11:39:33.183778Z","steps":["trace[1464941847] 'process raft request' (duration: 218.338537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:33.184061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.806101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-05-11T11:39:33.184134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.106793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-11T11:39:33.184097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.900467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-11T11:39:33.184208Z","caller":"traceutil/trace.go:171","msg":"trace[236952709] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:26013; }","duration":"144.177775ms","start":"2026-05-11T11:39:33.039982Z","end":"2026-05-11T11:39:33.18416Z","steps":["trace[236952709] 'agreement among raft nodes before linearized reading' (duration: 144.095232ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:33.184247Z","caller":"traceutil/trace.go:171","msg":"trace[1997147851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26013; }","duration":"210.111962ms","start":"2026-05-11T11:39:32.974113Z","end":"2026-05-11T11:39:33.184225Z","steps":["trace[1997147851] 'agreement among raft nodes before linearized reading' (duration: 209.790035ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:33.184144Z","caller":"traceutil/trace.go:171","msg":"trace[1545551011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26013; }","duration":"221.934984ms","start":"2026-05-11T11:39:32.962169Z","end":"2026-05-11T11:39:33.184104Z","steps":["trace[1545551011] 'agreement among raft nodes before linearized reading' (duration: 221.690019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:33.184362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.188642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-11T11:39:33.184487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.691003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-976b01a0-dfe5-4c62-9ad7-6abacfd0c496\" ","response":"range_response_count:1 size:3764"} {"level":"info","ts":"2026-05-11T11:39:33.184519Z","caller":"traceutil/trace.go:171","msg":"trace[285353470] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26013; }","duration":"203.357575ms","start":"2026-05-11T11:39:32.981133Z","end":"2026-05-11T11:39:33.18449Z","steps":["trace[285353470] 'agreement among raft nodes before linearized reading' (duration: 203.138461ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:33.184545Z","caller":"traceutil/trace.go:171","msg":"trace[1470865185] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-976b01a0-dfe5-4c62-9ad7-6abacfd0c496; range_end:; response_count:1; response_revision:26013; }","duration":"122.765013ms","start":"2026-05-11T11:39:33.06176Z","end":"2026-05-11T11:39:33.184525Z","steps":["trace[1470865185] 'agreement among raft nodes before linearized reading' (duration: 122.57223ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:33.500775Z","caller":"traceutil/trace.go:171","msg":"trace[1027176262] transaction","detail":"{read_only:false; response_revision:26015; number_of_response:1; }","duration":"310.73349ms","start":"2026-05-11T11:39:33.189995Z","end":"2026-05-11T11:39:33.500729Z","steps":["trace[1027176262] 'process raft request' (duration: 305.549973ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:33.500994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:33.189978Z","time spent":"310.911083ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:39:33.510522Z","caller":"traceutil/trace.go:171","msg":"trace[944920854] transaction","detail":"{read_only:false; response_revision:26016; number_of_response:1; }","duration":"246.478365ms","start":"2026-05-11T11:39:33.264012Z","end":"2026-05-11T11:39:33.51049Z","steps":["trace[944920854] 'process raft request' (duration: 246.28801ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:33.510599Z","caller":"traceutil/trace.go:171","msg":"trace[2067351488] transaction","detail":"{read_only:false; response_revision:26017; number_of_response:1; }","duration":"245.931445ms","start":"2026-05-11T11:39:33.264626Z","end":"2026-05-11T11:39:33.510557Z","steps":["trace[2067351488] 'process raft request' (duration: 245.783392ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:33.510972Z","caller":"traceutil/trace.go:171","msg":"trace[879008508] transaction","detail":"{read_only:false; response_revision:26018; number_of_response:1; }","duration":"244.233363ms","start":"2026-05-11T11:39:33.26672Z","end":"2026-05-11T11:39:33.510954Z","steps":["trace[879008508] 'process raft request' (duration: 243.717064ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:34.11643Z","caller":"traceutil/trace.go:171","msg":"trace[572611771] linearizableReadLoop","detail":"{readStateIndex:26881; appliedIndex:26880; }","duration":"114.238553ms","start":"2026-05-11T11:39:34.002155Z","end":"2026-05-11T11:39:34.116394Z","steps":["trace[572611771] 'read index received' (duration: 93.928303ms)","trace[572611771] 'applied index is now lower than readState.Index' (duration: 20.30881ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:34.116615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.946707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:39:34.116659Z","caller":"traceutil/trace.go:171","msg":"trace[1818678828] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:26021; }","duration":"138.069031ms","start":"2026-05-11T11:39:33.978575Z","end":"2026-05-11T11:39:34.116644Z","steps":["trace[1818678828] 'agreement among raft nodes before linearized reading' (duration: 137.938157ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:34.116683Z","caller":"traceutil/trace.go:171","msg":"trace[1204038697] transaction","detail":"{read_only:false; response_revision:26021; number_of_response:1; }","duration":"147.099521ms","start":"2026-05-11T11:39:33.969535Z","end":"2026-05-11T11:39:34.116635Z","steps":["trace[1204038697] 'process raft request' (duration: 126.530485ms)","trace[1204038697] 'compare' (duration: 20.158078ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:34.988209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.552553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-11T11:39:34.988345Z","caller":"traceutil/trace.go:171","msg":"trace[121669343] linearizableReadLoop","detail":"{readStateIndex:26884; appliedIndex:26883; }","duration":"186.911057ms","start":"2026-05-11T11:39:34.801411Z","end":"2026-05-11T11:39:34.988322Z","steps":["trace[121669343] 'read index received' (duration: 50.061639ms)","trace[121669343] 'applied index is now lower than readState.Index' (duration: 136.847597ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:34.988361Z","caller":"traceutil/trace.go:171","msg":"trace[1761481753] transaction","detail":"{read_only:false; response_revision:26024; number_of_response:1; }","duration":"272.077195ms","start":"2026-05-11T11:39:34.716247Z","end":"2026-05-11T11:39:34.988324Z","steps":["trace[1761481753] 'process raft request' (duration: 135.259517ms)","trace[1761481753] 'compare' (duration: 136.007543ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:34.988662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.221419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-11T11:39:34.988737Z","caller":"traceutil/trace.go:171","msg":"trace[1826241256] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26024; }","duration":"101.360712ms","start":"2026-05-11T11:39:34.887357Z","end":"2026-05-11T11:39:34.988718Z","steps":["trace[1826241256] 'agreement among raft nodes before linearized reading' (duration: 101.109137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:34.988778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.321804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-05-11T11:39:34.988929Z","caller":"traceutil/trace.go:171","msg":"trace[3599988] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26024; }","duration":"187.521587ms","start":"2026-05-11T11:39:34.801354Z","end":"2026-05-11T11:39:34.988876Z","steps":["trace[3599988] 'agreement among raft nodes before linearized reading' (duration: 187.044759ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:35.147723Z","caller":"traceutil/trace.go:171","msg":"trace[2030887283] transaction","detail":"{read_only:false; response_revision:26025; number_of_response:1; }","duration":"154.856036ms","start":"2026-05-11T11:39:34.992837Z","end":"2026-05-11T11:39:35.147693Z","steps":["trace[2030887283] 'process raft request' (duration: 149.319762ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:35.149277Z","caller":"traceutil/trace.go:171","msg":"trace[2146221264] linearizableReadLoop","detail":"{readStateIndex:26886; appliedIndex:26884; }","duration":"137.286086ms","start":"2026-05-11T11:39:35.011958Z","end":"2026-05-11T11:39:35.149245Z","steps":["trace[2146221264] 'read index received' (duration: 130.125501ms)","trace[2146221264] 'applied index is now lower than readState.Index' (duration: 7.159595ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:35.149361Z","caller":"traceutil/trace.go:171","msg":"trace[747160092] transaction","detail":"{read_only:false; response_revision:26026; number_of_response:1; }","duration":"156.320693ms","start":"2026-05-11T11:39:34.993015Z","end":"2026-05-11T11:39:35.149335Z","steps":["trace[747160092] 'process raft request' (duration: 156.11116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:35.149416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.443588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:39:35.149445Z","caller":"traceutil/trace.go:171","msg":"trace[110386806] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:26026; }","duration":"137.52623ms","start":"2026-05-11T11:39:35.01191Z","end":"2026-05-11T11:39:35.149436Z","steps":["trace[110386806] 'agreement among raft nodes before linearized reading' (duration: 137.447759ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:35.507658Z","caller":"traceutil/trace.go:171","msg":"trace[1015871271] transaction","detail":"{read_only:false; response_revision:26029; number_of_response:1; }","duration":"286.855712ms","start":"2026-05-11T11:39:35.220774Z","end":"2026-05-11T11:39:35.50763Z","steps":["trace[1015871271] 'process raft request' (duration: 272.467612ms)","trace[1015871271] 'compare' (duration: 13.924172ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:36.066007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.520662ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-11T11:39:36.066139Z","caller":"traceutil/trace.go:171","msg":"trace[315017129] transaction","detail":"{read_only:false; response_revision:26030; number_of_response:1; }","duration":"555.185768ms","start":"2026-05-11T11:39:35.51093Z","end":"2026-05-11T11:39:36.066116Z","steps":["trace[315017129] 'process raft request' (duration: 305.459303ms)","trace[315017129] 'compare' (duration: 248.846898ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:36.066207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:35.510904Z","time spent":"555.268789ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:39:36.089907Z","caller":"traceutil/trace.go:171","msg":"trace[976556085] transaction","detail":"{read_only:false; response_revision:26031; number_of_response:1; }","duration":"574.624791ms","start":"2026-05-11T11:39:35.515256Z","end":"2026-05-11T11:39:36.089881Z","steps":["trace[976556085] 'process raft request' (duration: 574.319266ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:36.089933Z","caller":"traceutil/trace.go:171","msg":"trace[160614341] transaction","detail":"{read_only:false; response_revision:26033; number_of_response:1; }","duration":"573.003101ms","start":"2026-05-11T11:39:35.5169Z","end":"2026-05-11T11:39:36.089903Z","steps":["trace[160614341] 'process raft request' (duration: 572.905179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:36.090032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:35.515235Z","time spent":"574.733914ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T11:39:36.090123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:35.516873Z","time spent":"573.141563ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:39:36.090297Z","caller":"traceutil/trace.go:171","msg":"trace[1176723444] linearizableReadLoop","detail":"{readStateIndex:26893; appliedIndex:26889; }","duration":"521.598267ms","start":"2026-05-11T11:39:35.568251Z","end":"2026-05-11T11:39:36.089849Z","steps":["trace[1176723444] 'read index received' (duration: 248.159287ms)","trace[1176723444] 'applied index is now lower than readState.Index' (duration: 273.43751ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:36.090495Z","caller":"traceutil/trace.go:171","msg":"trace[1819607445] transaction","detail":"{read_only:false; response_revision:26032; number_of_response:1; }","duration":"574.214793ms","start":"2026-05-11T11:39:35.51626Z","end":"2026-05-11T11:39:36.090475Z","steps":["trace[1819607445] 'process raft request' (duration: 573.49482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:36.0906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:35.51625Z","time spent":"574.312365ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T11:39:36.090329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.034894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:39:36.092016Z","caller":"traceutil/trace.go:171","msg":"trace[1920113711] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:26033; }","duration":"522.496113ms","start":"2026-05-11T11:39:35.568206Z","end":"2026-05-11T11:39:36.090702Z","steps":["trace[1920113711] 'agreement among raft nodes before linearized reading' (duration: 521.800981ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:36.092114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:35.568139Z","time spent":"523.95312ms","remote":"127.0.0.1:37010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"info","ts":"2026-05-11T11:39:36.13948Z","caller":"traceutil/trace.go:171","msg":"trace[1084766678] transaction","detail":"{read_only:false; response_revision:26034; number_of_response:1; }","duration":"128.647084ms","start":"2026-05-11T11:39:36.01079Z","end":"2026-05-11T11:39:36.139437Z","steps":["trace[1084766678] 'process raft request' (duration: 128.385349ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:36.208704Z","caller":"traceutil/trace.go:171","msg":"trace[1568388149] linearizableReadLoop","detail":"{readStateIndex:26895; appliedIndex:26893; }","duration":"118.134567ms","start":"2026-05-11T11:39:36.090533Z","end":"2026-05-11T11:39:36.208667Z","steps":["trace[1568388149] 'read index received' (duration: 48.780116ms)","trace[1568388149] 'applied index is now lower than readState.Index' (duration: 69.352021ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:36.208792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.121379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-11T11:39:36.208927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"488.812391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:39:36.208977Z","caller":"traceutil/trace.go:171","msg":"trace[1600550817] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:26034; }","duration":"488.931214ms","start":"2026-05-11T11:39:35.720029Z","end":"2026-05-11T11:39:36.20896Z","steps":["trace[1600550817] 'agreement among raft nodes before linearized reading' (duration: 488.811121ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:36.20903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:35.72001Z","time spent":"489.008905ms","remote":"127.0.0.1:40844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-05-11T11:39:36.208927Z","caller":"traceutil/trace.go:171","msg":"trace[388641990] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26034; }","duration":"229.314753ms","start":"2026-05-11T11:39:35.979592Z","end":"2026-05-11T11:39:36.208907Z","steps":["trace[388641990] 'agreement among raft nodes before linearized reading' (duration: 229.134759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:36.20909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.063926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-05-11T11:39:36.20921Z","caller":"traceutil/trace.go:171","msg":"trace[14039074] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26034; }","duration":"239.25089ms","start":"2026-05-11T11:39:35.969928Z","end":"2026-05-11T11:39:36.209179Z","steps":["trace[14039074] 'agreement among raft nodes before linearized reading' (duration: 238.857622ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:37.325678Z","caller":"traceutil/trace.go:171","msg":"trace[236004723] transaction","detail":"{read_only:false; response_revision:26038; number_of_response:1; }","duration":"490.793708ms","start":"2026-05-11T11:39:36.834849Z","end":"2026-05-11T11:39:37.325643Z","steps":["trace[236004723] 'process raft request' (duration: 490.599104ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:37.32564Z","caller":"traceutil/trace.go:171","msg":"trace[2071310810] linearizableReadLoop","detail":"{readStateIndex:26899; appliedIndex:26898; }","duration":"345.695935ms","start":"2026-05-11T11:39:36.979918Z","end":"2026-05-11T11:39:37.325614Z","steps":["trace[2071310810] 'read index received' (duration: 345.577223ms)","trace[2071310810] 'applied index is now lower than readState.Index' (duration: 117.372µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:39:37.325833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.908051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-11T11:39:37.325856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:36.834834Z","time spent":"490.91317ms","remote":"127.0.0.1:43152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3932,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:39:37.32589Z","caller":"traceutil/trace.go:171","msg":"trace[518990831] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26038; }","duration":"346.018333ms","start":"2026-05-11T11:39:36.979857Z","end":"2026-05-11T11:39:37.325875Z","steps":["trace[518990831] 'agreement among raft nodes before linearized reading' (duration: 345.88419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:37.325934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:36.979831Z","time spent":"346.095595ms","remote":"127.0.0.1:42976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-11T11:39:37.361466Z","caller":"traceutil/trace.go:171","msg":"trace[1647913329] transaction","detail":"{read_only:false; response_revision:26039; number_of_response:1; }","duration":"367.091477ms","start":"2026-05-11T11:39:36.99433Z","end":"2026-05-11T11:39:37.361422Z","steps":["trace[1647913329] 'process raft request' (duration: 366.800122ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:37.361558Z","caller":"traceutil/trace.go:171","msg":"trace[1032730812] transaction","detail":"{read_only:false; response_revision:26040; number_of_response:1; }","duration":"156.355884ms","start":"2026-05-11T11:39:37.205171Z","end":"2026-05-11T11:39:37.361527Z","steps":["trace[1032730812] 'process raft request' (duration: 156.15183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:37.361619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.340967ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-976b01a0-dfe5-4c62-9ad7-6abacfd0c496\" ","response":"range_response_count:1 size:3950"} {"level":"info","ts":"2026-05-11T11:39:37.361685Z","caller":"traceutil/trace.go:171","msg":"trace[810610006] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-976b01a0-dfe5-4c62-9ad7-6abacfd0c496; range_end:; response_count:1; response_revision:26040; }","duration":"145.452219ms","start":"2026-05-11T11:39:37.216216Z","end":"2026-05-11T11:39:37.361668Z","steps":["trace[810610006] 'agreement among raft nodes before linearized reading' (duration: 145.335857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:37.361796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:39:36.994295Z","time spent":"367.276091ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T11:39:37.361813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.19248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-11T11:39:37.361951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.344398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-11T11:39:37.362022Z","caller":"traceutil/trace.go:171","msg":"trace[154825621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26040; }","duration":"209.463009ms","start":"2026-05-11T11:39:37.152543Z","end":"2026-05-11T11:39:37.362006Z","steps":["trace[154825621] 'agreement among raft nodes before linearized reading' (duration: 209.110872ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:37.361995Z","caller":"traceutil/trace.go:171","msg":"trace[964956439] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:26040; }","duration":"245.451305ms","start":"2026-05-11T11:39:37.116496Z","end":"2026-05-11T11:39:37.361948Z","steps":["trace[964956439] 'agreement among raft nodes before linearized reading' (duration: 245.147179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:37.362039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.978925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-11T11:39:37.362125Z","caller":"traceutil/trace.go:171","msg":"trace[783003533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26040; }","duration":"157.123078ms","start":"2026-05-11T11:39:37.204982Z","end":"2026-05-11T11:39:37.362105Z","steps":["trace[783003533] 'agreement among raft nodes before linearized reading' (duration: 156.453645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:39:37.362224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.772167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-11T11:39:37.362277Z","caller":"traceutil/trace.go:171","msg":"trace[488712389] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26040; }","duration":"208.849459ms","start":"2026-05-11T11:39:37.153415Z","end":"2026-05-11T11:39:37.362264Z","steps":["trace[488712389] 'agreement among raft nodes before linearized reading' (duration: 208.025394ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:39:43.496929Z","caller":"traceutil/trace.go:171","msg":"trace[1845985858] transaction","detail":"{read_only:false; response_revision:26106; number_of_response:1; }","duration":"112.50117ms","start":"2026-05-11T11:39:43.384373Z","end":"2026-05-11T11:39:43.496874Z","steps":["trace[1845985858] 'process raft request' (duration: 94.761327ms)","trace[1845985858] 'compare' (duration: 17.55554ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:39:43.507879Z","caller":"traceutil/trace.go:171","msg":"trace[56490348] transaction","detail":"{read_only:false; response_revision:26107; number_of_response:1; }","duration":"123.087129ms","start":"2026-05-11T11:39:43.38476Z","end":"2026-05-11T11:39:43.507847Z","steps":["trace[56490348] 'process raft request' (duration: 122.831745ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:03.401012Z","caller":"traceutil/trace.go:171","msg":"trace[1063496592] transaction","detail":"{read_only:false; response_revision:26292; number_of_response:1; }","duration":"128.274158ms","start":"2026-05-11T11:40:03.272692Z","end":"2026-05-11T11:40:03.400967Z","steps":["trace[1063496592] 'process raft request' (duration: 127.807879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:03.677482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.823181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-11T11:40:03.677655Z","caller":"traceutil/trace.go:171","msg":"trace[378371098] transaction","detail":"{read_only:false; response_revision:26293; number_of_response:1; }","duration":"138.987999ms","start":"2026-05-11T11:40:03.53864Z","end":"2026-05-11T11:40:03.677628Z","steps":["trace[378371098] 'process raft request' (duration: 12.888102ms)","trace[378371098] 'compare' (duration: 125.527766ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:03.846997Z","caller":"traceutil/trace.go:171","msg":"trace[438044587] transaction","detail":"{read_only:false; response_revision:26294; number_of_response:1; }","duration":"260.484577ms","start":"2026-05-11T11:40:03.58648Z","end":"2026-05-11T11:40:03.846964Z","steps":["trace[438044587] 'process raft request' (duration: 235.349346ms)","trace[438044587] 'compare' (duration: 24.902467ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:03.847146Z","caller":"traceutil/trace.go:171","msg":"trace[1511636477] linearizableReadLoop","detail":"{readStateIndex:27162; appliedIndex:27160; }","duration":"230.339802ms","start":"2026-05-11T11:40:03.616774Z","end":"2026-05-11T11:40:03.847114Z","steps":["trace[1511636477] 'read index received' (duration: 205.066758ms)","trace[1511636477] 'applied index is now lower than readState.Index' (duration: 25.270544ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:03.847223Z","caller":"traceutil/trace.go:171","msg":"trace[1894130545] transaction","detail":"{read_only:false; response_revision:26295; number_of_response:1; }","duration":"259.635632ms","start":"2026-05-11T11:40:03.58754Z","end":"2026-05-11T11:40:03.847176Z","steps":["trace[1894130545] 'process raft request' (duration: 259.373786ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:03.847371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.585357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-11T11:40:03.8474Z","caller":"traceutil/trace.go:171","msg":"trace[1698310451] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26295; }","duration":"230.667138ms","start":"2026-05-11T11:40:03.616725Z","end":"2026-05-11T11:40:03.847392Z","steps":["trace[1698310451] 'agreement among raft nodes before linearized reading' (duration: 230.526405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:03.847407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.372537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-05-11T11:40:03.847428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.858415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-11T11:40:03.847446Z","caller":"traceutil/trace.go:171","msg":"trace[1356349272] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:26295; }","duration":"122.458338ms","start":"2026-05-11T11:40:03.724975Z","end":"2026-05-11T11:40:03.847433Z","steps":["trace[1356349272] 'agreement among raft nodes before linearized reading' (duration: 122.386446ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:03.847473Z","caller":"traceutil/trace.go:171","msg":"trace[709271709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26295; }","duration":"228.955106ms","start":"2026-05-11T11:40:03.618504Z","end":"2026-05-11T11:40:03.847459Z","steps":["trace[709271709] 'agreement among raft nodes before linearized reading' (duration: 228.792163ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:03.84752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.439803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-11T11:40:03.847584Z","caller":"traceutil/trace.go:171","msg":"trace[50948229] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26295; }","duration":"223.583885ms","start":"2026-05-11T11:40:03.623981Z","end":"2026-05-11T11:40:03.847565Z","steps":["trace[50948229] 'agreement among raft nodes before linearized reading' (duration: 223.431532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:03.847588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.584544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-11T11:40:03.847623Z","caller":"traceutil/trace.go:171","msg":"trace[824953763] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26295; }","duration":"224.643915ms","start":"2026-05-11T11:40:03.62297Z","end":"2026-05-11T11:40:03.847614Z","steps":["trace[824953763] 'agreement among raft nodes before linearized reading' (duration: 224.535763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:04.130205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.720164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-11T11:40:04.130656Z","caller":"traceutil/trace.go:171","msg":"trace[594465325] transaction","detail":"{read_only:false; response_revision:26296; number_of_response:1; }","duration":"279.30542ms","start":"2026-05-11T11:40:03.851305Z","end":"2026-05-11T11:40:04.13061Z","steps":["trace[594465325] 'process raft request' (duration: 133.422764ms)","trace[594465325] 'compare' (duration: 144.444989ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:04.130732Z","caller":"traceutil/trace.go:171","msg":"trace[1031556077] transaction","detail":"{read_only:false; response_revision:26299; number_of_response:1; }","duration":"277.842622ms","start":"2026-05-11T11:40:03.852878Z","end":"2026-05-11T11:40:04.13072Z","steps":["trace[1031556077] 'process raft request' (duration: 277.780511ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:04.130847Z","caller":"traceutil/trace.go:171","msg":"trace[1893643533] transaction","detail":"{read_only:false; response_revision:26297; number_of_response:1; }","duration":"278.826041ms","start":"2026-05-11T11:40:03.851994Z","end":"2026-05-11T11:40:04.13082Z","steps":["trace[1893643533] 'process raft request' (duration: 278.353232ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:04.130911Z","caller":"traceutil/trace.go:171","msg":"trace[989824621] transaction","detail":"{read_only:false; response_revision:26298; number_of_response:1; }","duration":"278.126877ms","start":"2026-05-11T11:40:03.852763Z","end":"2026-05-11T11:40:04.13089Z","steps":["trace[989824621] 'process raft request' (duration: 277.693789ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:04.423985Z","caller":"traceutil/trace.go:171","msg":"trace[107666036] transaction","detail":"{read_only:false; response_revision:26300; number_of_response:1; }","duration":"234.561442ms","start":"2026-05-11T11:40:04.189394Z","end":"2026-05-11T11:40:04.423956Z","steps":["trace[107666036] 'process raft request' (duration: 234.351547ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:04.619179Z","caller":"traceutil/trace.go:171","msg":"trace[351778849] transaction","detail":"{read_only:false; response_revision:26302; number_of_response:1; }","duration":"428.593981ms","start":"2026-05-11T11:40:04.190558Z","end":"2026-05-11T11:40:04.619152Z","steps":["trace[351778849] 'process raft request' (duration: 428.53056ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:04.619184Z","caller":"traceutil/trace.go:171","msg":"trace[54699000] transaction","detail":"{read_only:false; response_revision:26301; number_of_response:1; }","duration":"429.07449ms","start":"2026-05-11T11:40:04.190083Z","end":"2026-05-11T11:40:04.619157Z","steps":["trace[54699000] 'process raft request' (duration: 428.849235ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:04.619331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:40:04.190526Z","time spent":"428.722863ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T11:40:04.619611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:40:04.190054Z","time spent":"429.198993ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:40:04.619686Z","caller":"traceutil/trace.go:171","msg":"trace[489759415] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"296.634656ms","start":"2026-05-11T11:40:04.323043Z","end":"2026-05-11T11:40:04.619678Z","steps":["trace[489759415] 'process raft request' (duration: 296.358611ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:04.619628Z","caller":"traceutil/trace.go:171","msg":"trace[1987424489] linearizableReadLoop","detail":"{readStateIndex:27169; appliedIndex:27166; }","duration":"422.493556ms","start":"2026-05-11T11:40:04.1971Z","end":"2026-05-11T11:40:04.619593Z","steps":["trace[1987424489] 'read index received' (duration: 226.806946ms)","trace[1987424489] 'applied index is now lower than readState.Index' (duration: 195.68487ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:40:04.619868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.430715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:40:04.619897Z","caller":"traceutil/trace.go:171","msg":"trace[858626160] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:26304; }","duration":"139.502757ms","start":"2026-05-11T11:40:04.480386Z","end":"2026-05-11T11:40:04.619889Z","steps":["trace[858626160] 'agreement among raft nodes before linearized reading' (duration: 139.453896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:04.619924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.701813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:40:04.619986Z","caller":"traceutil/trace.go:171","msg":"trace[803232202] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:26304; }","duration":"250.793986ms","start":"2026-05-11T11:40:04.369168Z","end":"2026-05-11T11:40:04.619962Z","steps":["trace[803232202] 'agreement among raft nodes before linearized reading' (duration: 250.641232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:04.619957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.832163ms","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-11T11:40:04.620039Z","caller":"traceutil/trace.go:171","msg":"trace[1185915292] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26304; }","duration":"422.979057ms","start":"2026-05-11T11:40:04.197048Z","end":"2026-05-11T11:40:04.620027Z","steps":["trace[1185915292] 'agreement among raft nodes before linearized reading' (duration: 422.705721ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:04.620095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:40:04.19702Z","time spent":"423.066358ms","remote":"127.0.0.1:43220","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":"info","ts":"2026-05-11T11:40:04.619508Z","caller":"traceutil/trace.go:171","msg":"trace[1554217859] transaction","detail":"{read_only:false; response_revision:26303; number_of_response:1; }","duration":"368.744308ms","start":"2026-05-11T11:40:04.250721Z","end":"2026-05-11T11:40:04.619466Z","steps":["trace[1554217859] 'process raft request' (duration: 368.402452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:04.620618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:40:04.250703Z","time spent":"369.829338ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:40:04.895128Z","caller":"traceutil/trace.go:171","msg":"trace[381828790] transaction","detail":"{read_only:false; response_revision:26305; number_of_response:1; }","duration":"270.467645ms","start":"2026-05-11T11:40:04.624629Z","end":"2026-05-11T11:40:04.895096Z","steps":["trace[381828790] 'process raft request' (duration: 270.286062ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:05.104518Z","caller":"traceutil/trace.go:171","msg":"trace[222841443] linearizableReadLoop","detail":"{readStateIndex:27173; appliedIndex:27172; }","duration":"194.585071ms","start":"2026-05-11T11:40:04.909911Z","end":"2026-05-11T11:40:05.104496Z","steps":["trace[222841443] 'read index received' (duration: 186.058661ms)","trace[222841443] 'applied index is now lower than readState.Index' (duration: 8.52474ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:05.104555Z","caller":"traceutil/trace.go:171","msg":"trace[2018210913] transaction","detail":"{read_only:false; response_revision:26307; number_of_response:1; }","duration":"190.375052ms","start":"2026-05-11T11:40:04.914146Z","end":"2026-05-11T11:40:05.104521Z","steps":["trace[2018210913] 'process raft request' (duration: 190.27072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:05.104802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.827135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/securitygroups/\" range_end:\"/registry/openstack.k-orc.cloud/securitygroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:40:05.104883Z","caller":"traceutil/trace.go:171","msg":"trace[2076037106] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/securitygroups/; range_end:/registry/openstack.k-orc.cloud/securitygroups0; response_count:0; response_revision:26307; }","duration":"194.947567ms","start":"2026-05-11T11:40:04.909894Z","end":"2026-05-11T11:40:05.104842Z","steps":["trace[2076037106] 'agreement among raft nodes before linearized reading' (duration: 194.741554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:05.104972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.506582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:40:05.105017Z","caller":"traceutil/trace.go:171","msg":"trace[268345701] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26307; }","duration":"127.601154ms","start":"2026-05-11T11:40:04.977404Z","end":"2026-05-11T11:40:05.105006Z","steps":["trace[268345701] 'agreement among raft nodes before linearized reading' (duration: 127.515033ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:05.105139Z","caller":"traceutil/trace.go:171","msg":"trace[392889130] transaction","detail":"{read_only:false; response_revision:26306; number_of_response:1; }","duration":"247.237129ms","start":"2026-05-11T11:40:04.857213Z","end":"2026-05-11T11:40:05.10445Z","steps":["trace[392889130] 'process raft request' (duration: 238.74216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:06.061763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.575507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-05-11T11:40:06.061924Z","caller":"traceutil/trace.go:171","msg":"trace[1568892970] transaction","detail":"{read_only:false; response_revision:26309; number_of_response:1; }","duration":"208.590004ms","start":"2026-05-11T11:40:05.853296Z","end":"2026-05-11T11:40:06.061886Z","steps":["trace[1568892970] 'process raft request' (duration: 91.753902ms)","trace[1568892970] 'compare' (duration: 116.373724ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:06.325607Z","caller":"traceutil/trace.go:171","msg":"trace[1903956330] linearizableReadLoop","detail":"{readStateIndex:27177; appliedIndex:27176; }","duration":"190.575915ms","start":"2026-05-11T11:40:06.135Z","end":"2026-05-11T11:40:06.325576Z","steps":["trace[1903956330] 'read index received' (duration: 91.839872ms)","trace[1903956330] 'applied index is now lower than readState.Index' (duration: 98.733963ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:40:06.325924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.940962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-05-11T11:40:06.325927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.370942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-11T11:40:06.325972Z","caller":"traceutil/trace.go:171","msg":"trace[1000921222] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26309; }","duration":"191.072584ms","start":"2026-05-11T11:40:06.134889Z","end":"2026-05-11T11:40:06.325962Z","steps":["trace[1000921222] 'agreement among raft nodes before linearized reading' (duration: 190.8666ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:06.325993Z","caller":"traceutil/trace.go:171","msg":"trace[311247538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26309; }","duration":"190.466443ms","start":"2026-05-11T11:40:06.135508Z","end":"2026-05-11T11:40:06.325975Z","steps":["trace[311247538] 'agreement among raft nodes before linearized reading' (duration: 190.27198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:06.325928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.954854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-05-11T11:40:06.326052Z","caller":"traceutil/trace.go:171","msg":"trace[462472376] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26309; }","duration":"190.100926ms","start":"2026-05-11T11:40:06.135942Z","end":"2026-05-11T11:40:06.326043Z","steps":["trace[462472376] 'agreement among raft nodes before linearized reading' (duration: 189.837202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:06.326442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.210817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-11T11:40:06.326676Z","caller":"traceutil/trace.go:171","msg":"trace[424323850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26309; }","duration":"191.353579ms","start":"2026-05-11T11:40:06.135172Z","end":"2026-05-11T11:40:06.326526Z","steps":["trace[424323850] 'agreement among raft nodes before linearized reading' (duration: 190.597756ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:06.624198Z","caller":"traceutil/trace.go:171","msg":"trace[1668935608] transaction","detail":"{read_only:false; response_revision:26311; number_of_response:1; }","duration":"292.824923ms","start":"2026-05-11T11:40:06.331304Z","end":"2026-05-11T11:40:06.624129Z","steps":["trace[1668935608] 'process raft request' (duration: 267.729833ms)","trace[1668935608] 'compare' (duration: 24.811775ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:06.624537Z","caller":"traceutil/trace.go:171","msg":"trace[1876227209] transaction","detail":"{read_only:false; response_revision:26312; number_of_response:1; }","duration":"293.156939ms","start":"2026-05-11T11:40:06.331362Z","end":"2026-05-11T11:40:06.624519Z","steps":["trace[1876227209] 'process raft request' (duration: 292.717892ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:06.624759Z","caller":"traceutil/trace.go:171","msg":"trace[1302863283] linearizableReadLoop","detail":"{readStateIndex:27181; appliedIndex:27177; }","duration":"247.784359ms","start":"2026-05-11T11:40:06.376947Z","end":"2026-05-11T11:40:06.624731Z","steps":["trace[1302863283] 'read index received' (duration: 31.832898ms)","trace[1302863283] 'applied index is now lower than readState.Index' (duration: 215.950231ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:06.624821Z","caller":"traceutil/trace.go:171","msg":"trace[1741493294] transaction","detail":"{read_only:false; response_revision:26313; number_of_response:1; }","duration":"293.301862ms","start":"2026-05-11T11:40:06.331488Z","end":"2026-05-11T11:40:06.62479Z","steps":["trace[1741493294] 'process raft request' (duration: 292.964636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:06.624966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.002534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-05-11T11:40:06.625008Z","caller":"traceutil/trace.go:171","msg":"trace[869222996] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:26313; }","duration":"248.090776ms","start":"2026-05-11T11:40:06.376902Z","end":"2026-05-11T11:40:06.624993Z","steps":["trace[869222996] 'agreement among raft nodes before linearized reading' (duration: 247.929472ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:06.691945Z","caller":"traceutil/trace.go:171","msg":"trace[761602142] transaction","detail":"{read_only:false; response_revision:26314; number_of_response:1; }","duration":"262.103398ms","start":"2026-05-11T11:40:06.429798Z","end":"2026-05-11T11:40:06.691902Z","steps":["trace[761602142] 'process raft request' (duration: 261.899764ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:06.823865Z","caller":"traceutil/trace.go:171","msg":"trace[1775699274] transaction","detail":"{read_only:false; response_revision:26315; number_of_response:1; }","duration":"198.26801ms","start":"2026-05-11T11:40:06.625553Z","end":"2026-05-11T11:40:06.823821Z","steps":["trace[1775699274] 'process raft request' (duration: 164.139429ms)","trace[1775699274] 'compare' (duration: 33.853045ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:06.823879Z","caller":"traceutil/trace.go:171","msg":"trace[728222665] transaction","detail":"{read_only:false; response_revision:26316; number_of_response:1; }","duration":"198.055577ms","start":"2026-05-11T11:40:06.625789Z","end":"2026-05-11T11:40:06.823845Z","steps":["trace[728222665] 'process raft request' (duration: 197.930775ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:06.82399Z","caller":"traceutil/trace.go:171","msg":"trace[47355683] transaction","detail":"{read_only:false; response_revision:26317; number_of_response:1; }","duration":"196.996537ms","start":"2026-05-11T11:40:06.626958Z","end":"2026-05-11T11:40:06.823955Z","steps":["trace[47355683] 'process raft request' (duration: 196.819254ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:06.823901Z","caller":"traceutil/trace.go:171","msg":"trace[647660478] linearizableReadLoop","detail":"{readStateIndex:27186; appliedIndex:27181; }","duration":"195.674112ms","start":"2026-05-11T11:40:06.628209Z","end":"2026-05-11T11:40:06.823883Z","steps":["trace[647660478] 'read index received' (duration: 63.570872ms)","trace[647660478] 'applied index is now lower than readState.Index' (duration: 132.10172ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:40:06.824083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.848295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-11a13fc6-f9e1-4891-bfa4-1a7f6b16dc85\" ","response":"range_response_count:1 size:1323"} {"level":"info","ts":"2026-05-11T11:40:06.824129Z","caller":"traceutil/trace.go:171","msg":"trace[1350605260] range","detail":"{range_begin:/registry/persistentvolumes/pvc-11a13fc6-f9e1-4891-bfa4-1a7f6b16dc85; range_end:; response_count:1; response_revision:26318; }","duration":"195.937507ms","start":"2026-05-11T11:40:06.628178Z","end":"2026-05-11T11:40:06.824116Z","steps":["trace[1350605260] 'agreement among raft nodes before linearized reading' (duration: 195.771584ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:06.824114Z","caller":"traceutil/trace.go:171","msg":"trace[658420981] transaction","detail":"{read_only:false; response_revision:26318; number_of_response:1; }","duration":"196.522538ms","start":"2026-05-11T11:40:06.627551Z","end":"2026-05-11T11:40:06.824074Z","steps":["trace[658420981] 'process raft request' (duration: 196.271123ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:07.035138Z","caller":"traceutil/trace.go:171","msg":"trace[234107765] linearizableReadLoop","detail":"{readStateIndex:27187; appliedIndex:27186; }","duration":"129.912547ms","start":"2026-05-11T11:40:06.905196Z","end":"2026-05-11T11:40:07.035108Z","steps":["trace[234107765] 'read index received' (duration: 65.688823ms)","trace[234107765] 'applied index is now lower than readState.Index' (duration: 64.222584ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:07.035287Z","caller":"traceutil/trace.go:171","msg":"trace[843055262] transaction","detail":"{read_only:false; response_revision:26319; number_of_response:1; }","duration":"132.435625ms","start":"2026-05-11T11:40:06.902837Z","end":"2026-05-11T11:40:07.035272Z","steps":["trace[843055262] 'process raft request' (duration: 68.144518ms)","trace[843055262] 'compare' (duration: 63.99254ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:40:07.035648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.431337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-05-11T11:40:07.035728Z","caller":"traceutil/trace.go:171","msg":"trace[126083490] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26319; }","duration":"130.56274ms","start":"2026-05-11T11:40:06.905144Z","end":"2026-05-11T11:40:07.035707Z","steps":["trace[126083490] 'agreement among raft nodes before linearized reading' (duration: 130.313025ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:07.227488Z","caller":"traceutil/trace.go:171","msg":"trace[204677386] transaction","detail":"{read_only:false; response_revision:26320; number_of_response:1; }","duration":"117.746549ms","start":"2026-05-11T11:40:07.109706Z","end":"2026-05-11T11:40:07.227452Z","steps":["trace[204677386] 'process raft request' (duration: 51.590658ms)","trace[204677386] 'compare' (duration: 66.008739ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:13.897459Z","caller":"traceutil/trace.go:171","msg":"trace[1996278150] transaction","detail":"{read_only:false; response_revision:26374; number_of_response:1; }","duration":"152.844507ms","start":"2026-05-11T11:40:13.744585Z","end":"2026-05-11T11:40:13.897429Z","steps":["trace[1996278150] 'process raft request' (duration: 152.699225ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:14.075205Z","caller":"traceutil/trace.go:171","msg":"trace[1698720214] transaction","detail":"{read_only:false; response_revision:26376; number_of_response:1; }","duration":"125.75652ms","start":"2026-05-11T11:40:13.949396Z","end":"2026-05-11T11:40:14.075152Z","steps":["trace[1698720214] 'process raft request' (duration: 63.749256ms)","trace[1698720214] 'compare' (duration: 61.800629ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:16.832366Z","caller":"traceutil/trace.go:171","msg":"trace[295021432] linearizableReadLoop","detail":"{readStateIndex:27266; appliedIndex:27265; }","duration":"120.529421ms","start":"2026-05-11T11:40:16.711808Z","end":"2026-05-11T11:40:16.832337Z","steps":["trace[295021432] 'read index received' (duration: 120.312857ms)","trace[295021432] 'applied index is now lower than readState.Index' (duration: 215.074µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:16.83243Z","caller":"traceutil/trace.go:171","msg":"trace[1639995628] transaction","detail":"{read_only:false; response_revision:26396; number_of_response:1; }","duration":"226.127153ms","start":"2026-05-11T11:40:16.606265Z","end":"2026-05-11T11:40:16.832392Z","steps":["trace[1639995628] 'process raft request' (duration: 225.818318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:16.832636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.801316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-11T11:40:16.832673Z","caller":"traceutil/trace.go:171","msg":"trace[997685137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26396; }","duration":"120.904248ms","start":"2026-05-11T11:40:16.711761Z","end":"2026-05-11T11:40:16.832665Z","steps":["trace[997685137] 'agreement among raft nodes before linearized reading' (duration: 120.699845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:16.834965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.28936ms","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:8"} {"level":"info","ts":"2026-05-11T11:40:16.835083Z","caller":"traceutil/trace.go:171","msg":"trace[1488899465] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:26397; }","duration":"118.447013ms","start":"2026-05-11T11:40:16.716606Z","end":"2026-05-11T11:40:16.835053Z","steps":["trace[1488899465] 'agreement among raft nodes before linearized reading' (duration: 118.229269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:16.835327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.705587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-05-11T11:40:16.83542Z","caller":"traceutil/trace.go:171","msg":"trace[1737635826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26397; }","duration":"111.831769ms","start":"2026-05-11T11:40:16.723566Z","end":"2026-05-11T11:40:16.835398Z","steps":["trace[1737635826] 'agreement among raft nodes before linearized reading' (duration: 111.528143ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:18.221554Z","caller":"traceutil/trace.go:171","msg":"trace[2054136654] transaction","detail":"{read_only:false; response_revision:26413; number_of_response:1; }","duration":"133.131568ms","start":"2026-05-11T11:40:18.088391Z","end":"2026-05-11T11:40:18.221523Z","steps":["trace[2054136654] 'process raft request' (duration: 132.793781ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:18.31635Z","caller":"traceutil/trace.go:171","msg":"trace[490922551] transaction","detail":"{read_only:false; response_revision:26414; number_of_response:1; }","duration":"154.343046ms","start":"2026-05-11T11:40:18.161968Z","end":"2026-05-11T11:40:18.316311Z","steps":["trace[490922551] 'process raft request' (duration: 130.464379ms)","trace[490922551] 'compare' (duration: 23.473179ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:18.841831Z","caller":"traceutil/trace.go:171","msg":"trace[561107166] transaction","detail":"{read_only:false; response_revision:26417; number_of_response:1; }","duration":"151.39286ms","start":"2026-05-11T11:40:18.690396Z","end":"2026-05-11T11:40:18.841789Z","steps":["trace[561107166] 'process raft request' (duration: 124.678609ms)","trace[561107166] 'compare' (duration: 26.617079ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T11:40:43.180676Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006b7a.wal"} {"level":"warn","ts":"2026-05-11T11:40:43.986826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.618408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3566"} {"level":"info","ts":"2026-05-11T11:40:43.986939Z","caller":"traceutil/trace.go:171","msg":"trace[1529220468] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:26729; }","duration":"140.792731ms","start":"2026-05-11T11:40:43.846122Z","end":"2026-05-11T11:40:43.986915Z","steps":["trace[1529220468] 'range keys from in-memory index tree' (duration: 140.414404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:47.284609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.102732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinedeployments/\" range_end:\"/registry/cluster.x-k8s.io/machinedeployments0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-05-11T11:40:47.28473Z","caller":"traceutil/trace.go:171","msg":"trace[261949483] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinedeployments/; range_end:/registry/cluster.x-k8s.io/machinedeployments0; response_count:0; response_revision:26784; }","duration":"226.253405ms","start":"2026-05-11T11:40:47.058453Z","end":"2026-05-11T11:40:47.284706Z","steps":["trace[261949483] 'count revisions from in-memory index tree' (duration: 225.95177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:47.284804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.050988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-11T11:40:47.284928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.794395ms","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-11T11:40:47.284979Z","caller":"traceutil/trace.go:171","msg":"trace[1387753419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26784; }","duration":"228.311294ms","start":"2026-05-11T11:40:47.056641Z","end":"2026-05-11T11:40:47.284952Z","steps":["trace[1387753419] 'range keys from in-memory index tree' (duration: 227.882985ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:47.285041Z","caller":"traceutil/trace.go:171","msg":"trace[1231498832] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26784; }","duration":"227.953487ms","start":"2026-05-11T11:40:47.057062Z","end":"2026-05-11T11:40:47.285015Z","steps":["trace[1231498832] 'range keys from in-memory index tree' (duration: 227.59752ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:47.711821Z","caller":"traceutil/trace.go:171","msg":"trace[1544102622] transaction","detail":"{read_only:false; response_revision:26787; number_of_response:1; }","duration":"421.725333ms","start":"2026-05-11T11:40:47.290054Z","end":"2026-05-11T11:40:47.711779Z","steps":["trace[1544102622] 'process raft request' (duration: 421.645951ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T11:40:47.711984Z","caller":"traceutil/trace.go:171","msg":"trace[25350514] transaction","detail":"{read_only:false; response_revision:26786; number_of_response:1; }","duration":"422.021539ms","start":"2026-05-11T11:40:47.289901Z","end":"2026-05-11T11:40:47.711922Z","steps":["trace[25350514] 'process raft request' (duration: 421.58141ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T11:40:47.712119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:40:47.290026Z","time spent":"421.903586ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T11:40:47.712269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:40:47.289861Z","time spent":"422.260333ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:40:47.807528Z","caller":"traceutil/trace.go:171","msg":"trace[643281007] transaction","detail":"{read_only:false; response_revision:26788; number_of_response:1; }","duration":"434.357809ms","start":"2026-05-11T11:40:47.373133Z","end":"2026-05-11T11:40:47.807491Z","steps":["trace[643281007] 'process raft request' (duration: 400.645546ms)","trace[643281007] 'compare' (duration: 33.520139ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T11:40:47.807676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T11:40:47.373102Z","time spent":"434.496592ms","remote":"127.0.0.1:43220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T11:42:57.721112Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25076} {"level":"info","ts":"2026-05-11T11:42:57.862908Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25076,"took":"137.271596ms","hash":4288884294,"current-db-size-bytes":60907520,"current-db-size":"61 MB","current-db-size-in-use-bytes":37056512,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-05-11T11:42:57.863027Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4288884294,"revision":25076,"compact-revision":21898} {"level":"info","ts":"2026-05-11T11:44:51.019073Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-11T11:44:51.02425Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-05-11T11:44:51.024348Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-05-11T11:47:57.728488Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27965} {"level":"info","ts":"2026-05-11T11:47:57.866185Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27965,"took":"132.919537ms","hash":1544040882,"current-db-size-bytes":60907520,"current-db-size":"61 MB","current-db-size-in-use-bytes":32669696,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-05-11T11:47:57.866266Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1544040882,"revision":27965,"compact-revision":25076} {"level":"info","ts":"2026-05-11T11:52:57.734819Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30474} {"level":"info","ts":"2026-05-11T11:52:57.867438Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30474,"took":"127.835937ms","hash":2923309851,"current-db-size-bytes":60907520,"current-db-size":"61 MB","current-db-size-in-use-bytes":30146560,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-11T11:52:57.867524Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2923309851,"revision":30474,"compact-revision":27965} {"level":"info","ts":"2026-05-11T11:57:57.741385Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32727} {"level":"info","ts":"2026-05-11T11:57:57.88687Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32727,"took":"141.156257ms","hash":3322383040,"current-db-size-bytes":60907520,"current-db-size":"61 MB","current-db-size-in-use-bytes":29999104,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-05-11T11:57:57.88695Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3322383040,"revision":32727,"compact-revision":30474} {"level":"info","ts":"2026-05-11T12:02:57.747351Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34992} {"level":"info","ts":"2026-05-11T12:02:57.875588Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34992,"took":"123.23773ms","hash":1902574603,"current-db-size-bytes":60907520,"current-db-size":"61 MB","current-db-size-in-use-bytes":32649216,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-05-11T12:02:57.875671Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1902574603,"revision":34992,"compact-revision":32727} {"level":"info","ts":"2026-05-11T12:05:58.783856Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"ab97322ebdd79664","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-11T12:05:58.792692Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-05-11T12:05:58.79296Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-05-11T12:07:57.75493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37353} {"level":"info","ts":"2026-05-11T12:07:57.87495Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37353,"took":"115.732699ms","hash":2126952063,"current-db-size-bytes":62603264,"current-db-size":"63 MB","current-db-size-in-use-bytes":31916032,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-05-11T12:07:57.875009Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2126952063,"revision":37353,"compact-revision":34992}