{"level":"warn","ts":"2026-07-06T21:35:48.510171Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-06T21:35:48.510305Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-06T21:35:48.510452Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-06T21:35:48.510478Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-07-06T21:35:48.510521Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-06T21:35:48.511981Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-07-06T21:35:48.512105Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-06T21:35:48.516836Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.330084ms"} {"level":"info","ts":"2026-07-06T21:35:48.527936Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-07-06T21:35:48.528028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-07-06T21:35:48.528052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-07-06T21:35:48.528067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-06T21:35:48.52808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-07-06T21:35:48.528124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-07-06T21:35:48.533837Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-06T21:35:48.535951Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-06T21:35:48.53739Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-06T21:35:48.540169Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-06T21:35:48.540419Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-06T21:35:48.540653Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-06T21:35:48.540777Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-06T21:35:48.540803Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-06T21:35:48.542767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-07-06T21:35:48.543175Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-07-06T21:35:48.546622Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-06T21:35:48.546945Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-07-06T21:35:48.547025Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-07-06T21:35:48.547119Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-06T21:35:48.547197Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-06T21:35:48.829092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-07-06T21:35:48.829198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-07-06T21:35:48.829236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-07-06T21:35:48.829259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-07-06T21:35:48.829271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-07-06T21:35:48.829287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-07-06T21:35:48.829307Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-07-06T21:35:48.830195Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T21:35:48.830981Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-06T21:35:48.830978Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-07-06T21:35:48.831014Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-06T21:35:48.831447Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-06T21:35:48.831512Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-06T21:35:48.831634Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T21:35:48.831767Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T21:35:48.831809Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-06T21:35:48.834428Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-07-06T21:35:48.835085Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-06T21:36:09.105891Z","caller":"traceutil/trace.go:171","msg":"trace[464905967] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"114.504042ms","start":"2026-07-06T21:36:08.99136Z","end":"2026-07-06T21:36:09.105864Z","steps":["trace[464905967] 'process raft request' (duration: 114.289816ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:36:14.494252Z","caller":"traceutil/trace.go:171","msg":"trace[1639500105] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"267.357406ms","start":"2026-07-06T21:36:14.226869Z","end":"2026-07-06T21:36:14.494226Z","steps":["trace[1639500105] 'process raft request' (duration: 267.219443ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:36:33.156638Z","caller":"traceutil/trace.go:171","msg":"trace[443592711] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"106.372405ms","start":"2026-07-06T21:36:33.050236Z","end":"2026-07-06T21:36:33.156609Z","steps":["trace[443592711] 'process raft request' (duration: 94.822824ms)","trace[443592711] 'compare' (duration: 11.312095ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:36:33.607666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.39773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-06T21:36:33.607702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.131606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-06T21:36:33.607797Z","caller":"traceutil/trace.go:171","msg":"trace[993589586] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"342.591794ms","start":"2026-07-06T21:36:33.265182Z","end":"2026-07-06T21:36:33.607774Z","steps":["trace[993589586] 'range keys from in-memory index tree' (duration: 342.205395ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:36:33.607826Z","caller":"traceutil/trace.go:171","msg":"trace[1647040603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:634; }","duration":"131.325251ms","start":"2026-07-06T21:36:33.476478Z","end":"2026-07-06T21:36:33.607803Z","steps":["trace[1647040603] 'range keys from in-memory index tree' (duration: 130.87986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:36:33.60784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:36:33.265155Z","time spent":"342.674996ms","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-06T21:36:33.607701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.389832ms","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-07-06T21:36:33.607931Z","caller":"traceutil/trace.go:171","msg":"trace[132569762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:634; }","duration":"131.666689ms","start":"2026-07-06T21:36:33.476238Z","end":"2026-07-06T21:36:33.607904Z","steps":["trace[132569762] 'range keys from in-memory index tree' (duration: 131.157477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:36:34.067908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.056932ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:36:34.068072Z","caller":"traceutil/trace.go:171","msg":"trace[1583133922] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:638; }","duration":"354.241306ms","start":"2026-07-06T21:36:33.713807Z","end":"2026-07-06T21:36:34.068048Z","steps":["trace[1583133922] 'range keys from in-memory index tree' (duration: 354.033822ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:36:34.068085Z","caller":"traceutil/trace.go:171","msg":"trace[1010144184] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"395.5292ms","start":"2026-07-06T21:36:33.672521Z","end":"2026-07-06T21:36:34.06805Z","steps":["trace[1010144184] 'process raft request' (duration: 391.268377ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:36:34.068691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:36:33.672494Z","time spent":"395.650484ms","remote":"127.0.0.1:37536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-06T21:38:03.811744Z","caller":"traceutil/trace.go:171","msg":"trace[74498321] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"192.705415ms","start":"2026-07-06T21:38:03.619011Z","end":"2026-07-06T21:38:03.811716Z","steps":["trace[74498321] 'process raft request' (duration: 192.545971ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:38:03.860447Z","caller":"traceutil/trace.go:171","msg":"trace[124353832] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1941; }","duration":"111.596059ms","start":"2026-07-06T21:38:03.748828Z","end":"2026-07-06T21:38:03.860425Z","steps":["trace[124353832] 'read index received' (duration: 62.75795ms)","trace[124353832] 'applied index is now lower than readState.Index' (duration: 48.837239ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:38:03.860552Z","caller":"traceutil/trace.go:171","msg":"trace[153652090] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"166.365482ms","start":"2026-07-06T21:38:03.694179Z","end":"2026-07-06T21:38:03.860545Z","steps":["trace[153652090] 'process raft request' (duration: 166.123026ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:38:03.860737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.890876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-06T21:38:03.860766Z","caller":"traceutil/trace.go:171","msg":"trace[1317046314] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1868; }","duration":"111.972938ms","start":"2026-07-06T21:38:03.748787Z","end":"2026-07-06T21:38:03.860759Z","steps":["trace[1317046314] 'agreement among raft nodes before linearized reading' (duration: 111.848345ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:38:04.184325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.591636ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T21:38:04.184522Z","caller":"traceutil/trace.go:171","msg":"trace[351560762] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"260.913116ms","start":"2026-07-06T21:38:03.923585Z","end":"2026-07-06T21:38:04.184498Z","steps":["trace[351560762] 'process raft request' (duration: 153.714365ms)","trace[351560762] 'compare' (duration: 106.268949ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:38:04.184573Z","caller":"traceutil/trace.go:171","msg":"trace[1724372881] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"260.940516ms","start":"2026-07-06T21:38:03.923593Z","end":"2026-07-06T21:38:04.184534Z","steps":["trace[1724372881] 'process raft request' (duration: 260.810593ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:38:04.184594Z","caller":"traceutil/trace.go:171","msg":"trace[1538554597] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"259.977803ms","start":"2026-07-06T21:38:03.924578Z","end":"2026-07-06T21:38:04.184556Z","steps":["trace[1538554597] 'process raft request' (duration: 259.906892ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:38:20.386921Z","caller":"traceutil/trace.go:171","msg":"trace[114130123] transaction","detail":"{read_only:false; response_revision:2008; number_of_response:1; }","duration":"114.639914ms","start":"2026-07-06T21:38:20.272256Z","end":"2026-07-06T21:38:20.386896Z","steps":["trace[114130123] 'process raft request' (duration: 114.48675ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:38:20.387512Z","caller":"traceutil/trace.go:171","msg":"trace[354423075] transaction","detail":"{read_only:false; response_revision:2009; number_of_response:1; }","duration":"115.192758ms","start":"2026-07-06T21:38:20.272293Z","end":"2026-07-06T21:38:20.387485Z","steps":["trace[354423075] 'process raft request' (duration: 114.991513ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:38:20.38769Z","caller":"traceutil/trace.go:171","msg":"trace[459271203] transaction","detail":"{read_only:false; response_revision:2010; number_of_response:1; }","duration":"112.39327ms","start":"2026-07-06T21:38:20.275278Z","end":"2026-07-06T21:38:20.387672Z","steps":["trace[459271203] 'process raft request' (duration: 112.161054ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:38:53.492951Z","caller":"traceutil/trace.go:171","msg":"trace[637444782] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"156.919365ms","start":"2026-07-06T21:38:53.335979Z","end":"2026-07-06T21:38:53.492898Z","steps":["trace[637444782] 'process raft request' (duration: 125.201152ms)","trace[637444782] 'compare' (duration: 31.456577ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:38:59.640385Z","caller":"traceutil/trace.go:171","msg":"trace[1824710097] linearizableReadLoop","detail":"{readStateIndex:2312; appliedIndex:2311; }","duration":"109.826117ms","start":"2026-07-06T21:38:59.530527Z","end":"2026-07-06T21:38:59.640353Z","steps":["trace[1824710097] 'read index received' (duration: 109.629212ms)","trace[1824710097] 'applied index is now lower than readState.Index' (duration: 195.595µs)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:38:59.640438Z","caller":"traceutil/trace.go:171","msg":"trace[739368502] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"127.14049ms","start":"2026-07-06T21:38:59.513257Z","end":"2026-07-06T21:38:59.640397Z","steps":["trace[739368502] 'process raft request' (duration: 126.906194ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:38:59.640622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.073342ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:38:59.640722Z","caller":"traceutil/trace.go:171","msg":"trace[1074434442] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2224; }","duration":"110.234476ms","start":"2026-07-06T21:38:59.530467Z","end":"2026-07-06T21:38:59.640701Z","steps":["trace[1074434442] 'agreement among raft nodes before linearized reading' (duration: 110.060912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:40:17.762538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.811919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:40:17.762677Z","caller":"traceutil/trace.go:171","msg":"trace[2110705540] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2840; }","duration":"117.007614ms","start":"2026-07-06T21:40:17.645641Z","end":"2026-07-06T21:40:17.762649Z","steps":["trace[2110705540] 'range keys from in-memory index tree' (duration: 116.636225ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:23.852767Z","caller":"traceutil/trace.go:171","msg":"trace[368046938] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"133.108556ms","start":"2026-07-06T21:44:23.719625Z","end":"2026-07-06T21:44:23.852733Z","steps":["trace[368046938] 'process raft request' (duration: 73.502142ms)","trace[368046938] 'compare' (duration: 59.433119ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:44:26.473285Z","caller":"traceutil/trace.go:171","msg":"trace[1227908461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5074; }","duration":"100.055953ms","start":"2026-07-06T21:44:26.373183Z","end":"2026-07-06T21:44:26.473239Z","steps":["trace[1227908461] 'range keys from in-memory index tree' (duration: 99.659444ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:44:26.47357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.313621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-06T21:44:26.473606Z","caller":"traceutil/trace.go:171","msg":"trace[795876969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5074; }","duration":"100.436164ms","start":"2026-07-06T21:44:26.373162Z","end":"2026-07-06T21:44:26.473599Z","steps":["trace[795876969] 'range keys from in-memory index tree' (duration: 100.099346ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:26.61211Z","caller":"traceutil/trace.go:171","msg":"trace[1250111043] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"133.612727ms","start":"2026-07-06T21:44:26.478463Z","end":"2026-07-06T21:44:26.612076Z","steps":["trace[1250111043] 'process raft request' (duration: 133.381572ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:26.692493Z","caller":"traceutil/trace.go:171","msg":"trace[835352346] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"213.161584ms","start":"2026-07-06T21:44:26.479306Z","end":"2026-07-06T21:44:26.692468Z","steps":["trace[835352346] 'process raft request' (duration: 197.937285ms)","trace[835352346] 'compare' (duration: 15.014174ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:44:26.692775Z","caller":"traceutil/trace.go:171","msg":"trace[1951568542] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"213.339638ms","start":"2026-07-06T21:44:26.479424Z","end":"2026-07-06T21:44:26.692764Z","steps":["trace[1951568542] 'process raft request' (duration: 212.99866ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:26.693183Z","caller":"traceutil/trace.go:171","msg":"trace[615647027] transaction","detail":"{read_only:false; response_revision:5078; number_of_response:1; }","duration":"187.200196ms","start":"2026-07-06T21:44:26.505958Z","end":"2026-07-06T21:44:26.693158Z","steps":["trace[615647027] 'process raft request' (duration: 186.765275ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:26.693295Z","caller":"traceutil/trace.go:171","msg":"trace[1690704496] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"170.271396ms","start":"2026-07-06T21:44:26.523014Z","end":"2026-07-06T21:44:26.693285Z","steps":["trace[1690704496] 'process raft request' (duration: 170.06009ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:26.693497Z","caller":"traceutil/trace.go:171","msg":"trace[1593117569] linearizableReadLoop","detail":"{readStateIndex:5274; appliedIndex:5269; }","duration":"143.816484ms","start":"2026-07-06T21:44:26.549645Z","end":"2026-07-06T21:44:26.693461Z","steps":["trace[1593117569] 'read index received' (duration: 62.35232ms)","trace[1593117569] 'applied index is now lower than readState.Index' (duration: 81.462834ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:44:26.693574Z","caller":"traceutil/trace.go:171","msg":"trace[1368353220] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"136.428615ms","start":"2026-07-06T21:44:26.557138Z","end":"2026-07-06T21:44:26.693567Z","steps":["trace[1368353220] 'process raft request' (duration: 136.103358ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:44:26.693814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.203293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-06T21:44:26.693865Z","caller":"traceutil/trace.go:171","msg":"trace[920128189] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:5080; }","duration":"139.295705ms","start":"2026-07-06T21:44:26.554557Z","end":"2026-07-06T21:44:26.693853Z","steps":["trace[920128189] 'agreement among raft nodes before linearized reading' (duration: 139.114721ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:44:26.694141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.4861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:728911"} {"level":"info","ts":"2026-07-06T21:44:26.694173Z","caller":"traceutil/trace.go:171","msg":"trace[457731614] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5080; }","duration":"144.590103ms","start":"2026-07-06T21:44:26.549576Z","end":"2026-07-06T21:44:26.694166Z","steps":["trace[457731614] 'agreement among raft nodes before linearized reading' (duration: 144.04429ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:28.975323Z","caller":"traceutil/trace.go:171","msg":"trace[1057273028] transaction","detail":"{read_only:false; response_revision:5120; number_of_response:1; }","duration":"119.187528ms","start":"2026-07-06T21:44:28.856098Z","end":"2026-07-06T21:44:28.975286Z","steps":["trace[1057273028] 'process raft request' (duration: 98.776453ms)","trace[1057273028] 'compare' (duration: 20.259961ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:44:41.772967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.823716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:44:41.773111Z","caller":"traceutil/trace.go:171","msg":"trace[1509685291] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5344; }","duration":"126.99894ms","start":"2026-07-06T21:44:41.646082Z","end":"2026-07-06T21:44:41.773081Z","steps":["trace[1509685291] 'range keys from in-memory index tree' (duration: 126.732113ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:44:41.773157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.267875ms","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-07-06T21:44:41.773634Z","caller":"traceutil/trace.go:171","msg":"trace[1699307401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5344; }","duration":"154.822999ms","start":"2026-07-06T21:44:41.618791Z","end":"2026-07-06T21:44:41.773614Z","steps":["trace[1699307401] 'range keys from in-memory index tree' (duration: 154.042189ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:49.876956Z","caller":"traceutil/trace.go:171","msg":"trace[917039232] linearizableReadLoop","detail":"{readStateIndex:5735; appliedIndex:5734; }","duration":"135.853464ms","start":"2026-07-06T21:44:49.741073Z","end":"2026-07-06T21:44:49.876927Z","steps":["trace[917039232] 'read index received' (duration: 80.035503ms)","trace[917039232] 'applied index is now lower than readState.Index' (duration: 55.816371ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:44:49.877346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.259333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4cf55a8e-2d5e-437c-91e2-4509aaa4992b\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-06T21:44:49.877388Z","caller":"traceutil/trace.go:171","msg":"trace[1069626623] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4cf55a8e-2d5e-437c-91e2-4509aaa4992b; range_end:; response_count:1; response_revision:5525; }","duration":"136.353555ms","start":"2026-07-06T21:44:49.741021Z","end":"2026-07-06T21:44:49.877375Z","steps":["trace[1069626623] 'agreement among raft nodes before linearized reading' (duration: 136.081429ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:49.877357Z","caller":"traceutil/trace.go:171","msg":"trace[1257302925] transaction","detail":"{read_only:false; response_revision:5525; number_of_response:1; }","duration":"195.772772ms","start":"2026-07-06T21:44:49.681365Z","end":"2026-07-06T21:44:49.877138Z","steps":["trace[1257302925] 'process raft request' (duration: 139.818868ms)","trace[1257302925] 'compare' (duration: 55.608806ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:44:50.243787Z","caller":"traceutil/trace.go:171","msg":"trace[1082537142] transaction","detail":"{read_only:false; response_revision:5528; number_of_response:1; }","duration":"102.080852ms","start":"2026-07-06T21:44:50.141663Z","end":"2026-07-06T21:44:50.243744Z","steps":["trace[1082537142] 'process raft request' (duration: 58.795152ms)","trace[1082537142] 'compare' (duration: 43.050975ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:44:50.245605Z","caller":"traceutil/trace.go:171","msg":"trace[1267921850] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"103.756512ms","start":"2026-07-06T21:44:50.141814Z","end":"2026-07-06T21:44:50.245571Z","steps":["trace[1267921850] 'process raft request' (duration: 103.229759ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:50.245897Z","caller":"traceutil/trace.go:171","msg":"trace[750452295] transaction","detail":"{read_only:false; response_revision:5533; number_of_response:1; }","duration":"101.816215ms","start":"2026-07-06T21:44:50.144041Z","end":"2026-07-06T21:44:50.245857Z","steps":["trace[750452295] 'process raft request' (duration: 101.366935ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:50.246024Z","caller":"traceutil/trace.go:171","msg":"trace[1172853169] transaction","detail":"{read_only:false; response_revision:5534; number_of_response:1; }","duration":"100.770771ms","start":"2026-07-06T21:44:50.145225Z","end":"2026-07-06T21:44:50.245996Z","steps":["trace[1172853169] 'process raft request' (duration: 100.242177ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:50.246176Z","caller":"traceutil/trace.go:171","msg":"trace[1625502410] transaction","detail":"{read_only:false; response_revision:5531; number_of_response:1; }","duration":"103.25399ms","start":"2026-07-06T21:44:50.142868Z","end":"2026-07-06T21:44:50.246122Z","steps":["trace[1625502410] 'process raft request' (duration: 102.44913ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:50.246467Z","caller":"traceutil/trace.go:171","msg":"trace[1397606777] transaction","detail":"{read_only:false; response_revision:5532; number_of_response:1; }","duration":"103.306872ms","start":"2026-07-06T21:44:50.143146Z","end":"2026-07-06T21:44:50.246453Z","steps":["trace[1397606777] 'process raft request' (duration: 102.209325ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:44:50.246545Z","caller":"traceutil/trace.go:171","msg":"trace[1195850313] transaction","detail":"{read_only:false; response_revision:5530; number_of_response:1; }","duration":"104.464539ms","start":"2026-07-06T21:44:50.142026Z","end":"2026-07-06T21:44:50.24649Z","steps":["trace[1195850313] 'process raft request' (duration: 103.230999ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:45:49.182239Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3014} {"level":"info","ts":"2026-07-06T21:45:49.289492Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3014,"took":"105.182735ms","hash":2144104237,"current-db-size-bytes":58757120,"current-db-size":"59 MB","current-db-size-in-use-bytes":31633408,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-07-06T21:45:49.289579Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2144104237,"revision":3014,"compact-revision":-1} {"level":"info","ts":"2026-07-06T21:50:49.187689Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6085} {"level":"info","ts":"2026-07-06T21:50:49.291562Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6085,"took":"101.554517ms","hash":475253080,"current-db-size-bytes":58757120,"current-db-size":"59 MB","current-db-size-in-use-bytes":21913600,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-07-06T21:50:49.291629Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":475253080,"revision":6085,"compact-revision":3014} {"level":"warn","ts":"2026-07-06T21:51:06.931349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.68692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:51:06.931532Z","caller":"traceutil/trace.go:171","msg":"trace[496064778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8397; }","duration":"285.916405ms","start":"2026-07-06T21:51:06.645588Z","end":"2026-07-06T21:51:06.931505Z","steps":["trace[496064778] 'range keys from in-memory index tree' (duration: 285.581347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:51:06.931532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.85716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-06T21:51:06.931603Z","caller":"traceutil/trace.go:171","msg":"trace[2013244924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8397; }","duration":"121.982173ms","start":"2026-07-06T21:51:06.809605Z","end":"2026-07-06T21:51:06.931588Z","steps":["trace[2013244924] 'range keys from in-memory index tree' (duration: 121.634785ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:51:06.931729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.802688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-06T21:51:06.931807Z","caller":"traceutil/trace.go:171","msg":"trace[748093936] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8397; }","duration":"121.918671ms","start":"2026-07-06T21:51:06.809871Z","end":"2026-07-06T21:51:06.931789Z","steps":["trace[748093936] 'range keys from in-memory index tree' (duration: 121.583572ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:51:06.931732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.075465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-06T21:51:06.931926Z","caller":"traceutil/trace.go:171","msg":"trace[153686756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8397; }","duration":"122.294531ms","start":"2026-07-06T21:51:06.809605Z","end":"2026-07-06T21:51:06.9319Z","steps":["trace[153686756] 'range keys from in-memory index tree' (duration: 121.871841ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:51:07.04452Z","caller":"traceutil/trace.go:171","msg":"trace[570805901] transaction","detail":"{read_only:false; response_revision:8399; number_of_response:1; }","duration":"107.143943ms","start":"2026-07-06T21:51:06.93732Z","end":"2026-07-06T21:51:07.044464Z","steps":["trace[570805901] 'process raft request' (duration: 106.831275ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:51:07.044787Z","caller":"traceutil/trace.go:171","msg":"trace[594548157] transaction","detail":"{read_only:false; response_revision:8400; number_of_response:1; }","duration":"107.322447ms","start":"2026-07-06T21:51:06.937427Z","end":"2026-07-06T21:51:07.04475Z","steps":["trace[594548157] 'process raft request' (duration: 106.917207ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:51:18.587159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.599447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T21:51:18.587257Z","caller":"traceutil/trace.go:171","msg":"trace[682500119] linearizableReadLoop","detail":"{readStateIndex:8761; appliedIndex:8760; }","duration":"219.149292ms","start":"2026-07-06T21:51:18.368094Z","end":"2026-07-06T21:51:18.587243Z","steps":["trace[682500119] 'read index received' (duration: 112.196056ms)","trace[682500119] 'applied index is now lower than readState.Index' (duration: 106.951786ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:51:18.587289Z","caller":"traceutil/trace.go:171","msg":"trace[1948228926] transaction","detail":"{read_only:false; response_revision:8457; number_of_response:1; }","duration":"282.58969ms","start":"2026-07-06T21:51:18.304662Z","end":"2026-07-06T21:51:18.587252Z","steps":["trace[1948228926] 'process raft request' (duration: 175.819069ms)","trace[1948228926] 'compare' (duration: 106.493405ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:51:18.58743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.341287ms","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-07-06T21:51:18.587463Z","caller":"traceutil/trace.go:171","msg":"trace[659025298] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8457; }","duration":"219.425899ms","start":"2026-07-06T21:51:18.368026Z","end":"2026-07-06T21:51:18.587452Z","steps":["trace[659025298] 'agreement among raft nodes before linearized reading' (duration: 219.262435ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:51:18.738907Z","caller":"traceutil/trace.go:171","msg":"trace[1175374990] transaction","detail":"{read_only:false; response_revision:8459; number_of_response:1; }","duration":"106.775341ms","start":"2026-07-06T21:51:18.632072Z","end":"2026-07-06T21:51:18.738848Z","steps":["trace[1175374990] 'process raft request' (duration: 88.125999ms)","trace[1175374990] 'compare' (duration: 18.277644ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:51:19.460837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.809346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T21:51:19.460956Z","caller":"traceutil/trace.go:171","msg":"trace[401536324] transaction","detail":"{read_only:false; response_revision:8464; number_of_response:1; }","duration":"350.270996ms","start":"2026-07-06T21:51:19.110665Z","end":"2026-07-06T21:51:19.460936Z","steps":["trace[401536324] 'process raft request' (duration: 130.291465ms)","trace[401536324] 'compare' (duration: 219.261414ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:51:19.461052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-06T21:51:19.110636Z","time spent":"350.353077ms","remote":"127.0.0.1:37292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-06T21:51:47.415679Z","caller":"traceutil/trace.go:171","msg":"trace[52189652] transaction","detail":"{read_only:false; response_revision:8667; number_of_response:1; }","duration":"253.622239ms","start":"2026-07-06T21:51:47.162029Z","end":"2026-07-06T21:51:47.415651Z","steps":["trace[52189652] 'process raft request' (duration: 253.474795ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:51:47.416608Z","caller":"traceutil/trace.go:171","msg":"trace[1722424678] linearizableReadLoop","detail":"{readStateIndex:8979; appliedIndex:8978; }","duration":"142.719683ms","start":"2026-07-06T21:51:47.273852Z","end":"2026-07-06T21:51:47.416572Z","steps":["trace[1722424678] 'read index received' (duration: 141.946095ms)","trace[1722424678] 'applied index is now lower than readState.Index' (duration: 772.008µs)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:51:47.416723Z","caller":"traceutil/trace.go:171","msg":"trace[1679844924] transaction","detail":"{read_only:false; response_revision:8668; number_of_response:1; }","duration":"220.892602ms","start":"2026-07-06T21:51:47.19581Z","end":"2026-07-06T21:51:47.416703Z","steps":["trace[1679844924] 'process raft request' (duration: 220.552244ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:51:47.416926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.02767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-07-06T21:51:47.416986Z","caller":"traceutil/trace.go:171","msg":"trace[1880192391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8668; }","duration":"143.147823ms","start":"2026-07-06T21:51:47.273818Z","end":"2026-07-06T21:51:47.416966Z","steps":["trace[1880192391] 'agreement among raft nodes before linearized reading' (duration: 142.911337ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:51:51.559264Z","caller":"traceutil/trace.go:171","msg":"trace[1623174986] linearizableReadLoop","detail":"{readStateIndex:9001; appliedIndex:9000; }","duration":"123.305674ms","start":"2026-07-06T21:51:51.435928Z","end":"2026-07-06T21:51:51.559234Z","steps":["trace[1623174986] 'read index received' (duration: 122.948405ms)","trace[1623174986] 'applied index is now lower than readState.Index' (duration: 355.889µs)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:51:51.559435Z","caller":"traceutil/trace.go:171","msg":"trace[1493866756] transaction","detail":"{read_only:false; response_revision:8688; number_of_response:1; }","duration":"126.911638ms","start":"2026-07-06T21:51:51.432443Z","end":"2026-07-06T21:51:51.559355Z","steps":["trace[1493866756] 'process raft request' (duration: 126.59912ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:51:51.559604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.085595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-06T21:51:51.559664Z","caller":"traceutil/trace.go:171","msg":"trace[972803050] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8688; }","duration":"122.186188ms","start":"2026-07-06T21:51:51.437463Z","end":"2026-07-06T21:51:51.559649Z","steps":["trace[972803050] 'agreement among raft nodes before linearized reading' (duration: 121.993334ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:51:51.559711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.750323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-07-06T21:51:51.559841Z","caller":"traceutil/trace.go:171","msg":"trace[864452889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8688; }","duration":"123.935328ms","start":"2026-07-06T21:51:51.435863Z","end":"2026-07-06T21:51:51.559799Z","steps":["trace[864452889] 'agreement among raft nodes before linearized reading' (duration: 123.58042ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:51:51.695259Z","caller":"traceutil/trace.go:171","msg":"trace[2141172347] transaction","detail":"{read_only:false; response_revision:8689; number_of_response:1; }","duration":"131.042342ms","start":"2026-07-06T21:51:51.564192Z","end":"2026-07-06T21:51:51.695234Z","steps":["trace[2141172347] 'process raft request' (duration: 83.498832ms)","trace[2141172347] 'compare' (duration: 47.369406ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:51:51.695532Z","caller":"traceutil/trace.go:171","msg":"trace[2115380821] transaction","detail":"{read_only:false; response_revision:8690; number_of_response:1; }","duration":"130.627522ms","start":"2026-07-06T21:51:51.564871Z","end":"2026-07-06T21:51:51.695499Z","steps":["trace[2115380821] 'process raft request' (duration: 130.321975ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:51:51.824558Z","caller":"traceutil/trace.go:171","msg":"trace[1954565854] transaction","detail":"{read_only:false; response_revision:8691; number_of_response:1; }","duration":"124.362048ms","start":"2026-07-06T21:51:51.700173Z","end":"2026-07-06T21:51:51.824535Z","steps":["trace[1954565854] 'process raft request' (duration: 105.289597ms)","trace[1954565854] 'compare' (duration: 18.968558ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:51:59.8244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.066844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:51:59.824463Z","caller":"traceutil/trace.go:171","msg":"trace[1712221289] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:8773; }","duration":"109.162037ms","start":"2026-07-06T21:51:59.715285Z","end":"2026-07-06T21:51:59.824447Z","steps":["trace[1712221289] 'count revisions from in-memory index tree' (duration: 108.916621ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:52:00.077235Z","caller":"traceutil/trace.go:171","msg":"trace[1075560164] transaction","detail":"{read_only:false; response_revision:8775; number_of_response:1; }","duration":"249.78193ms","start":"2026-07-06T21:51:59.827435Z","end":"2026-07-06T21:52:00.077217Z","steps":["trace[1075560164] 'process raft request' (duration: 249.624576ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:52:00.110803Z","caller":"traceutil/trace.go:171","msg":"trace[668502784] transaction","detail":"{read_only:false; response_revision:8776; number_of_response:1; }","duration":"281.889992ms","start":"2026-07-06T21:51:59.828892Z","end":"2026-07-06T21:52:00.110782Z","steps":["trace[668502784] 'process raft request' (duration: 281.721418ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:52:00.110915Z","caller":"traceutil/trace.go:171","msg":"trace[1480630340] linearizableReadLoop","detail":"{readStateIndex:9094; appliedIndex:9091; }","duration":"256.585417ms","start":"2026-07-06T21:51:59.854321Z","end":"2026-07-06T21:52:00.110906Z","steps":["trace[1480630340] 'read index received' (duration: 222.805455ms)","trace[1480630340] 'applied index is now lower than readState.Index' (duration: 33.778792ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T21:52:00.111027Z","caller":"traceutil/trace.go:171","msg":"trace[1224010973] transaction","detail":"{read_only:false; response_revision:8777; number_of_response:1; }","duration":"280.259966ms","start":"2026-07-06T21:51:59.830715Z","end":"2026-07-06T21:52:00.110975Z","steps":["trace[1224010973] 'process raft request' (duration: 280.01643ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:52:00.111086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.761201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-06T21:52:00.111126Z","caller":"traceutil/trace.go:171","msg":"trace[1259829341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8777; }","duration":"256.858523ms","start":"2026-07-06T21:51:59.854259Z","end":"2026-07-06T21:52:00.111117Z","steps":["trace[1259829341] 'agreement among raft nodes before linearized reading' (duration: 256.699419ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T21:52:00.111128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.614247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-06T21:52:00.111216Z","caller":"traceutil/trace.go:171","msg":"trace[1183460584] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8777; }","duration":"157.757671ms","start":"2026-07-06T21:51:59.953437Z","end":"2026-07-06T21:52:00.111194Z","steps":["trace[1183460584] 'agreement among raft nodes before linearized reading' (duration: 157.591607ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:52:15.314305Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002409.wal"} {"level":"info","ts":"2026-07-06T21:53:33.237633Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"380f6760faea5f9e","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-06T21:53:33.242414Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-06T21:53:33.24251Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-06T21:55:49.195843Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8164} {"level":"info","ts":"2026-07-06T21:55:49.260335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8164,"took":"62.267094ms","hash":2144826788,"current-db-size-bytes":58757120,"current-db-size":"59 MB","current-db-size-in-use-bytes":28012544,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-06T21:55:49.260398Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2144826788,"revision":8164,"compact-revision":6085} {"level":"info","ts":"2026-07-06T21:58:56.708664Z","caller":"traceutil/trace.go:171","msg":"trace[52999264] linearizableReadLoop","detail":"{readStateIndex:12386; appliedIndex:12385; }","duration":"223.113148ms","start":"2026-07-06T21:58:56.485507Z","end":"2026-07-06T21:58:56.70862Z","steps":["trace[52999264] 'read index received' (duration: 198.926137ms)","trace[52999264] 'applied index is now lower than readState.Index' (duration: 24.185451ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T21:58:56.708936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.407776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T21:58:56.708986Z","caller":"traceutil/trace.go:171","msg":"trace[862225346] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:11971; }","duration":"223.476758ms","start":"2026-07-06T21:58:56.485493Z","end":"2026-07-06T21:58:56.70897Z","steps":["trace[862225346] 'agreement among raft nodes before linearized reading' (duration: 223.329084ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T21:58:56.709134Z","caller":"traceutil/trace.go:171","msg":"trace[435134074] transaction","detail":"{read_only:false; response_revision:11971; number_of_response:1; }","duration":"244.661938ms","start":"2026-07-06T21:58:56.464167Z","end":"2026-07-06T21:58:56.708829Z","steps":["trace[435134074] 'process raft request' (duration: 220.391955ms)","trace[435134074] 'compare' (duration: 23.525046ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T22:00:49.204635Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10532} {"level":"info","ts":"2026-07-06T22:00:49.285379Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10532,"took":"78.021509ms","hash":3672477951,"current-db-size-bytes":58757120,"current-db-size":"59 MB","current-db-size-in-use-bytes":26165248,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-07-06T22:00:49.285457Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3672477951,"revision":10532,"compact-revision":8164} {"level":"warn","ts":"2026-07-06T22:05:24.013991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.526743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-06T22:05:24.014103Z","caller":"traceutil/trace.go:171","msg":"trace[1552759783] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:14585; }","duration":"144.725759ms","start":"2026-07-06T22:05:23.869351Z","end":"2026-07-06T22:05:24.014077Z","steps":["trace[1552759783] 'count revisions from in-memory index tree' (duration: 144.44017ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T22:05:40.003316Z","caller":"traceutil/trace.go:171","msg":"trace[1351260806] linearizableReadLoop","detail":"{readStateIndex:15194; appliedIndex:15193; }","duration":"111.459832ms","start":"2026-07-06T22:05:39.891831Z","end":"2026-07-06T22:05:40.003291Z","steps":["trace[1351260806] 'read index received' (duration: 111.287638ms)","trace[1351260806] 'applied index is now lower than readState.Index' (duration: 171.244µs)"],"step_count":2} {"level":"warn","ts":"2026-07-06T22:05:40.003557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.713499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-qllx5\" ","response":"range_response_count:1 size:12364"} {"level":"info","ts":"2026-07-06T22:05:40.003532Z","caller":"traceutil/trace.go:171","msg":"trace[485113762] transaction","detail":"{read_only:false; response_revision:14682; number_of_response:1; }","duration":"163.813521ms","start":"2026-07-06T22:05:39.839676Z","end":"2026-07-06T22:05:40.003489Z","steps":["trace[485113762] 'process raft request' (duration: 163.473783ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T22:05:40.003607Z","caller":"traceutil/trace.go:171","msg":"trace[1034994194] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-qllx5; range_end:; response_count:1; response_revision:14682; }","duration":"111.823311ms","start":"2026-07-06T22:05:39.891771Z","end":"2026-07-06T22:05:40.003594Z","steps":["trace[1034994194] 'agreement among raft nodes before linearized reading' (duration: 111.639617ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T22:05:49.213435Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12727} {"level":"info","ts":"2026-07-06T22:05:49.287756Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12727,"took":"71.380739ms","hash":1220673287,"current-db-size-bytes":58757120,"current-db-size":"59 MB","current-db-size-in-use-bytes":27525120,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-06T22:05:49.28783Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1220673287,"revision":12727,"compact-revision":10532} {"level":"info","ts":"2026-07-06T22:06:02.170388Z","caller":"traceutil/trace.go:171","msg":"trace[1078464748] transaction","detail":"{read_only:false; response_revision:14994; number_of_response:1; }","duration":"111.865931ms","start":"2026-07-06T22:06:02.058494Z","end":"2026-07-06T22:06:02.17036Z","steps":["trace[1078464748] 'process raft request' (duration: 111.666716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T22:07:27.23989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.409811ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-06T22:07:27.240133Z","caller":"traceutil/trace.go:171","msg":"trace[395085794] transaction","detail":"{read_only:false; response_revision:15803; number_of_response:1; }","duration":"158.737647ms","start":"2026-07-06T22:07:27.08129Z","end":"2026-07-06T22:07:27.240028Z","steps":["trace[395085794] 'process raft request' (duration: 39.0805ms)","trace[395085794] 'compare' (duration: 119.299879ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T22:07:28.067457Z","caller":"traceutil/trace.go:171","msg":"trace[1906177950] transaction","detail":"{read_only:false; response_revision:15806; number_of_response:1; }","duration":"118.388846ms","start":"2026-07-06T22:07:27.948999Z","end":"2026-07-06T22:07:28.067388Z","steps":["trace[1906177950] 'process raft request' (duration: 118.085648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T22:07:28.365459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.302981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-h8jqb\" ","response":"range_response_count:1 size:22099"} {"level":"warn","ts":"2026-07-06T22:07:28.365488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.749658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-07-06T22:07:28.365551Z","caller":"traceutil/trace.go:171","msg":"trace[831646395] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-h8jqb; range_end:; response_count:1; response_revision:15806; }","duration":"232.459435ms","start":"2026-07-06T22:07:28.13307Z","end":"2026-07-06T22:07:28.365529Z","steps":["trace[831646395] 'range keys from in-memory index tree' (duration: 232.073505ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T22:07:28.365573Z","caller":"traceutil/trace.go:171","msg":"trace[208191893] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15806; }","duration":"206.897501ms","start":"2026-07-06T22:07:28.158653Z","end":"2026-07-06T22:07:28.365551Z","steps":["trace[208191893] 'range keys from in-memory index tree' (duration: 206.496621ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T22:07:28.366199Z","caller":"traceutil/trace.go:171","msg":"trace[1059088129] transaction","detail":"{read_only:false; response_revision:15807; number_of_response:1; }","duration":"174.653601ms","start":"2026-07-06T22:07:28.191498Z","end":"2026-07-06T22:07:28.366152Z","steps":["trace[1059088129] 'process raft request' (duration: 161.582136ms)","trace[1059088129] 'compare' (duration: 12.618294ms)"],"step_count":2} {"level":"info","ts":"2026-07-06T22:07:28.366238Z","caller":"traceutil/trace.go:171","msg":"trace[1763860970] linearizableReadLoop","detail":"{readStateIndex:16355; appliedIndex:16354; }","duration":"140.361461ms","start":"2026-07-06T22:07:28.225736Z","end":"2026-07-06T22:07:28.366097Z","steps":["trace[1763860970] 'read index received' (duration: 127.278896ms)","trace[1763860970] 'applied index is now lower than readState.Index' (duration: 13.059154ms)"],"step_count":2} {"level":"warn","ts":"2026-07-06T22:07:28.366527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.764081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-07-06T22:07:28.366605Z","caller":"traceutil/trace.go:171","msg":"trace[1640349136] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15807; }","duration":"140.910955ms","start":"2026-07-06T22:07:28.225673Z","end":"2026-07-06T22:07:28.366584Z","steps":["trace[1640349136] 'agreement among raft nodes before linearized reading' (duration: 140.627668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T22:07:28.366701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.741046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-07-06T22:07:28.366763Z","caller":"traceutil/trace.go:171","msg":"trace[217171811] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15807; }","duration":"139.872169ms","start":"2026-07-06T22:07:28.226876Z","end":"2026-07-06T22:07:28.366748Z","steps":["trace[217171811] 'agreement among raft nodes before linearized reading' (duration: 139.629163ms)"],"step_count":1} {"level":"warn","ts":"2026-07-06T22:07:28.367211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.347256ms","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-07-06T22:07:28.36726Z","caller":"traceutil/trace.go:171","msg":"trace[838855545] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15807; }","duration":"141.437728ms","start":"2026-07-06T22:07:28.225809Z","end":"2026-07-06T22:07:28.367247Z","steps":["trace[838855545] 'agreement among raft nodes before linearized reading' (duration: 140.616817ms)"],"step_count":1} {"level":"info","ts":"2026-07-06T22:10:49.220324Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14750} {"level":"info","ts":"2026-07-06T22:10:49.300017Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14750,"took":"75.474336ms","hash":312559998,"current-db-size-bytes":58757120,"current-db-size":"59 MB","current-db-size-in-use-bytes":33980416,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-06T22:10:49.300087Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":312559998,"revision":14750,"compact-revision":12727} {"level":"info","ts":"2026-07-06T22:15:49.227008Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17407} {"level":"info","ts":"2026-07-06T22:15:49.330338Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17407,"took":"100.535316ms","hash":3531170397,"current-db-size-bytes":58757120,"current-db-size":"59 MB","current-db-size-in-use-bytes":30015488,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-06T22:15:49.330401Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3531170397,"revision":17407,"compact-revision":14750} {"level":"info","ts":"2026-07-06T22:16:18.605649Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"380f6760faea5f9e","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-06T22:16:18.612036Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-07-06T22:16:18.612161Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-07-06T22:20:49.23403Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19178} {"level":"info","ts":"2026-07-06T22:20:49.321323Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19178,"took":"83.220046ms","hash":2330971491,"current-db-size-bytes":58757120,"current-db-size":"59 MB","current-db-size-in-use-bytes":23891968,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-07-06T22:20:49.321392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2330971491,"revision":19178,"compact-revision":17407}