{"level":"warn","ts":"2026-10-15T19:01:28.771288Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T19:01:28.771373Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.118: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://162.253.55.118:2380","--initial-cluster=instance=https://162.253.55.118:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.118:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.118: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-10-15T19:01:28.771462Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-15T19:01:28.77149Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.118:2380"]} {"level":"info","ts":"2026-10-15T19:01:28.771514Z","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-10-15T19:01:28.772257Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"]} {"level":"info","ts":"2026-10-15T19:01:28.772355Z","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://162.253.55.118:2380"],"listen-peer-urls":["https://162.253.55.118:2380"],"advertise-client-urls":["https://162.253.55.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.118: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-10-15T19:01:28.775292Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.691782ms"} {"level":"info","ts":"2026-10-15T19:01:28.78427Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39c975536cfc1086","cluster-id":"ac0a95643fc422f0"} {"level":"info","ts":"2026-10-15T19:01:28.784382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=()"} {"level":"info","ts":"2026-10-15T19:01:28.784421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became follower at term 0"} {"level":"info","ts":"2026-10-15T19:01:28.784443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39c975536cfc1086 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-15T19:01:28.784463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became follower at term 1"} {"level":"info","ts":"2026-10-15T19:01:28.784549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=(4163988331651928198)"} {"level":"warn","ts":"2026-10-15T19:01:28.790746Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-15T19:01:28.793824Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-15T19:01:28.795405Z","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-10-15T19:01:28.797782Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39c975536cfc1086","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-15T19:01:28.797996Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39c975536cfc1086","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-15T19:01:28.798092Z","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-10-15T19:01:28.798256Z","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-10-15T19:01:28.798305Z","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-10-15T19:01:28.798915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 switched to configuration voters=(4163988331651928198)"} {"level":"info","ts":"2026-10-15T19:01:28.799028Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ac0a95643fc422f0","local-member-id":"39c975536cfc1086","added-peer-id":"39c975536cfc1086","added-peer-peer-urls":["https://162.253.55.118:2380"]} {"level":"info","ts":"2026-10-15T19:01:28.800527Z","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-10-15T19:01:28.800698Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39c975536cfc1086","initial-advertise-peer-urls":["https://162.253.55.118:2380"],"listen-peer-urls":["https://162.253.55.118:2380"],"advertise-client-urls":["https://162.253.55.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-15T19:01:28.800726Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-15T19:01:28.800826Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.118:2380"} {"level":"info","ts":"2026-10-15T19:01:28.800836Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.118:2380"} {"level":"info","ts":"2026-10-15T19:01:29.08582Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 is starting a new election at term 1"} {"level":"info","ts":"2026-10-15T19:01:29.085907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became pre-candidate at term 1"} {"level":"info","ts":"2026-10-15T19:01:29.085949Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 received MsgPreVoteResp from 39c975536cfc1086 at term 1"} {"level":"info","ts":"2026-10-15T19:01:29.085974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became candidate at term 2"} {"level":"info","ts":"2026-10-15T19:01:29.085988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 received MsgVoteResp from 39c975536cfc1086 at term 2"} {"level":"info","ts":"2026-10-15T19:01:29.08601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39c975536cfc1086 became leader at term 2"} {"level":"info","ts":"2026-10-15T19:01:29.086033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39c975536cfc1086 elected leader 39c975536cfc1086 at term 2"} {"level":"info","ts":"2026-10-15T19:01:29.087199Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:01:29.088308Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39c975536cfc1086","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.118:2379]}","request-path":"/0/members/39c975536cfc1086/attributes","cluster-id":"ac0a95643fc422f0","publish-timeout":"7s"} {"level":"info","ts":"2026-10-15T19:01:29.088545Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T19:01:29.088707Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-15T19:01:29.088945Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ac0a95643fc422f0","local-member-id":"39c975536cfc1086","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:01:29.089134Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:01:29.089181Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-15T19:01:29.093027Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.118:2379"} {"level":"info","ts":"2026-10-15T19:01:29.093185Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-15T19:01:29.093237Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-15T19:01:29.096126Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-15T19:02:20.08197Z","caller":"traceutil/trace.go:171","msg":"trace[16649916] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"209.729725ms","start":"2026-10-15T19:02:19.872217Z","end":"2026-10-15T19:02:20.081947Z","steps":["trace[16649916] 'process raft request' (duration: 209.582381ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:02:20.370653Z","caller":"traceutil/trace.go:171","msg":"trace[1408389649] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"129.777126ms","start":"2026-10-15T19:02:20.240847Z","end":"2026-10-15T19:02:20.370624Z","steps":["trace[1408389649] 'process raft request' (duration: 129.727004ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:02:20.370697Z","caller":"traceutil/trace.go:171","msg":"trace[1234314695] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"161.931464ms","start":"2026-10-15T19:02:20.208714Z","end":"2026-10-15T19:02:20.370645Z","steps":["trace[1234314695] 'process raft request' (duration: 104.920544ms)","trace[1234314695] 'compare' (duration: 56.766044ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:02:20.370898Z","caller":"traceutil/trace.go:171","msg":"trace[1540503383] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"156.330793ms","start":"2026-10-15T19:02:20.214547Z","end":"2026-10-15T19:02:20.370878Z","steps":["trace[1540503383] 'read index received' (duration: 99.25133ms)","trace[1540503383] 'applied index is now lower than readState.Index' (duration: 57.078143ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:02:20.371138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.57373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-15T19:02:20.371248Z","caller":"traceutil/trace.go:171","msg":"trace[456689924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"156.722594ms","start":"2026-10-15T19:02:20.214504Z","end":"2026-10-15T19:02:20.371227Z","steps":["trace[456689924] 'agreement among raft nodes before linearized reading' (duration: 156.447407ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:02:20.683709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.726293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:02:20.683781Z","caller":"traceutil/trace.go:171","msg":"trace[294787034] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:655; }","duration":"193.871178ms","start":"2026-10-15T19:02:20.489892Z","end":"2026-10-15T19:02:20.683764Z","steps":["trace[294787034] 'range keys from in-memory index tree' (duration: 193.60748ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:02:37.113485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.686928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dltck\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-10-15T19:02:37.113588Z","caller":"traceutil/trace.go:171","msg":"trace[654519231] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dltck; range_end:; response_count:1; response_revision:823; }","duration":"151.836612ms","start":"2026-10-15T19:02:36.961729Z","end":"2026-10-15T19:02:37.113566Z","steps":["trace[654519231] 'range keys from in-memory index tree' (duration: 151.525393ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:03:22.369201Z","caller":"traceutil/trace.go:171","msg":"trace[1469330585] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"187.69674ms","start":"2026-10-15T19:03:22.181477Z","end":"2026-10-15T19:03:22.369174Z","steps":["trace[1469330585] 'process raft request' (duration: 187.520015ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:03:54.62715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.454936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-15T19:03:54.627252Z","caller":"traceutil/trace.go:171","msg":"trace[2024795180] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1885; }","duration":"222.61274ms","start":"2026-10-15T19:03:54.404619Z","end":"2026-10-15T19:03:54.627231Z","steps":["trace[2024795180] 'range keys from in-memory index tree' (duration: 222.23184ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:03:55.07818Z","caller":"traceutil/trace.go:171","msg":"trace[206428470] transaction","detail":"{read_only:false; response_revision:1889; number_of_response:1; }","duration":"181.592556ms","start":"2026-10-15T19:03:54.896542Z","end":"2026-10-15T19:03:55.078134Z","steps":["trace[206428470] 'process raft request' (duration: 141.564416ms)","trace[206428470] 'compare' (duration: 39.723291ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:03:55.078206Z","caller":"traceutil/trace.go:171","msg":"trace[1869624943] linearizableReadLoop","detail":"{readStateIndex:1962; appliedIndex:1960; }","duration":"170.984269ms","start":"2026-10-15T19:03:54.907184Z","end":"2026-10-15T19:03:55.078168Z","steps":["trace[1869624943] 'read index received' (duration: 131.023172ms)","trace[1869624943] 'applied index is now lower than readState.Index' (duration: 39.959467ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:03:55.078429Z","caller":"traceutil/trace.go:171","msg":"trace[2067572648] transaction","detail":"{read_only:false; response_revision:1890; number_of_response:1; }","duration":"180.801224ms","start":"2026-10-15T19:03:54.897602Z","end":"2026-10-15T19:03:55.078403Z","steps":["trace[2067572648] 'process raft request' (duration: 180.458425ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:03:55.078441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.227456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:03:55.078482Z","caller":"traceutil/trace.go:171","msg":"trace[825454826] transaction","detail":"{read_only:false; response_revision:1891; number_of_response:1; }","duration":"112.807461ms","start":"2026-10-15T19:03:54.96566Z","end":"2026-10-15T19:03:55.078467Z","steps":["trace[825454826] 'process raft request' (duration: 112.453081ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:03:55.078523Z","caller":"traceutil/trace.go:171","msg":"trace[1443570006] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1891; }","duration":"171.342729ms","start":"2026-10-15T19:03:54.907159Z","end":"2026-10-15T19:03:55.078502Z","steps":["trace[1443570006] 'agreement among raft nodes before linearized reading' (duration: 171.189204ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:03:55.078627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.287289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-10-15T19:03:55.078675Z","caller":"traceutil/trace.go:171","msg":"trace[972244222] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1891; }","duration":"141.427393ms","start":"2026-10-15T19:03:54.937232Z","end":"2026-10-15T19:03:55.07866Z","steps":["trace[972244222] 'agreement among raft nodes before linearized reading' (duration: 141.127065ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:04:39.43958Z","caller":"traceutil/trace.go:171","msg":"trace[1597053711] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"111.041567ms","start":"2026-10-15T19:04:39.328502Z","end":"2026-10-15T19:04:39.439543Z","steps":["trace[1597053711] 'process raft request' (duration: 47.677757ms)","trace[1597053711] 'compare' (duration: 63.150794ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:04:44.983933Z","caller":"traceutil/trace.go:171","msg":"trace[1705555036] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"174.961263ms","start":"2026-10-15T19:04:44.808942Z","end":"2026-10-15T19:04:44.983903Z","steps":["trace[1705555036] 'process raft request' (duration: 174.754407ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:04:45.121781Z","caller":"traceutil/trace.go:171","msg":"trace[1083242318] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"132.177628ms","start":"2026-10-15T19:04:44.989571Z","end":"2026-10-15T19:04:45.121749Z","steps":["trace[1083242318] 'process raft request' (duration: 96.762432ms)","trace[1083242318] 'compare' (duration: 35.209791ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:05:35.39949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.200017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-15T19:05:35.399597Z","caller":"traceutil/trace.go:171","msg":"trace[736685209] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2660; }","duration":"187.352951ms","start":"2026-10-15T19:05:35.212223Z","end":"2026-10-15T19:05:35.399576Z","steps":["trace[736685209] 'range keys from in-memory index tree' (duration: 186.998902ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:08.798635Z","caller":"traceutil/trace.go:171","msg":"trace[2099578172] transaction","detail":"{read_only:false; response_revision:2863; number_of_response:1; }","duration":"214.568497ms","start":"2026-10-15T19:06:08.584038Z","end":"2026-10-15T19:06:08.798607Z","steps":["trace[2099578172] 'process raft request' (duration: 214.31971ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:06:08.848559Z","caller":"traceutil/trace.go:171","msg":"trace[1011466076] transaction","detail":"{read_only:false; response_revision:2864; number_of_response:1; }","duration":"247.412034ms","start":"2026-10-15T19:06:08.60111Z","end":"2026-10-15T19:06:08.848522Z","steps":["trace[1011466076] 'process raft request' (duration: 228.543895ms)","trace[1011466076] 'compare' (duration: 18.714065ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:06:14.11122Z","caller":"traceutil/trace.go:171","msg":"trace[691298723] linearizableReadLoop","detail":"{readStateIndex:3004; appliedIndex:3003; }","duration":"110.826784ms","start":"2026-10-15T19:06:14.000366Z","end":"2026-10-15T19:06:14.111193Z","steps":["trace[691298723] 'read index received' (duration: 40.909865ms)","trace[691298723] 'applied index is now lower than readState.Index' (duration: 69.915979ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:06:14.111289Z","caller":"traceutil/trace.go:171","msg":"trace[1716605129] transaction","detail":"{read_only:false; response_revision:2895; number_of_response:1; }","duration":"141.835331ms","start":"2026-10-15T19:06:13.96941Z","end":"2026-10-15T19:06:14.111245Z","steps":["trace[1716605129] 'process raft request' (duration: 71.993674ms)","trace[1716605129] 'compare' (duration: 69.506908ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:06:14.111532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.151133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-10-15T19:06:14.111578Z","caller":"traceutil/trace.go:171","msg":"trace[130231098] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:2895; }","duration":"111.280066ms","start":"2026-10-15T19:06:14.000286Z","end":"2026-10-15T19:06:14.111566Z","steps":["trace[130231098] 'agreement among raft nodes before linearized reading' (duration: 111.026779ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:09:10.497568Z","caller":"traceutil/trace.go:171","msg":"trace[1265160586] transaction","detail":"{read_only:false; response_revision:4024; number_of_response:1; }","duration":"127.479142ms","start":"2026-10-15T19:09:10.370065Z","end":"2026-10-15T19:09:10.497544Z","steps":["trace[1265160586] 'process raft request' (duration: 126.894386ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:42.656604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.293951ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:10:42.656716Z","caller":"traceutil/trace.go:171","msg":"trace[158358202] linearizableReadLoop","detail":"{readStateIndex:5427; appliedIndex:5426; }","duration":"256.394401ms","start":"2026-10-15T19:10:42.400307Z","end":"2026-10-15T19:10:42.656701Z","steps":["trace[158358202] 'read index received' (duration: 13.439233ms)","trace[158358202] 'applied index is now lower than readState.Index' (duration: 242.953988ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:10:42.656741Z","caller":"traceutil/trace.go:171","msg":"trace[233999904] transaction","detail":"{read_only:false; response_revision:5232; number_of_response:1; }","duration":"289.556947ms","start":"2026-10-15T19:10:42.367155Z","end":"2026-10-15T19:10:42.656712Z","steps":["trace[233999904] 'process raft request' (duration: 46.579229ms)","trace[233999904] 'compare' (duration: 242.160976ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:10:42.657003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.696979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-66b2d722-34da-4934-b182-f378b9a0f239\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-10-15T19:10:42.657147Z","caller":"traceutil/trace.go:171","msg":"trace[535017228] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-66b2d722-34da-4934-b182-f378b9a0f239; range_end:; response_count:1; response_revision:5232; }","duration":"256.865394ms","start":"2026-10-15T19:10:42.400233Z","end":"2026-10-15T19:10:42.657098Z","steps":["trace[535017228] 'agreement among raft nodes before linearized reading' (duration: 256.589726ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:42.657668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.663209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-15T19:10:42.657666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.021373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:10:42.657721Z","caller":"traceutil/trace.go:171","msg":"trace[840411652] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:0; response_revision:5232; }","duration":"246.73987ms","start":"2026-10-15T19:10:42.410969Z","end":"2026-10-15T19:10:42.657709Z","steps":["trace[840411652] 'agreement among raft nodes before linearized reading' (duration: 246.629187ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:42.657731Z","caller":"traceutil/trace.go:171","msg":"trace[586769342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5232; }","duration":"168.123525ms","start":"2026-10-15T19:10:42.489594Z","end":"2026-10-15T19:10:42.657717Z","steps":["trace[586769342] 'agreement among raft nodes before linearized reading' (duration: 168.031523ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:42.657812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.12568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-66b2d722-34da-4934-b182-f378b9a0f239\" ","response":"range_response_count:1 size:3601"} {"level":"warn","ts":"2026-10-15T19:10:42.657821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.780723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-2b25w-tls\" ","response":"range_response_count:1 size:2184"} {"level":"info","ts":"2026-10-15T19:10:42.657878Z","caller":"traceutil/trace.go:171","msg":"trace[780705717] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-66b2d722-34da-4934-b182-f378b9a0f239; range_end:; response_count:1; response_revision:5232; }","duration":"210.237693ms","start":"2026-10-15T19:10:42.447626Z","end":"2026-10-15T19:10:42.657864Z","steps":["trace[780705717] 'agreement among raft nodes before linearized reading' (duration: 210.042058ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:42.657896Z","caller":"traceutil/trace.go:171","msg":"trace[1558170839] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-2b25w-tls; range_end:; response_count:1; response_revision:5232; }","duration":"168.915437ms","start":"2026-10-15T19:10:42.488963Z","end":"2026-10-15T19:10:42.657878Z","steps":["trace[1558170839] 'agreement among raft nodes before linearized reading' (duration: 168.67343ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:43.002912Z","caller":"traceutil/trace.go:171","msg":"trace[1647430545] linearizableReadLoop","detail":"{readStateIndex:5434; appliedIndex:5433; }","duration":"117.786154ms","start":"2026-10-15T19:10:42.885102Z","end":"2026-10-15T19:10:43.002888Z","steps":["trace[1647430545] 'read index received' (duration: 97.582818ms)","trace[1647430545] 'applied index is now lower than readState.Index' (duration: 20.202306ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:10:43.003208Z","caller":"traceutil/trace.go:171","msg":"trace[1013993320] transaction","detail":"{read_only:false; response_revision:5237; number_of_response:1; }","duration":"118.824252ms","start":"2026-10-15T19:10:42.884347Z","end":"2026-10-15T19:10:43.003171Z","steps":["trace[1013993320] 'process raft request' (duration: 98.351028ms)","trace[1013993320] 'compare' (duration: 20.091444ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:10:43.003266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.139334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18116"} {"level":"info","ts":"2026-10-15T19:10:43.003346Z","caller":"traceutil/trace.go:171","msg":"trace[1271157135] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5237; }","duration":"118.242346ms","start":"2026-10-15T19:10:42.885057Z","end":"2026-10-15T19:10:43.0033Z","steps":["trace[1271157135] 'agreement among raft nodes before linearized reading' (duration: 117.916398ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:51.746331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.275777ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:10:51.746461Z","caller":"traceutil/trace.go:171","msg":"trace[1662742210] transaction","detail":"{read_only:false; response_revision:5422; number_of_response:1; }","duration":"127.414755ms","start":"2026-10-15T19:10:51.619019Z","end":"2026-10-15T19:10:51.746433Z","steps":["trace[1662742210] 'process raft request' (duration: 18.86333ms)","trace[1662742210] 'compare' (duration: 107.934108ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:10:52.037559Z","caller":"traceutil/trace.go:171","msg":"trace[662462014] linearizableReadLoop","detail":"{readStateIndex:5625; appliedIndex:5624; }","duration":"251.001085ms","start":"2026-10-15T19:10:51.78653Z","end":"2026-10-15T19:10:52.037532Z","steps":["trace[662462014] 'read index received' (duration: 235.27255ms)","trace[662462014] 'applied index is now lower than readState.Index' (duration: 15.727455ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:10:52.037594Z","caller":"traceutil/trace.go:171","msg":"trace[263092063] transaction","detail":"{read_only:false; response_revision:5423; number_of_response:1; }","duration":"264.86202ms","start":"2026-10-15T19:10:51.772696Z","end":"2026-10-15T19:10:52.037558Z","steps":["trace[263092063] 'process raft request' (duration: 248.95031ms)","trace[263092063] 'compare' (duration: 15.770136ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:10:52.037857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.293923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-10-15T19:10:52.037947Z","caller":"traceutil/trace.go:171","msg":"trace[1173991982] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5423; }","duration":"251.437927ms","start":"2026-10-15T19:10:51.786487Z","end":"2026-10-15T19:10:52.037925Z","steps":["trace[1173991982] 'agreement among raft nodes before linearized reading' (duration: 251.139899ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:52.052026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.953031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:10:52.052107Z","caller":"traceutil/trace.go:171","msg":"trace[208640179] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:5424; }","duration":"235.087596ms","start":"2026-10-15T19:10:51.817Z","end":"2026-10-15T19:10:52.052087Z","steps":["trace[208640179] 'agreement among raft nodes before linearized reading' (duration: 234.943132ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:52.052585Z","caller":"traceutil/trace.go:171","msg":"trace[1867742423] transaction","detail":"{read_only:false; response_revision:5424; number_of_response:1; }","duration":"263.257007ms","start":"2026-10-15T19:10:51.789317Z","end":"2026-10-15T19:10:52.052574Z","steps":["trace[1867742423] 'process raft request' (duration: 262.490596ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:52.052738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.040349ms","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-10-15T19:10:52.052913Z","caller":"traceutil/trace.go:171","msg":"trace[755836210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5424; }","duration":"186.256625ms","start":"2026-10-15T19:10:51.866586Z","end":"2026-10-15T19:10:52.052843Z","steps":["trace[755836210] 'agreement among raft nodes before linearized reading' (duration: 185.815993ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:10:52.440395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.818615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-10-15T19:10:52.440491Z","caller":"traceutil/trace.go:171","msg":"trace[1415174597] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5426; }","duration":"134.977929ms","start":"2026-10-15T19:10:52.30549Z","end":"2026-10-15T19:10:52.440468Z","steps":["trace[1415174597] 'range keys from in-memory index tree' (duration: 134.608889ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:10:56.94316Z","caller":"traceutil/trace.go:171","msg":"trace[1935981079] transaction","detail":"{read_only:false; response_revision:5498; number_of_response:1; }","duration":"100.782184ms","start":"2026-10-15T19:10:56.842331Z","end":"2026-10-15T19:10:56.943114Z","steps":["trace[1935981079] 'process raft request' (duration: 24.609165ms)","trace[1935981079] 'compare' (duration: 76.038205ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:11:05.00796Z","caller":"traceutil/trace.go:171","msg":"trace[1971528623] transaction","detail":"{read_only:false; response_revision:5664; number_of_response:1; }","duration":"148.72524ms","start":"2026-10-15T19:11:04.859205Z","end":"2026-10-15T19:11:05.00793Z","steps":["trace[1971528623] 'process raft request' (duration: 88.240255ms)","trace[1971528623] 'compare' (duration: 60.021013ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:11:05.00809Z","caller":"traceutil/trace.go:171","msg":"trace[1680318618] transaction","detail":"{read_only:false; response_revision:5665; number_of_response:1; }","duration":"141.626209ms","start":"2026-10-15T19:11:04.866433Z","end":"2026-10-15T19:11:05.008059Z","steps":["trace[1680318618] 'process raft request' (duration: 141.189377ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:11:05.008285Z","caller":"traceutil/trace.go:171","msg":"trace[898891362] linearizableReadLoop","detail":"{readStateIndex:5871; appliedIndex:5870; }","duration":"147.549478ms","start":"2026-10-15T19:11:04.860681Z","end":"2026-10-15T19:11:05.008231Z","steps":["trace[898891362] 'read index received' (duration: 86.790496ms)","trace[898891362] 'applied index is now lower than readState.Index' (duration: 60.749482ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:11:05.008668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.94312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-10-15T19:11:05.009067Z","caller":"traceutil/trace.go:171","msg":"trace[1157751317] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5666; }","duration":"148.355551ms","start":"2026-10-15T19:11:04.860672Z","end":"2026-10-15T19:11:05.009028Z","steps":["trace[1157751317] 'agreement among raft nodes before linearized reading' (duration: 147.786696ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:11:05.008744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.758868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-92vx9\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-10-15T19:11:05.009255Z","caller":"traceutil/trace.go:171","msg":"trace[35994601] range","detail":"{range_begin:/registry/pods/openstack/keepalived-92vx9; range_end:; response_count:1; response_revision:5666; }","duration":"133.322624ms","start":"2026-10-15T19:11:04.875913Z","end":"2026-10-15T19:11:05.009236Z","steps":["trace[35994601] 'agreement among raft nodes before linearized reading' (duration: 132.628345ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:11:05.008829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.622365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a65d63ee-f22c-4035-87f2-a407d14d0711\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-10-15T19:11:05.009336Z","caller":"traceutil/trace.go:171","msg":"trace[81300430] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a65d63ee-f22c-4035-87f2-a407d14d0711; range_end:; response_count:1; response_revision:5666; }","duration":"140.189369ms","start":"2026-10-15T19:11:04.86911Z","end":"2026-10-15T19:11:05.0093Z","steps":["trace[81300430] 'agreement among raft nodes before linearized reading' (duration: 139.420449ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:11:05.384449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.200883ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:11:05.384605Z","caller":"traceutil/trace.go:171","msg":"trace[1258705842] transaction","detail":"{read_only:false; response_revision:5667; number_of_response:1; }","duration":"357.720391ms","start":"2026-10-15T19:11:05.026855Z","end":"2026-10-15T19:11:05.384575Z","steps":["trace[1258705842] 'process raft request' (duration: 181.292271ms)","trace[1258705842] 'compare' (duration: 175.891385ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:11:05.384594Z","caller":"traceutil/trace.go:171","msg":"trace[1440477456] linearizableReadLoop","detail":"{readStateIndex:5874; appliedIndex:5873; }","duration":"356.805906ms","start":"2026-10-15T19:11:05.027764Z","end":"2026-10-15T19:11:05.38457Z","steps":["trace[1440477456] 'read index received' (duration: 180.307394ms)","trace[1440477456] 'applied index is now lower than readState.Index' (duration: 176.496812ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:11:05.384878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.096504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"warn","ts":"2026-10-15T19:11:05.384877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:11:05.026842Z","time spent":"357.823543ms","remote":"127.0.0.1:40718","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-15T19:11:05.385062Z","caller":"traceutil/trace.go:171","msg":"trace[2091694448] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5667; }","duration":"357.186556ms","start":"2026-10-15T19:11:05.027738Z","end":"2026-10-15T19:11:05.384925Z","steps":["trace[2091694448] 'agreement among raft nodes before linearized reading' (duration: 356.920619ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:11:05.38511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:11:05.027728Z","time spent":"357.369391ms","remote":"127.0.0.1:38788","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1366,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"warn","ts":"2026-10-15T19:11:05.385177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.234965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-10-15T19:11:05.385271Z","caller":"traceutil/trace.go:171","msg":"trace[1529172186] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5667; }","duration":"132.369849ms","start":"2026-10-15T19:11:05.252881Z","end":"2026-10-15T19:11:05.385251Z","steps":["trace[1529172186] 'agreement among raft nodes before linearized reading' (duration: 132.03288ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:11:05.38595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.343458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2225408"} {"level":"info","ts":"2026-10-15T19:11:05.386047Z","caller":"traceutil/trace.go:171","msg":"trace[2145236813] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:5667; }","duration":"196.479992ms","start":"2026-10-15T19:11:05.189549Z","end":"2026-10-15T19:11:05.386029Z","steps":["trace[2145236813] 'agreement among raft nodes before linearized reading' (duration: 195.329971ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:11:05.386549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.742284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-10-15T19:11:05.386721Z","caller":"traceutil/trace.go:171","msg":"trace[1654298010] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5667; }","duration":"174.976261ms","start":"2026-10-15T19:11:05.211711Z","end":"2026-10-15T19:11:05.386688Z","steps":["trace[1654298010] 'agreement among raft nodes before linearized reading' (duration: 173.248824ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:11:15.898946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.15727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"warn","ts":"2026-10-15T19:11:15.898983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.533665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-10-15T19:11:15.899027Z","caller":"traceutil/trace.go:171","msg":"trace[704173195] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5817; }","duration":"116.294724ms","start":"2026-10-15T19:11:15.782715Z","end":"2026-10-15T19:11:15.899009Z","steps":["trace[704173195] 'range keys from in-memory index tree' (duration: 115.932794ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:11:15.899063Z","caller":"traceutil/trace.go:171","msg":"trace[1945013758] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5817; }","duration":"108.648438ms","start":"2026-10-15T19:11:15.790387Z","end":"2026-10-15T19:11:15.899036Z","steps":["trace[1945013758] 'range keys from in-memory index tree' (duration: 108.374141ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:11:29.358903Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2977} {"level":"info","ts":"2026-10-15T19:11:29.443853Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2977,"took":"82.756887ms","hash":2133326175,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":32727040,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T19:11:29.443994Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2133326175,"revision":2977,"compact-revision":-1} {"level":"info","ts":"2026-10-15T19:16:29.366233Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5912} {"level":"info","ts":"2026-10-15T19:16:29.458659Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5912,"took":"90.371009ms","hash":1093038154,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":26472448,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-10-15T19:16:29.458731Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1093038154,"revision":5912,"compact-revision":2977} {"level":"info","ts":"2026-10-15T19:17:12.987436Z","caller":"traceutil/trace.go:171","msg":"trace[1121260399] linearizableReadLoop","detail":"{readStateIndex:8801; appliedIndex:8800; }","duration":"222.603092ms","start":"2026-10-15T19:17:12.764802Z","end":"2026-10-15T19:17:12.987405Z","steps":["trace[1121260399] 'read index received' (duration: 222.398376ms)","trace[1121260399] 'applied index is now lower than readState.Index' (duration: 203.076µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:17:12.987688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.87175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-15T19:17:12.987733Z","caller":"traceutil/trace.go:171","msg":"trace[870339032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8504; }","duration":"222.978213ms","start":"2026-10-15T19:17:12.764745Z","end":"2026-10-15T19:17:12.987723Z","steps":["trace[870339032] 'agreement among raft nodes before linearized reading' (duration: 222.788157ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:17:13.139677Z","caller":"traceutil/trace.go:171","msg":"trace[1937080095] transaction","detail":"{read_only:false; response_revision:8505; number_of_response:1; }","duration":"150.755956ms","start":"2026-10-15T19:17:12.988899Z","end":"2026-10-15T19:17:13.139655Z","steps":["trace[1937080095] 'process raft request' (duration: 131.788412ms)","trace[1937080095] 'compare' (duration: 18.708307ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:17:13.139676Z","caller":"traceutil/trace.go:171","msg":"trace[301799279] transaction","detail":"{read_only:false; response_revision:8506; number_of_response:1; }","duration":"147.644951ms","start":"2026-10-15T19:17:12.992004Z","end":"2026-10-15T19:17:13.139649Z","steps":["trace[301799279] 'process raft request' (duration: 147.553738ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:17:24.400046Z","caller":"traceutil/trace.go:171","msg":"trace[966047189] transaction","detail":"{read_only:false; response_revision:8568; number_of_response:1; }","duration":"234.228637ms","start":"2026-10-15T19:17:24.165792Z","end":"2026-10-15T19:17:24.400021Z","steps":["trace[966047189] 'process raft request' (duration: 234.066023ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:17:24.42606Z","caller":"traceutil/trace.go:171","msg":"trace[1976485406] linearizableReadLoop","detail":"{readStateIndex:8869; appliedIndex:8867; }","duration":"175.986759ms","start":"2026-10-15T19:17:24.250042Z","end":"2026-10-15T19:17:24.426028Z","steps":["trace[1976485406] 'read index received' (duration: 149.855971ms)","trace[1976485406] 'applied index is now lower than readState.Index' (duration: 26.129708ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:17:24.426089Z","caller":"traceutil/trace.go:171","msg":"trace[167037] transaction","detail":"{read_only:false; response_revision:8569; number_of_response:1; }","duration":"257.027515ms","start":"2026-10-15T19:17:24.16904Z","end":"2026-10-15T19:17:24.426067Z","steps":["trace[167037] 'process raft request' (duration: 256.814689ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:17:24.426201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.147374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T19:17:24.426249Z","caller":"traceutil/trace.go:171","msg":"trace[779750946] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:8569; }","duration":"176.251107ms","start":"2026-10-15T19:17:24.249984Z","end":"2026-10-15T19:17:24.426235Z","steps":["trace[779750946] 'agreement among raft nodes before linearized reading' (duration: 176.151064ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:17:25.660651Z","caller":"traceutil/trace.go:171","msg":"trace[715762746] linearizableReadLoop","detail":"{readStateIndex:8873; appliedIndex:8872; }","duration":"128.886113ms","start":"2026-10-15T19:17:25.531736Z","end":"2026-10-15T19:17:25.660623Z","steps":["trace[715762746] 'read index received' (duration: 128.638256ms)","trace[715762746] 'applied index is now lower than readState.Index' (duration: 246.577µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:17:25.660774Z","caller":"traceutil/trace.go:171","msg":"trace[592672278] transaction","detail":"{read_only:false; response_revision:8573; number_of_response:1; }","duration":"176.39133ms","start":"2026-10-15T19:17:25.484347Z","end":"2026-10-15T19:17:25.660738Z","steps":["trace[592672278] 'process raft request' (duration: 176.122472ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:17:25.660866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.101368ms","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-10-15T19:17:25.660904Z","caller":"traceutil/trace.go:171","msg":"trace[1911468521] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8573; }","duration":"129.182541ms","start":"2026-10-15T19:17:25.531712Z","end":"2026-10-15T19:17:25.660895Z","steps":["trace[1911468521] 'agreement among raft nodes before linearized reading' (duration: 129.019577ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:17:42.054407Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000230d.wal"} {"level":"info","ts":"2026-10-15T19:17:54.751714Z","caller":"traceutil/trace.go:171","msg":"trace[1072262382] transaction","detail":"{read_only:false; response_revision:8785; number_of_response:1; }","duration":"172.796862ms","start":"2026-10-15T19:17:54.578891Z","end":"2026-10-15T19:17:54.751687Z","steps":["trace[1072262382] 'process raft request' (duration: 172.674859ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:18:01.560438Z","caller":"traceutil/trace.go:171","msg":"trace[1980386225] transaction","detail":"{read_only:false; response_revision:8820; number_of_response:1; }","duration":"123.204999ms","start":"2026-10-15T19:18:01.437207Z","end":"2026-10-15T19:18:01.560412Z","steps":["trace[1980386225] 'process raft request' (duration: 123.055005ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:18:01.727356Z","caller":"traceutil/trace.go:171","msg":"trace[1009478849] transaction","detail":"{read_only:false; response_revision:8821; number_of_response:1; }","duration":"127.709571ms","start":"2026-10-15T19:18:01.599618Z","end":"2026-10-15T19:18:01.727327Z","steps":["trace[1009478849] 'process raft request' (duration: 96.259029ms)","trace[1009478849] 'compare' (duration: 31.341069ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:18:01.793856Z","caller":"traceutil/trace.go:171","msg":"trace[652082987] transaction","detail":"{read_only:false; response_revision:8822; number_of_response:1; }","duration":"109.053375ms","start":"2026-10-15T19:18:01.684777Z","end":"2026-10-15T19:18:01.793831Z","steps":["trace[652082987] 'process raft request' (duration: 108.907131ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:18:02.055207Z","caller":"traceutil/trace.go:171","msg":"trace[897114826] transaction","detail":"{read_only:false; response_revision:8825; number_of_response:1; }","duration":"189.778413ms","start":"2026-10-15T19:18:01.865403Z","end":"2026-10-15T19:18:02.055181Z","steps":["trace[897114826] 'process raft request' (duration: 107.476432ms)","trace[897114826] 'compare' (duration: 82.128706ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:18:08.822764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.82252ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:18:08.822972Z","caller":"traceutil/trace.go:171","msg":"trace[2079196089] linearizableReadLoop","detail":"{readStateIndex:9210; appliedIndex:9209; }","duration":"149.752949ms","start":"2026-10-15T19:18:08.673194Z","end":"2026-10-15T19:18:08.822947Z","steps":["trace[2079196089] 'read index received' (duration: 6.527737ms)","trace[2079196089] 'applied index is now lower than readState.Index' (duration: 143.222951ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:18:08.823034Z","caller":"traceutil/trace.go:171","msg":"trace[798990032] transaction","detail":"{read_only:false; response_revision:8896; number_of_response:1; }","duration":"151.937037ms","start":"2026-10-15T19:18:08.671042Z","end":"2026-10-15T19:18:08.822979Z","steps":["trace[798990032] 'compare' (duration: 142.495712ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:18:08.823252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.022976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-config-override\" ","response":"range_response_count:1 size:626"} {"level":"warn","ts":"2026-10-15T19:18:08.823257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.034209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-zq6xh\" ","response":"range_response_count:1 size:4638"} {"level":"info","ts":"2026-10-15T19:18:08.823315Z","caller":"traceutil/trace.go:171","msg":"trace[1317352357] range","detail":"{range_begin:/registry/configmaps/openstack/rook-config-override; range_end:; response_count:1; response_revision:8896; }","duration":"150.126498ms","start":"2026-10-15T19:18:08.673172Z","end":"2026-10-15T19:18:08.823298Z","steps":["trace[1317352357] 'agreement among raft nodes before linearized reading' (duration: 149.891012ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:18:08.823354Z","caller":"traceutil/trace.go:171","msg":"trace[197019041] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-zq6xh; range_end:; response_count:1; response_revision:8896; }","duration":"149.157352ms","start":"2026-10-15T19:18:08.674172Z","end":"2026-10-15T19:18:08.823329Z","steps":["trace[197019041] 'agreement among raft nodes before linearized reading' (duration: 148.961187ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:18:08.823362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.855929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-detect-version\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-10-15T19:18:08.823412Z","caller":"traceutil/trace.go:171","msg":"trace[1626174601] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-detect-version; range_end:; response_count:1; response_revision:8896; }","duration":"146.920692ms","start":"2026-10-15T19:18:08.676476Z","end":"2026-10-15T19:18:08.823396Z","steps":["trace[1626174601] 'agreement among raft nodes before linearized reading' (duration: 146.694636ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:18:08.979138Z","caller":"traceutil/trace.go:171","msg":"trace[496749988] transaction","detail":"{read_only:false; response_revision:8897; number_of_response:1; }","duration":"148.125883ms","start":"2026-10-15T19:18:08.830986Z","end":"2026-10-15T19:18:08.979112Z","steps":["trace[496749988] 'process raft request' (duration: 124.085062ms)","trace[496749988] 'compare' (duration: 23.800525ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:18:08.979641Z","caller":"traceutil/trace.go:171","msg":"trace[851643434] transaction","detail":"{read_only:false; number_of_response:1; response_revision:8898; }","duration":"148.531105ms","start":"2026-10-15T19:18:08.831092Z","end":"2026-10-15T19:18:08.979623Z","steps":["trace[851643434] 'process raft request' (duration: 147.95227ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:18:08.979694Z","caller":"traceutil/trace.go:171","msg":"trace[506511524] transaction","detail":"{read_only:false; response_revision:8899; number_of_response:1; }","duration":"146.044607ms","start":"2026-10-15T19:18:08.833612Z","end":"2026-10-15T19:18:08.979657Z","steps":["trace[506511524] 'process raft request' (duration: 145.861822ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:18:09.074464Z","caller":"traceutil/trace.go:171","msg":"trace[769476905] transaction","detail":"{read_only:false; response_revision:8900; number_of_response:1; }","duration":"184.808138ms","start":"2026-10-15T19:18:08.889596Z","end":"2026-10-15T19:18:09.074404Z","steps":["trace[769476905] 'process raft request' (duration: 184.15741ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:18:09.295949Z","caller":"traceutil/trace.go:171","msg":"trace[214262790] transaction","detail":"{read_only:false; response_revision:8902; number_of_response:1; }","duration":"136.986193ms","start":"2026-10-15T19:18:09.1589Z","end":"2026-10-15T19:18:09.295886Z","steps":["trace[214262790] 'process raft request' (duration: 106.599569ms)","trace[214262790] 'compare' (duration: 30.222849ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:18:09.873828Z","caller":"traceutil/trace.go:171","msg":"trace[1817625291] transaction","detail":"{read_only:false; response_revision:8906; number_of_response:1; }","duration":"196.997688ms","start":"2026-10-15T19:18:09.676796Z","end":"2026-10-15T19:18:09.873794Z","steps":["trace[1817625291] 'process raft request' (duration: 141.242477ms)","trace[1817625291] 'compare' (duration: 55.533815ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:18:09.873962Z","caller":"traceutil/trace.go:171","msg":"trace[1369862145] linearizableReadLoop","detail":"{readStateIndex:9221; appliedIndex:9220; }","duration":"177.882571ms","start":"2026-10-15T19:18:09.696007Z","end":"2026-10-15T19:18:09.87389Z","steps":["trace[1369862145] 'read index received' (duration: 121.984906ms)","trace[1369862145] 'applied index is now lower than readState.Index' (duration: 55.891835ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:18:09.874221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.172329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:18:09.874282Z","caller":"traceutil/trace.go:171","msg":"trace[1162011965] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:8907; }","duration":"178.282272ms","start":"2026-10-15T19:18:09.695983Z","end":"2026-10-15T19:18:09.874265Z","steps":["trace[1162011965] 'agreement among raft nodes before linearized reading' (duration: 178.132868ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:18:09.874332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.530158ms","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-10-15T19:18:09.874459Z","caller":"traceutil/trace.go:171","msg":"trace[580294775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8907; }","duration":"116.720023ms","start":"2026-10-15T19:18:09.757714Z","end":"2026-10-15T19:18:09.874434Z","steps":["trace[580294775] 'agreement among raft nodes before linearized reading' (duration: 116.468887ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:19:28.071454Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39c975536cfc1086","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T19:19:28.080393Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-10-15T19:19:28.080507Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-10-15T19:19:31.539237Z","caller":"traceutil/trace.go:171","msg":"trace[1601886571] linearizableReadLoop","detail":"{readStateIndex:10022; appliedIndex:10021; }","duration":"103.085765ms","start":"2026-10-15T19:19:31.436128Z","end":"2026-10-15T19:19:31.539214Z","steps":["trace[1601886571] 'read index received' (duration: 102.834468ms)","trace[1601886571] 'applied index is now lower than readState.Index' (duration: 250.427µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:19:31.539293Z","caller":"traceutil/trace.go:171","msg":"trace[256805916] transaction","detail":"{read_only:false; response_revision:9683; number_of_response:1; }","duration":"133.261357ms","start":"2026-10-15T19:19:31.406011Z","end":"2026-10-15T19:19:31.539272Z","steps":["trace[256805916] 'process raft request' (duration: 132.957629ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:19:31.539454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.243849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-15T19:19:31.539547Z","caller":"traceutil/trace.go:171","msg":"trace[1392583088] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:9683; }","duration":"103.362344ms","start":"2026-10-15T19:19:31.436122Z","end":"2026-10-15T19:19:31.539484Z","steps":["trace[1392583088] 'agreement among raft nodes before linearized reading' (duration: 103.21476ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:02.79682Z","caller":"traceutil/trace.go:171","msg":"trace[1384306637] linearizableReadLoop","detail":"{readStateIndex:10248; appliedIndex:10247; }","duration":"107.990749ms","start":"2026-10-15T19:20:02.688805Z","end":"2026-10-15T19:20:02.796795Z","steps":["trace[1384306637] 'read index received' (duration: 107.752482ms)","trace[1384306637] 'applied index is now lower than readState.Index' (duration: 237.097µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:20:02.796962Z","caller":"traceutil/trace.go:171","msg":"trace[1796292997] transaction","detail":"{read_only:false; response_revision:9903; number_of_response:1; }","duration":"162.660647ms","start":"2026-10-15T19:20:02.634291Z","end":"2026-10-15T19:20:02.796952Z","steps":["trace[1796292997] 'process raft request' (duration: 162.348449ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:20:02.797304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.484122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:20:02.797386Z","caller":"traceutil/trace.go:171","msg":"trace[1280047073] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:9903; }","duration":"108.615135ms","start":"2026-10-15T19:20:02.688752Z","end":"2026-10-15T19:20:02.797367Z","steps":["trace[1280047073] 'agreement among raft nodes before linearized reading' (duration: 108.506972ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:03.791627Z","caller":"traceutil/trace.go:171","msg":"trace[295664874] transaction","detail":"{read_only:false; response_revision:9908; number_of_response:1; }","duration":"141.650185ms","start":"2026-10-15T19:20:03.649957Z","end":"2026-10-15T19:20:03.791607Z","steps":["trace[295664874] 'process raft request' (duration: 141.519462ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:20:04.914284Z","caller":"traceutil/trace.go:171","msg":"trace[463552784] transaction","detail":"{read_only:false; response_revision:9916; number_of_response:1; }","duration":"111.707169ms","start":"2026-10-15T19:20:04.80254Z","end":"2026-10-15T19:20:04.914247Z","steps":["trace[463552784] 'process raft request' (duration: 92.928399ms)","trace[463552784] 'compare' (duration: 18.537764ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:21:29.375571Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8078} {"level":"info","ts":"2026-10-15T19:21:29.444925Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8078,"took":"67.14872ms","hash":776516694,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":28868608,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-10-15T19:21:29.444992Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":776516694,"revision":8078,"compact-revision":5912} {"level":"info","ts":"2026-10-15T19:22:57.593545Z","caller":"traceutil/trace.go:171","msg":"trace[1184474318] transaction","detail":"{read_only:false; response_revision:11434; number_of_response:1; }","duration":"101.481901ms","start":"2026-10-15T19:22:57.49204Z","end":"2026-10-15T19:22:57.593522Z","steps":["trace[1184474318] 'process raft request' (duration: 101.103761ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:23:17.330667Z","caller":"traceutil/trace.go:171","msg":"trace[911889841] transaction","detail":"{read_only:false; response_revision:11544; number_of_response:1; }","duration":"124.69252ms","start":"2026-10-15T19:23:17.205952Z","end":"2026-10-15T19:23:17.330645Z","steps":["trace[911889841] 'process raft request' (duration: 124.533436ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:23:17.348826Z","caller":"traceutil/trace.go:171","msg":"trace[500269515] transaction","detail":"{read_only:false; response_revision:11545; number_of_response:1; }","duration":"142.100082ms","start":"2026-10-15T19:23:17.206685Z","end":"2026-10-15T19:23:17.348785Z","steps":["trace[500269515] 'process raft request' (duration: 141.601269ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:26:29.383103Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10530} {"level":"info","ts":"2026-10-15T19:26:29.480234Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10530,"took":"94.544158ms","hash":3980217807,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":27492352,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-10-15T19:26:29.480311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3980217807,"revision":10530,"compact-revision":8078} {"level":"info","ts":"2026-10-15T19:29:48.45726Z","caller":"traceutil/trace.go:171","msg":"trace[1481699073] transaction","detail":"{read_only:false; response_revision:14168; number_of_response:1; }","duration":"169.032786ms","start":"2026-10-15T19:29:48.288203Z","end":"2026-10-15T19:29:48.457236Z","steps":["trace[1481699073] 'process raft request' (duration: 168.41775ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:29:48.685063Z","caller":"traceutil/trace.go:171","msg":"trace[1802246147] transaction","detail":"{read_only:false; response_revision:14169; number_of_response:1; }","duration":"222.884748ms","start":"2026-10-15T19:29:48.462126Z","end":"2026-10-15T19:29:48.685011Z","steps":["trace[1802246147] 'process raft request' (duration: 220.562096ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:29:48.685249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.58194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:29:48.685321Z","caller":"traceutil/trace.go:171","msg":"trace[912613929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:14169; }","duration":"194.670953ms","start":"2026-10-15T19:29:48.490634Z","end":"2026-10-15T19:29:48.685305Z","steps":["trace[912613929] 'agreement among raft nodes before linearized reading' (duration: 194.533109ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:29:48.685093Z","caller":"traceutil/trace.go:171","msg":"trace[1341643069] linearizableReadLoop","detail":"{readStateIndex:14655; appliedIndex:14654; }","duration":"194.352084ms","start":"2026-10-15T19:29:48.490658Z","end":"2026-10-15T19:29:48.68501Z","steps":["trace[1341643069] 'read index received' (duration: 191.844817ms)","trace[1341643069] 'applied index is now lower than readState.Index' (duration: 2.502687ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:30:12.751216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.373112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-33bb017e-0141-4c2b-a6b8-44ff81d72bc2\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-10-15T19:30:12.751317Z","caller":"traceutil/trace.go:171","msg":"trace[666274137] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-33bb017e-0141-4c2b-a6b8-44ff81d72bc2; range_end:; response_count:1; response_revision:14480; }","duration":"269.525776ms","start":"2026-10-15T19:30:12.48177Z","end":"2026-10-15T19:30:12.751296Z","steps":["trace[666274137] 'range keys from in-memory index tree' (duration: 269.158997ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:30:12.751478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.100485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-fsgzr\" ","response":"range_response_count:1 size:20660"} {"level":"info","ts":"2026-10-15T19:30:12.751571Z","caller":"traceutil/trace.go:171","msg":"trace[1105444135] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-fsgzr; range_end:; response_count:1; response_revision:14480; }","duration":"238.267059ms","start":"2026-10-15T19:30:12.513285Z","end":"2026-10-15T19:30:12.751552Z","steps":["trace[1105444135] 'range keys from in-memory index tree' (duration: 237.91078ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:31:29.389894Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12796} {"level":"info","ts":"2026-10-15T19:31:29.476744Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12796,"took":"84.347939ms","hash":2751095583,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":30281728,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-15T19:31:29.476817Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2751095583,"revision":12796,"compact-revision":10530} {"level":"warn","ts":"2026-10-15T19:31:39.767137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.34808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-15T19:31:39.767238Z","caller":"traceutil/trace.go:171","msg":"trace[600741788] linearizableReadLoop","detail":"{readStateIndex:15825; appliedIndex:15824; }","duration":"187.048609ms","start":"2026-10-15T19:31:39.580175Z","end":"2026-10-15T19:31:39.767223Z","steps":["trace[600741788] 'read index received' (duration: 53.468572ms)","trace[600741788] 'applied index is now lower than readState.Index' (duration: 133.578907ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:31:39.767433Z","caller":"traceutil/trace.go:171","msg":"trace[1407157447] transaction","detail":"{read_only:false; response_revision:15301; number_of_response:1; }","duration":"190.778718ms","start":"2026-10-15T19:31:39.576643Z","end":"2026-10-15T19:31:39.767422Z","steps":["trace[1407157447] 'process raft request' (duration: 57.070338ms)","trace[1407157447] 'compare' (duration: 133.252808ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:31:39.767648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.47649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:31:39.767693Z","caller":"traceutil/trace.go:171","msg":"trace[216825393] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15301; }","duration":"187.542302ms","start":"2026-10-15T19:31:39.580141Z","end":"2026-10-15T19:31:39.767683Z","steps":["trace[216825393] 'agreement among raft nodes before linearized reading' (duration: 187.47649ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:39.767877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.510191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:31:39.767909Z","caller":"traceutil/trace.go:171","msg":"trace[1740058722] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15301; }","duration":"187.543222ms","start":"2026-10-15T19:31:39.580358Z","end":"2026-10-15T19:31:39.767901Z","steps":["trace[1740058722] 'agreement among raft nodes before linearized reading' (duration: 187.497511ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:39.768053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.69532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:31:39.768083Z","caller":"traceutil/trace.go:171","msg":"trace[467534889] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15301; }","duration":"102.779061ms","start":"2026-10-15T19:31:39.665296Z","end":"2026-10-15T19:31:39.768075Z","steps":["trace[467534889] 'agreement among raft nodes before linearized reading' (duration: 102.73438ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:39.768267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.08692ms","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-10-15T19:31:39.76829Z","caller":"traceutil/trace.go:171","msg":"trace[375859005] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:15301; }","duration":"165.129861ms","start":"2026-10-15T19:31:39.603153Z","end":"2026-10-15T19:31:39.768283Z","steps":["trace[375859005] 'agreement among raft nodes before linearized reading' (duration: 165.030518ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:39.768441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.289261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-15T19:31:39.768464Z","caller":"traceutil/trace.go:171","msg":"trace[1644156158] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15301; }","duration":"185.327762ms","start":"2026-10-15T19:31:39.583129Z","end":"2026-10-15T19:31:39.768457Z","steps":["trace[1644156158] 'agreement among raft nodes before linearized reading' (duration: 185.25276ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:39.768556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.565962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-15T19:31:39.768576Z","caller":"traceutil/trace.go:171","msg":"trace[1329121411] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15301; }","duration":"187.604514ms","start":"2026-10-15T19:31:39.580965Z","end":"2026-10-15T19:31:39.76857Z","steps":["trace[1329121411] 'agreement among raft nodes before linearized reading' (duration: 187.572803ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:39.768873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.215333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-10-15T19:31:39.768946Z","caller":"traceutil/trace.go:171","msg":"trace[1013905236] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15301; }","duration":"100.313646ms","start":"2026-10-15T19:31:39.668612Z","end":"2026-10-15T19:31:39.768926Z","steps":["trace[1013905236] 'agreement among raft nodes before linearized reading' (duration: 100.165742ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:31:40.114905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.221387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-15T19:31:40.115915Z","caller":"traceutil/trace.go:171","msg":"trace[1197772592] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15302; }","duration":"102.565286ms","start":"2026-10-15T19:31:40.012568Z","end":"2026-10-15T19:31:40.115133Z","steps":["trace[1197772592] 'range keys from in-memory index tree' (duration: 101.925349ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:36:29.396894Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15250} {"level":"info","ts":"2026-10-15T19:36:29.501646Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15250,"took":"101.052119ms","hash":2016555545,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":32043008,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T19:36:29.50175Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2016555545,"revision":15250,"compact-revision":12796} {"level":"info","ts":"2026-10-15T19:37:29.233631Z","caller":"traceutil/trace.go:171","msg":"trace[2105077502] transaction","detail":"{read_only:false; response_revision:17883; number_of_response:1; }","duration":"102.563697ms","start":"2026-10-15T19:37:29.131035Z","end":"2026-10-15T19:37:29.233598Z","steps":["trace[2105077502] 'process raft request' (duration: 97.50964ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:37:36.237062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.519335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:37:36.237154Z","caller":"traceutil/trace.go:171","msg":"trace[778130271] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:17926; }","duration":"109.663878ms","start":"2026-10-15T19:37:36.127462Z","end":"2026-10-15T19:37:36.237126Z","steps":["trace[778130271] 'count revisions from in-memory index tree' (duration: 109.36299ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:37:37.194913Z","caller":"traceutil/trace.go:171","msg":"trace[479198082] linearizableReadLoop","detail":"{readStateIndex:18539; appliedIndex:18538; }","duration":"360.31076ms","start":"2026-10-15T19:37:36.834578Z","end":"2026-10-15T19:37:37.194889Z","steps":["trace[479198082] 'read index received' (duration: 360.071633ms)","trace[479198082] 'applied index is now lower than readState.Index' (duration: 235.047µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:37:37.195043Z","caller":"traceutil/trace.go:171","msg":"trace[1357086858] transaction","detail":"{read_only:false; response_revision:17929; number_of_response:1; }","duration":"438.801498ms","start":"2026-10-15T19:37:36.756198Z","end":"2026-10-15T19:37:37.195Z","steps":["trace[1357086858] 'process raft request' (duration: 438.49231ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:37:37.195168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.587458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-fsgzr\" ","response":"range_response_count:1 size:20763"} {"level":"info","ts":"2026-10-15T19:37:37.195209Z","caller":"traceutil/trace.go:171","msg":"trace[1640942690] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-fsgzr; range_end:; response_count:1; response_revision:17929; }","duration":"360.68597ms","start":"2026-10-15T19:37:36.834512Z","end":"2026-10-15T19:37:37.195198Z","steps":["trace[1640942690] 'agreement among raft nodes before linearized reading' (duration: 360.499695ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:37:37.195265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:37:36.834491Z","time spent":"360.765503ms","remote":"127.0.0.1:38884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":20786,"request content":"key:\"/registry/pods/openstack/libvirt-libvirt-default-fsgzr\" "} {"level":"warn","ts":"2026-10-15T19:37:37.195255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:37:36.75618Z","time spent":"438.952651ms","remote":"127.0.0.1:38944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:37:37.209049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.827987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-10-15T19:37:37.209102Z","caller":"traceutil/trace.go:171","msg":"trace[934655000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:17930; }","duration":"326.92931ms","start":"2026-10-15T19:37:36.88216Z","end":"2026-10-15T19:37:37.20909Z","steps":["trace[934655000] 'agreement among raft nodes before linearized reading' (duration: 326.723334ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:37:37.209132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:37:36.882137Z","time spent":"326.987991ms","remote":"127.0.0.1:38944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-10-15T19:37:37.20937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.167246ms","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-10-15T19:37:37.209407Z","caller":"traceutil/trace.go:171","msg":"trace[976847197] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:17930; }","duration":"294.260758ms","start":"2026-10-15T19:37:36.915136Z","end":"2026-10-15T19:37:37.209397Z","steps":["trace[976847197] 'agreement among raft nodes before linearized reading' (duration: 294.154815ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:37:37.209418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.24226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-v7zr2\" ","response":"range_response_count:1 size:9797"} {"level":"info","ts":"2026-10-15T19:37:37.2095Z","caller":"traceutil/trace.go:171","msg":"trace[1222609190] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-v7zr2; range_end:; response_count:1; response_revision:17930; }","duration":"174.375034ms","start":"2026-10-15T19:37:37.035103Z","end":"2026-10-15T19:37:37.209478Z","steps":["trace[1222609190] 'agreement among raft nodes before linearized reading' (duration: 174.037225ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:37:37.209546Z","caller":"traceutil/trace.go:171","msg":"trace[1591826049] transaction","detail":"{read_only:false; response_revision:17930; number_of_response:1; }","duration":"347.844924ms","start":"2026-10-15T19:37:36.86167Z","end":"2026-10-15T19:37:37.209515Z","steps":["trace[1591826049] 'process raft request' (duration: 347.069683ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:37:37.209697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:37:36.861653Z","time spent":"347.966107ms","remote":"127.0.0.1:38944","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-10-15T19:40:17.027427Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39c975536cfc1086","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T19:40:17.034509Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-10-15T19:40:17.034682Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-10-15T19:41:29.405835Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17470} {"level":"info","ts":"2026-10-15T19:41:29.509554Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17470,"took":"99.781033ms","hash":3378965658,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":34369536,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-10-15T19:41:29.509631Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3378965658,"revision":17470,"compact-revision":15250} {"level":"info","ts":"2026-10-15T19:43:18.298165Z","caller":"traceutil/trace.go:171","msg":"trace[227782519] transaction","detail":"{read_only:false; response_revision:20588; number_of_response:1; }","duration":"125.138567ms","start":"2026-10-15T19:43:18.172993Z","end":"2026-10-15T19:43:18.298132Z","steps":["trace[227782519] 'process raft request' (duration: 124.946162ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:18.683288Z","caller":"traceutil/trace.go:171","msg":"trace[1457001853] transaction","detail":"{read_only:false; response_revision:20589; number_of_response:1; }","duration":"141.221502ms","start":"2026-10-15T19:43:18.542031Z","end":"2026-10-15T19:43:18.683252Z","steps":["trace[1457001853] 'process raft request' (duration: 141.035967ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:18.84322Z","caller":"traceutil/trace.go:171","msg":"trace[771171927] linearizableReadLoop","detail":"{readStateIndex:21289; appliedIndex:21286; }","duration":"111.363085ms","start":"2026-10-15T19:43:18.731827Z","end":"2026-10-15T19:43:18.84319Z","steps":["trace[771171927] 'read index received' (duration: 65.622941ms)","trace[771171927] 'applied index is now lower than readState.Index' (duration: 45.739164ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:43:18.843484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.597101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"} {"level":"info","ts":"2026-10-15T19:43:18.843551Z","caller":"traceutil/trace.go:171","msg":"trace[43304613] transaction","detail":"{read_only:false; response_revision:20590; number_of_response:1; }","duration":"274.162009ms","start":"2026-10-15T19:43:18.569359Z","end":"2026-10-15T19:43:18.843521Z","steps":["trace[43304613] 'process raft request' (duration: 228.124987ms)","trace[43304613] 'compare' (duration: 45.450576ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:43:18.843634Z","caller":"traceutil/trace.go:171","msg":"trace[69356950] transaction","detail":"{read_only:false; response_revision:20591; number_of_response:1; }","duration":"223.372588ms","start":"2026-10-15T19:43:18.620191Z","end":"2026-10-15T19:43:18.843563Z","steps":["trace[69356950] 'process raft request' (duration: 222.900756ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:18.843683Z","caller":"traceutil/trace.go:171","msg":"trace[1884897528] transaction","detail":"{read_only:false; response_revision:20592; number_of_response:1; }","duration":"222.34119ms","start":"2026-10-15T19:43:18.621259Z","end":"2026-10-15T19:43:18.8436Z","steps":["trace[1884897528] 'process raft request' (duration: 221.885828ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:18.844015Z","caller":"traceutil/trace.go:171","msg":"trace[78275854] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:20592; }","duration":"112.227499ms","start":"2026-10-15T19:43:18.731771Z","end":"2026-10-15T19:43:18.843998Z","steps":["trace[78275854] 'agreement among raft nodes before linearized reading' (duration: 111.52362ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:19.316058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.126333ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:43:19.316215Z","caller":"traceutil/trace.go:171","msg":"trace[1712679247] transaction","detail":"{read_only:false; response_revision:20594; number_of_response:1; }","duration":"198.382154ms","start":"2026-10-15T19:43:19.117806Z","end":"2026-10-15T19:43:19.316188Z","steps":["trace[1712679247] 'process raft request' (duration: 94.964233ms)","trace[1712679247] 'compare' (duration: 102.915467ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:43:19.601218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.927744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:43:19.601305Z","caller":"traceutil/trace.go:171","msg":"trace[17797364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20594; }","duration":"111.063187ms","start":"2026-10-15T19:43:19.490221Z","end":"2026-10-15T19:43:19.601284Z","steps":["trace[17797364] 'range keys from in-memory index tree' (duration: 110.865372ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:19.601394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.731801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-10-15T19:43:19.601858Z","caller":"traceutil/trace.go:171","msg":"trace[261838613] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20594; }","duration":"140.215314ms","start":"2026-10-15T19:43:19.461611Z","end":"2026-10-15T19:43:19.601826Z","steps":["trace[261838613] 'range keys from in-memory index tree' (duration: 139.561267ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:43:19.794993Z","caller":"traceutil/trace.go:171","msg":"trace[667542407] linearizableReadLoop","detail":"{readStateIndex:21292; appliedIndex:21291; }","duration":"108.879028ms","start":"2026-10-15T19:43:19.686082Z","end":"2026-10-15T19:43:19.794961Z","steps":["trace[667542407] 'read index received' (duration: 108.521959ms)","trace[667542407] 'applied index is now lower than readState.Index' (duration: 355.959µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:43:19.795153Z","caller":"traceutil/trace.go:171","msg":"trace[67242279] transaction","detail":"{read_only:false; response_revision:20595; number_of_response:1; }","duration":"112.911678ms","start":"2026-10-15T19:43:19.68221Z","end":"2026-10-15T19:43:19.795122Z","steps":["trace[67242279] 'process raft request' (duration: 112.549958ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:43:19.795199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.085104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:43:19.795254Z","caller":"traceutil/trace.go:171","msg":"trace[39249342] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:20595; }","duration":"109.182417ms","start":"2026-10-15T19:43:19.686057Z","end":"2026-10-15T19:43:19.79524Z","steps":["trace[39249342] 'agreement among raft nodes before linearized reading' (duration: 109.064074ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:46:29.412907Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19835} {"level":"info","ts":"2026-10-15T19:46:29.53262Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19835,"took":"115.525958ms","hash":1117299020,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":30429184,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-10-15T19:46:29.532714Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1117299020,"revision":19835,"compact-revision":17470} {"level":"info","ts":"2026-10-15T19:47:11.938315Z","caller":"traceutil/trace.go:171","msg":"trace[1199607520] transaction","detail":"{read_only:false; response_revision:23027; number_of_response:1; }","duration":"308.404312ms","start":"2026-10-15T19:47:11.629856Z","end":"2026-10-15T19:47:11.93826Z","steps":["trace[1199607520] 'process raft request' (duration: 252.210095ms)","trace[1199607520] 'compare' (duration: 55.95264ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:47:11.93863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:47:11.629836Z","time spent":"308.601678ms","remote":"127.0.0.1:38944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:47:11.942931Z","caller":"traceutil/trace.go:171","msg":"trace[940877570] transaction","detail":"{read_only:false; response_revision:23028; number_of_response:1; }","duration":"161.931119ms","start":"2026-10-15T19:47:11.780982Z","end":"2026-10-15T19:47:11.942913Z","steps":["trace[940877570] 'process raft request' (duration: 161.743164ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:47:11.943399Z","caller":"traceutil/trace.go:171","msg":"trace[451968260] transaction","detail":"{read_only:false; response_revision:23030; number_of_response:1; }","duration":"145.023424ms","start":"2026-10-15T19:47:11.798354Z","end":"2026-10-15T19:47:11.943377Z","steps":["trace[451968260] 'process raft request' (duration: 144.828968ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:47:11.943523Z","caller":"traceutil/trace.go:171","msg":"trace[811497239] transaction","detail":"{read_only:false; response_revision:23029; number_of_response:1; }","duration":"158.180219ms","start":"2026-10-15T19:47:11.785301Z","end":"2026-10-15T19:47:11.943482Z","steps":["trace[811497239] 'process raft request' (duration: 157.565552ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:50:26.581636Z","caller":"traceutil/trace.go:171","msg":"trace[851571784] linearizableReadLoop","detail":"{readStateIndex:25816; appliedIndex:25815; }","duration":"113.275527ms","start":"2026-10-15T19:50:26.468333Z","end":"2026-10-15T19:50:26.581608Z","steps":["trace[851571784] 'read index received' (duration: 113.040761ms)","trace[851571784] 'applied index is now lower than readState.Index' (duration: 233.676µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:50:26.58173Z","caller":"traceutil/trace.go:171","msg":"trace[188059986] transaction","detail":"{read_only:false; response_revision:24999; number_of_response:1; }","duration":"119.991058ms","start":"2026-10-15T19:50:26.461708Z","end":"2026-10-15T19:50:26.581699Z","steps":["trace[188059986] 'process raft request' (duration: 119.743741ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:50:26.581918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.564085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-15T19:50:26.581964Z","caller":"traceutil/trace.go:171","msg":"trace[774721282] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24999; }","duration":"113.628106ms","start":"2026-10-15T19:50:26.468325Z","end":"2026-10-15T19:50:26.581953Z","steps":["trace[774721282] 'agreement among raft nodes before linearized reading' (duration: 113.38898ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:50:26.739342Z","caller":"traceutil/trace.go:171","msg":"trace[658559648] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"152.365332ms","start":"2026-10-15T19:50:26.586945Z","end":"2026-10-15T19:50:26.73931Z","steps":["trace[658559648] 'process raft request' (duration: 152.105584ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:50:26.739804Z","caller":"traceutil/trace.go:171","msg":"trace[1288020278] linearizableReadLoop","detail":"{readStateIndex:25817; appliedIndex:25816; }","duration":"145.374602ms","start":"2026-10-15T19:50:26.594413Z","end":"2026-10-15T19:50:26.739788Z","steps":["trace[1288020278] 'read index received' (duration: 144.381576ms)","trace[1288020278] 'applied index is now lower than readState.Index' (duration: 991.426µs)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:50:26.740017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.591249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-10-15T19:50:26.740063Z","caller":"traceutil/trace.go:171","msg":"trace[1570563592] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25000; }","duration":"145.684062ms","start":"2026-10-15T19:50:26.594366Z","end":"2026-10-15T19:50:26.74005Z","steps":["trace[1570563592] 'agreement among raft nodes before linearized reading' (duration: 145.506467ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:50:26.968862Z","caller":"traceutil/trace.go:171","msg":"trace[1085948335] transaction","detail":"{read_only:false; response_revision:25001; number_of_response:1; }","duration":"366.624413ms","start":"2026-10-15T19:50:26.6022Z","end":"2026-10-15T19:50:26.968825Z","steps":["trace[1085948335] 'process raft request' (duration: 279.993555ms)","trace[1085948335] 'compare' (duration: 86.402562ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:50:26.968898Z","caller":"traceutil/trace.go:171","msg":"trace[777712694] linearizableReadLoop","detail":"{readStateIndex:25819; appliedIndex:25817; }","duration":"229.02447ms","start":"2026-10-15T19:50:26.739848Z","end":"2026-10-15T19:50:26.968872Z","steps":["trace[777712694] 'read index received' (duration: 142.329691ms)","trace[777712694] 'applied index is now lower than readState.Index' (duration: 86.691719ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:50:26.968911Z","caller":"traceutil/trace.go:171","msg":"trace[559207148] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"228.853665ms","start":"2026-10-15T19:50:26.740013Z","end":"2026-10-15T19:50:26.968867Z","steps":["trace[559207148] 'process raft request' (duration: 228.792043ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:50:26.969007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:50:26.602176Z","time spent":"366.754207ms","remote":"127.0.0.1:38944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-15T19:50:26.969113Z","caller":"traceutil/trace.go:171","msg":"trace[588317030] transaction","detail":"{read_only:false; response_revision:25005; number_of_response:1; }","duration":"123.643316ms","start":"2026-10-15T19:50:26.845445Z","end":"2026-10-15T19:50:26.969088Z","steps":["trace[588317030] 'process raft request' (duration: 123.587955ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:50:26.969227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.299516ms","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-10-15T19:50:26.969251Z","caller":"traceutil/trace.go:171","msg":"trace[662447363] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25005; }","duration":"339.347587ms","start":"2026-10-15T19:50:26.629896Z","end":"2026-10-15T19:50:26.969244Z","steps":["trace[662447363] 'agreement among raft nodes before linearized reading' (duration: 339.199223ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:50:26.969265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.349343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-10-15T19:50:26.969316Z","caller":"traceutil/trace.go:171","msg":"trace[48025055] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25005; }","duration":"221.442986ms","start":"2026-10-15T19:50:26.747862Z","end":"2026-10-15T19:50:26.969305Z","steps":["trace[48025055] 'agreement among raft nodes before linearized reading' (duration: 221.241681ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:50:26.969265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:50:26.629884Z","time spent":"339.378708ms","remote":"127.0.0.1:38944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-10-15T19:50:26.969714Z","caller":"traceutil/trace.go:171","msg":"trace[282420997] transaction","detail":"{read_only:false; response_revision:25004; number_of_response:1; }","duration":"221.767004ms","start":"2026-10-15T19:50:26.747728Z","end":"2026-10-15T19:50:26.969495Z","steps":["trace[282420997] 'process raft request' (duration: 221.121157ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:50:26.968901Z","caller":"traceutil/trace.go:171","msg":"trace[966034733] transaction","detail":"{read_only:false; response_revision:25002; number_of_response:1; }","duration":"286.808189ms","start":"2026-10-15T19:50:26.68203Z","end":"2026-10-15T19:50:26.968838Z","steps":["trace[966034733] 'process raft request' (duration: 286.715017ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:50:54.744063Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006608.wal"} {"level":"info","ts":"2026-10-15T19:51:23.358992Z","caller":"traceutil/trace.go:171","msg":"trace[1020278613] transaction","detail":"{read_only:false; response_revision:25519; number_of_response:1; }","duration":"137.067118ms","start":"2026-10-15T19:51:23.2219Z","end":"2026-10-15T19:51:23.358967Z","steps":["trace[1020278613] 'process raft request' (duration: 136.923334ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:23.37346Z","caller":"traceutil/trace.go:171","msg":"trace[954399910] transaction","detail":"{read_only:false; response_revision:25520; number_of_response:1; }","duration":"146.192594ms","start":"2026-10-15T19:51:23.227241Z","end":"2026-10-15T19:51:23.373434Z","steps":["trace[954399910] 'process raft request' (duration: 146.0247ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:28.9187Z","caller":"traceutil/trace.go:171","msg":"trace[337883639] linearizableReadLoop","detail":"{readStateIndex:26388; appliedIndex:26387; }","duration":"103.202195ms","start":"2026-10-15T19:51:28.815469Z","end":"2026-10-15T19:51:28.918671Z","steps":["trace[337883639] 'read index received' (duration: 102.959728ms)","trace[337883639] 'applied index is now lower than readState.Index' (duration: 240.967µs)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:51:28.9188Z","caller":"traceutil/trace.go:171","msg":"trace[1469542751] transaction","detail":"{read_only:false; response_revision:25558; number_of_response:1; }","duration":"141.694824ms","start":"2026-10-15T19:51:28.777077Z","end":"2026-10-15T19:51:28.918772Z","steps":["trace[1469542751] 'process raft request' (duration: 141.332914ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:51:28.918844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.349809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-10-15T19:51:28.918878Z","caller":"traceutil/trace.go:171","msg":"trace[1114696581] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:25558; }","duration":"103.427491ms","start":"2026-10-15T19:51:28.81544Z","end":"2026-10-15T19:51:28.918867Z","steps":["trace[1114696581] 'agreement among raft nodes before linearized reading' (duration: 103.335439ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:51:29.202298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.81104ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:51:29.202506Z","caller":"traceutil/trace.go:171","msg":"trace[1803364197] linearizableReadLoop","detail":"{readStateIndex:26389; appliedIndex:26388; }","duration":"151.309483ms","start":"2026-10-15T19:51:29.051132Z","end":"2026-10-15T19:51:29.202442Z","steps":["trace[1803364197] 'read index received' (duration: 37.231µs)","trace[1803364197] 'applied index is now lower than readState.Index' (duration: 151.270762ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:51:29.202867Z","caller":"traceutil/trace.go:171","msg":"trace[628656051] transaction","detail":"{read_only:false; response_revision:25559; number_of_response:1; }","duration":"278.817033ms","start":"2026-10-15T19:51:28.924002Z","end":"2026-10-15T19:51:29.202819Z","steps":["trace[628656051] 'process raft request' (duration: 124.226562ms)","trace[628656051] 'compare' (duration: 153.580414ms)"],"step_count":2} {"level":"warn","ts":"2026-10-15T19:51:29.202885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.218104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-10-15T19:51:29.202947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.793356ms","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-10-15T19:51:29.202978Z","caller":"traceutil/trace.go:171","msg":"trace[1761057216] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:25559; }","duration":"143.342188ms","start":"2026-10-15T19:51:29.059616Z","end":"2026-10-15T19:51:29.202958Z","steps":["trace[1761057216] 'agreement among raft nodes before linearized reading' (duration: 143.187594ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:29.203001Z","caller":"traceutil/trace.go:171","msg":"trace[1574428052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25559; }","duration":"151.891679ms","start":"2026-10-15T19:51:29.051093Z","end":"2026-10-15T19:51:29.202985Z","steps":["trace[1574428052] 'agreement among raft nodes before linearized reading' (duration: 151.684793ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:51:29.497712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.51676ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-10-15T19:51:29.497887Z","caller":"traceutil/trace.go:171","msg":"trace[149225635] transaction","detail":"{read_only:false; response_revision:25561; number_of_response:1; }","duration":"274.019894ms","start":"2026-10-15T19:51:29.223849Z","end":"2026-10-15T19:51:29.497869Z","steps":["trace[149225635] 'process raft request' (duration: 273.959282ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:29.498012Z","caller":"traceutil/trace.go:171","msg":"trace[596099023] transaction","detail":"{read_only:false; response_revision:25560; number_of_response:1; }","duration":"290.831408ms","start":"2026-10-15T19:51:29.207171Z","end":"2026-10-15T19:51:29.498002Z","steps":["trace[596099023] 'process raft request' (duration: 145.916857ms)","trace[596099023] 'compare' (duration: 144.265413ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:51:29.692889Z","caller":"traceutil/trace.go:171","msg":"trace[541576529] linearizableReadLoop","detail":"{readStateIndex:26394; appliedIndex:26389; }","duration":"275.981447ms","start":"2026-10-15T19:51:29.416889Z","end":"2026-10-15T19:51:29.692871Z","steps":["trace[541576529] 'read index received' (duration: 30.76902ms)","trace[541576529] 'applied index is now lower than readState.Index' (duration: 245.211547ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:51:29.693156Z","caller":"traceutil/trace.go:171","msg":"trace[1810338626] transaction","detail":"{read_only:false; response_revision:25564; number_of_response:1; }","duration":"278.267829ms","start":"2026-10-15T19:51:29.414863Z","end":"2026-10-15T19:51:29.693131Z","steps":["trace[1810338626] 'process raft request' (duration: 277.980061ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:29.693173Z","caller":"traceutil/trace.go:171","msg":"trace[257563354] transaction","detail":"{read_only:false; response_revision:25562; number_of_response:1; }","duration":"313.376407ms","start":"2026-10-15T19:51:29.379773Z","end":"2026-10-15T19:51:29.693149Z","steps":["trace[257563354] 'process raft request' (duration: 312.930855ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:51:29.693238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.339407ms","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-10-15T19:51:29.693267Z","caller":"traceutil/trace.go:171","msg":"trace[1310915818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25564; }","duration":"276.398689ms","start":"2026-10-15T19:51:29.41686Z","end":"2026-10-15T19:51:29.693259Z","steps":["trace[1310915818] 'agreement among raft nodes before linearized reading' (duration: 276.257645ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:29.693242Z","caller":"traceutil/trace.go:171","msg":"trace[1921437450] transaction","detail":"{read_only:false; response_revision:25563; number_of_response:1; }","duration":"298.302919ms","start":"2026-10-15T19:51:29.394905Z","end":"2026-10-15T19:51:29.693208Z","steps":["trace[1921437450] 'process raft request' (duration: 297.903638ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:51:29.693293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-15T19:51:29.379748Z","time spent":"313.471469ms","remote":"127.0.0.1:38944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-10-15T19:51:29.712831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.591088ms","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-10-15T19:51:29.712928Z","caller":"traceutil/trace.go:171","msg":"trace[2000013728] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25565; }","duration":"165.738872ms","start":"2026-10-15T19:51:29.547166Z","end":"2026-10-15T19:51:29.712905Z","steps":["trace[2000013728] 'agreement among raft nodes before linearized reading' (duration: 165.482105ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:51:29.713139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.828389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:51:29.713191Z","caller":"traceutil/trace.go:171","msg":"trace[1823918647] transaction","detail":"{read_only:false; response_revision:25565; number_of_response:1; }","duration":"100.179033ms","start":"2026-10-15T19:51:29.612991Z","end":"2026-10-15T19:51:29.71317Z","steps":["trace[1823918647] 'process raft request' (duration: 99.390802ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:29.713224Z","caller":"traceutil/trace.go:171","msg":"trace[1590536829] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:25565; }","duration":"210.959263ms","start":"2026-10-15T19:51:29.502241Z","end":"2026-10-15T19:51:29.7132Z","steps":["trace[1590536829] 'agreement among raft nodes before linearized reading' (duration: 210.818929ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:51:29.713629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.790139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:51:29.713688Z","caller":"traceutil/trace.go:171","msg":"trace[901127019] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25565; }","duration":"223.931963ms","start":"2026-10-15T19:51:29.489743Z","end":"2026-10-15T19:51:29.713675Z","steps":["trace[901127019] 'agreement among raft nodes before linearized reading' (duration: 223.82069ms)"],"step_count":1} {"level":"warn","ts":"2026-10-15T19:51:29.713988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.886032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-10-15T19:51:29.714043Z","caller":"traceutil/trace.go:171","msg":"trace[1497039214] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:25565; }","duration":"286.958624ms","start":"2026-10-15T19:51:29.427068Z","end":"2026-10-15T19:51:29.714027Z","steps":["trace[1497039214] 'agreement among raft nodes before linearized reading' (duration: 285.521265ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:29.813711Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22173} {"level":"info","ts":"2026-10-15T19:51:29.813808Z","caller":"traceutil/trace.go:171","msg":"trace[991386122] compact","detail":"{revision:22173; response_revision:25565; }","duration":"118.809556ms","start":"2026-10-15T19:51:29.694959Z","end":"2026-10-15T19:51:29.813768Z","steps":["trace[991386122] 'process raft request' (duration: 28.055998ms)","trace[991386122] 'check and update compact revision' (duration: 90.512802ms)"],"step_count":2} {"level":"info","ts":"2026-10-15T19:51:29.814068Z","caller":"traceutil/trace.go:171","msg":"trace[179952292] transaction","detail":"{read_only:false; response_revision:25566; number_of_response:1; }","duration":"116.512124ms","start":"2026-10-15T19:51:29.697528Z","end":"2026-10-15T19:51:29.81404Z","steps":["trace[179952292] 'process raft request' (duration: 116.124093ms)"],"step_count":1} {"level":"info","ts":"2026-10-15T19:51:29.938914Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22173,"took":"115.346012ms","hash":752825444,"current-db-size-bytes":56147968,"current-db-size":"56 MB","current-db-size-in-use-bytes":45006848,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-10-15T19:51:29.938991Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":752825444,"revision":22173,"compact-revision":19835} {"level":"info","ts":"2026-10-15T19:56:29.822435Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25564} {"level":"info","ts":"2026-10-15T19:56:29.991801Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25564,"took":"165.380964ms","hash":1089582010,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":35831808,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-10-15T19:56:29.991878Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1089582010,"revision":25564,"compact-revision":22173} {"level":"info","ts":"2026-10-15T19:57:57.593562Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39c975536cfc1086","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T19:57:57.598573Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-10-15T19:57:57.598654Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-10-15T20:01:29.829363Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28441} {"level":"info","ts":"2026-10-15T20:01:29.999827Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28441,"took":"166.37081ms","hash":2979863880,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":30687232,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:01:29.999902Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2979863880,"revision":28441,"compact-revision":25564} {"level":"info","ts":"2026-10-15T20:06:29.836936Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30723} {"level":"info","ts":"2026-10-15T20:06:29.967738Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30723,"took":"126.942588ms","hash":1842553424,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":31784960,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-10-15T20:06:29.967963Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1842553424,"revision":30723,"compact-revision":28441} {"level":"info","ts":"2026-10-15T20:11:29.844094Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33015} {"level":"info","ts":"2026-10-15T20:11:29.996037Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33015,"took":"147.149506ms","hash":180354169,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":31137792,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-10-15T20:11:29.996084Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":180354169,"revision":33015,"compact-revision":30723} {"level":"info","ts":"2026-10-15T20:16:29.856444Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35310} {"level":"info","ts":"2026-10-15T20:16:29.995754Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35310,"took":"134.776379ms","hash":2112309373,"current-db-size-bytes":57507840,"current-db-size":"58 MB","current-db-size-in-use-bytes":32563200,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T20:16:29.995829Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2112309373,"revision":35310,"compact-revision":33015} {"level":"info","ts":"2026-10-15T20:19:17.059139Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39c975536cfc1086","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-10-15T20:19:17.06765Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-10-15T20:19:17.070822Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-10-15T20:21:29.866066Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37539} {"level":"info","ts":"2026-10-15T20:21:29.993125Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37539,"took":"122.864609ms","hash":2814686846,"current-db-size-bytes":57933824,"current-db-size":"58 MB","current-db-size-in-use-bytes":32649216,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-10-15T20:21:29.993219Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2814686846,"revision":37539,"compact-revision":35310}