{"level":"warn","ts":"2026-08-12T01:06:50.200024Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-12T01:06:50.200143Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.77: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.77:2380","--initial-cluster=instance=https://199.204.45.77:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.77:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.77: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-08-12T01:06:50.200241Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-12T01:06:50.200261Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-08-12T01:06:50.200288Z","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-08-12T01:06:50.201077Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"]} {"level":"info","ts":"2026-08-12T01:06:50.201178Z","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.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.77: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-08-12T01:06:50.20519Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.683615ms"} {"level":"info","ts":"2026-08-12T01:06:50.214421Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9133559b3198d4ec","cluster-id":"60f1aee33b0786f5"} {"level":"info","ts":"2026-08-12T01:06:50.214528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=()"} {"level":"info","ts":"2026-08-12T01:06:50.214556Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 0"} {"level":"info","ts":"2026-08-12T01:06:50.214577Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9133559b3198d4ec [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-12T01:06:50.214595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became follower at term 1"} {"level":"info","ts":"2026-08-12T01:06:50.214645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"warn","ts":"2026-08-12T01:06:50.219806Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-12T01:06:50.22211Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-12T01:06:50.223455Z","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-08-12T01:06:50.225318Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9133559b3198d4ec","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-12T01:06:50.22543Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9133559b3198d4ec","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-12T01:06:50.225674Z","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-08-12T01:06:50.225821Z","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-08-12T01:06:50.225837Z","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-08-12T01:06:50.226391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec switched to configuration voters=(10462800484352185580)"} {"level":"info","ts":"2026-08-12T01:06:50.226496Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","added-peer-id":"9133559b3198d4ec","added-peer-peer-urls":["https://199.204.45.77:2380"]} {"level":"info","ts":"2026-08-12T01:06:50.22812Z","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-08-12T01:06:50.228301Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-08-12T01:06:50.228386Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.77:2380"} {"level":"info","ts":"2026-08-12T01:06:50.229137Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9133559b3198d4ec","initial-advertise-peer-urls":["https://199.204.45.77:2380"],"listen-peer-urls":["https://199.204.45.77:2380"],"advertise-client-urls":["https://199.204.45.77:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.77:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-12T01:06:50.229222Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-12T01:06:51.21493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec is starting a new election at term 1"} {"level":"info","ts":"2026-08-12T01:06:51.215088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became pre-candidate at term 1"} {"level":"info","ts":"2026-08-12T01:06:51.215148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgPreVoteResp from 9133559b3198d4ec at term 1"} {"level":"info","ts":"2026-08-12T01:06:51.215199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became candidate at term 2"} {"level":"info","ts":"2026-08-12T01:06:51.215238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec received MsgVoteResp from 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-08-12T01:06:51.215277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9133559b3198d4ec became leader at term 2"} {"level":"info","ts":"2026-08-12T01:06:51.215311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9133559b3198d4ec elected leader 9133559b3198d4ec at term 2"} {"level":"info","ts":"2026-08-12T01:06:51.216623Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9133559b3198d4ec","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.77:2379]}","request-path":"/0/members/9133559b3198d4ec/attributes","cluster-id":"60f1aee33b0786f5","publish-timeout":"7s"} {"level":"info","ts":"2026-08-12T01:06:51.216687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T01:06:51.216619Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T01:06:51.216625Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-12T01:06:51.217101Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-12T01:06:51.217166Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-12T01:06:51.217888Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"60f1aee33b0786f5","local-member-id":"9133559b3198d4ec","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T01:06:51.218016Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T01:06:51.218052Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-12T01:06:51.220017Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.77:2379"} {"level":"info","ts":"2026-08-12T01:06:51.220625Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-12T01:06:54.564728Z","caller":"traceutil/trace.go:171","msg":"trace[714508850] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"199.825939ms","start":"2026-08-12T01:06:54.364877Z","end":"2026-08-12T01:06:54.564703Z","steps":["trace[714508850] 'process raft request' (duration: 199.736817ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:06:54.564827Z","caller":"traceutil/trace.go:171","msg":"trace[1085025677] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"201.804529ms","start":"2026-08-12T01:06:54.362979Z","end":"2026-08-12T01:06:54.564784Z","steps":["trace[1085025677] 'process raft request' (duration: 176.515511ms)","trace[1085025677] 'compare' (duration: 24.979292ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:07:00.873007Z","caller":"traceutil/trace.go:171","msg":"trace[1560153642] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"148.779301ms","start":"2026-08-12T01:07:00.724191Z","end":"2026-08-12T01:07:00.872971Z","steps":["trace[1560153642] 'process raft request' (duration: 148.602598ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:07:01.706119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.435543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-08-12T01:07:01.706256Z","caller":"traceutil/trace.go:171","msg":"trace[1845531088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:342; }","duration":"694.620927ms","start":"2026-08-12T01:07:01.011615Z","end":"2026-08-12T01:07:01.706236Z","steps":["trace[1845531088] 'range keys from in-memory index tree' (duration: 694.28963ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:07:01.706299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:07:01.011596Z","time spent":"694.691958ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-12T01:07:01.706301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.996527ms","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-08-12T01:07:01.706494Z","caller":"traceutil/trace.go:171","msg":"trace[888705438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:342; }","duration":"348.260893ms","start":"2026-08-12T01:07:01.358202Z","end":"2026-08-12T01:07:01.706463Z","steps":["trace[888705438] 'range keys from in-memory index tree' (duration: 347.808743ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:07:01.706563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:07:01.358177Z","time spent":"348.373916ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-12T01:07:02.019932Z","caller":"traceutil/trace.go:171","msg":"trace[2028220428] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"309.360755ms","start":"2026-08-12T01:07:01.710546Z","end":"2026-08-12T01:07:02.019906Z","steps":["trace[2028220428] 'process raft request' (duration: 309.203912ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:07:02.020553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:07:01.710513Z","time spent":"309.505258ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:07:02.059807Z","caller":"traceutil/trace.go:171","msg":"trace[1238012486] linearizableReadLoop","detail":"{readStateIndex:353; appliedIndex:351; }","duration":"204.193478ms","start":"2026-08-12T01:07:01.855591Z","end":"2026-08-12T01:07:02.059784Z","steps":["trace[1238012486] 'read index received' (duration: 164.286899ms)","trace[1238012486] 'applied index is now lower than readState.Index' (duration: 39.905669ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:07:02.059845Z","caller":"traceutil/trace.go:171","msg":"trace[1774483136] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"348.518869ms","start":"2026-08-12T01:07:01.711308Z","end":"2026-08-12T01:07:02.059827Z","steps":["trace[1774483136] 'process raft request' (duration: 348.339745ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:07:02.059918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.321871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-12T01:07:02.05995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:07:01.711274Z","time spent":"348.611211ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:07:02.059949Z","caller":"traceutil/trace.go:171","msg":"trace[932889388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:344; }","duration":"204.416023ms","start":"2026-08-12T01:07:01.855524Z","end":"2026-08-12T01:07:02.05994Z","steps":["trace[932889388] 'agreement among raft nodes before linearized reading' (duration: 204.349192ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:07:02.2592Z","caller":"traceutil/trace.go:171","msg":"trace[166042902] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"195.417119ms","start":"2026-08-12T01:07:02.063732Z","end":"2026-08-12T01:07:02.259149Z","steps":["trace[166042902] 'process raft request' (duration: 156.074512ms)","trace[166042902] 'compare' (duration: 39.088352ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:07:32.969282Z","caller":"traceutil/trace.go:171","msg":"trace[1136714985] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"115.353586ms","start":"2026-08-12T01:07:32.853897Z","end":"2026-08-12T01:07:32.969251Z","steps":["trace[1136714985] 'process raft request' (duration: 114.766694ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:07:33.598745Z","caller":"traceutil/trace.go:171","msg":"trace[1719471769] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"142.677836ms","start":"2026-08-12T01:07:33.456041Z","end":"2026-08-12T01:07:33.598719Z","steps":["trace[1719471769] 'process raft request' (duration: 141.989252ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:07:33.807081Z","caller":"traceutil/trace.go:171","msg":"trace[2036740964] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"144.564045ms","start":"2026-08-12T01:07:33.66249Z","end":"2026-08-12T01:07:33.807054Z","steps":["trace[2036740964] 'process raft request' (duration: 144.425162ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:07:33.824269Z","caller":"traceutil/trace.go:171","msg":"trace[1677935419] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"145.461903ms","start":"2026-08-12T01:07:33.678778Z","end":"2026-08-12T01:07:33.82424Z","steps":["trace[1677935419] 'process raft request' (duration: 145.265518ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:07:34.047764Z","caller":"traceutil/trace.go:171","msg":"trace[713941591] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"210.468107ms","start":"2026-08-12T01:07:33.837272Z","end":"2026-08-12T01:07:34.04774Z","steps":["trace[713941591] 'process raft request' (duration: 210.331454ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:09:01.284035Z","caller":"traceutil/trace.go:171","msg":"trace[610710933] transaction","detail":"{read_only:false; response_revision:1819; number_of_response:1; }","duration":"164.939313ms","start":"2026-08-12T01:09:01.119061Z","end":"2026-08-12T01:09:01.284Z","steps":["trace[610710933] 'process raft request' (duration: 134.979888ms)","trace[610710933] 'compare' (duration: 29.628629ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:09:01.761258Z","caller":"traceutil/trace.go:171","msg":"trace[116642974] transaction","detail":"{read_only:false; response_revision:1820; number_of_response:1; }","duration":"177.230565ms","start":"2026-08-12T01:09:01.584002Z","end":"2026-08-12T01:09:01.761232Z","steps":["trace[116642974] 'process raft request' (duration: 177.093782ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:09:01.76133Z","caller":"traceutil/trace.go:171","msg":"trace[204972757] linearizableReadLoop","detail":"{readStateIndex:1889; appliedIndex:1889; }","duration":"176.969839ms","start":"2026-08-12T01:09:01.584289Z","end":"2026-08-12T01:09:01.761259Z","steps":["trace[204972757] 'read index received' (duration: 176.941489ms)","trace[204972757] 'applied index is now lower than readState.Index' (duration: 15.44µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:09:01.761689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.344127ms","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-08-12T01:09:01.762199Z","caller":"traceutil/trace.go:171","msg":"trace[1224213731] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1820; }","duration":"177.94287ms","start":"2026-08-12T01:09:01.584241Z","end":"2026-08-12T01:09:01.762184Z","steps":["trace[1224213731] 'agreement among raft nodes before linearized reading' (duration: 177.177254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:09:14.931551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.120397ms","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-08-12T01:09:14.93165Z","caller":"traceutil/trace.go:171","msg":"trace[1057240856] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1927; }","duration":"182.254071ms","start":"2026-08-12T01:09:14.749371Z","end":"2026-08-12T01:09:14.931625Z","steps":["trace[1057240856] 'range keys from in-memory index tree' (duration: 181.972295ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:09:14.931791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.415793ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T01:09:14.931901Z","caller":"traceutil/trace.go:171","msg":"trace[688777302] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"160.369991ms","start":"2026-08-12T01:09:14.771513Z","end":"2026-08-12T01:09:14.931883Z","steps":["trace[688777302] 'process raft request' (duration: 18.58126ms)","trace[688777302] 'compare' (duration: 141.302121ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:09:51.397537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.738401ms","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-08-12T01:09:51.397669Z","caller":"traceutil/trace.go:171","msg":"trace[2017515594] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2137; }","duration":"260.916024ms","start":"2026-08-12T01:09:51.136723Z","end":"2026-08-12T01:09:51.397639Z","steps":["trace[2017515594] 'range keys from in-memory index tree' (duration: 260.479486ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:09:51.397664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.522728ms","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-08-12T01:09:51.397939Z","caller":"traceutil/trace.go:171","msg":"trace[1944390564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2137; }","duration":"224.861105ms","start":"2026-08-12T01:09:51.17306Z","end":"2026-08-12T01:09:51.397921Z","steps":["trace[1944390564] 'range keys from in-memory index tree' (duration: 224.290634ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:09:57.264064Z","caller":"traceutil/trace.go:171","msg":"trace[1133791209] linearizableReadLoop","detail":"{readStateIndex:2251; appliedIndex:2250; }","duration":"106.941575ms","start":"2026-08-12T01:09:57.157099Z","end":"2026-08-12T01:09:57.264041Z","steps":["trace[1133791209] 'read index received' (duration: 106.760332ms)","trace[1133791209] 'applied index is now lower than readState.Index' (duration: 180.513µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:09:57.26416Z","caller":"traceutil/trace.go:171","msg":"trace[1755948690] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"141.027774ms","start":"2026-08-12T01:09:57.123108Z","end":"2026-08-12T01:09:57.264136Z","steps":["trace[1755948690] 'process raft request' (duration: 140.758139ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:09:57.264195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.068238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/orders/\" range_end:\"/registry/acme.cert-manager.io/orders0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T01:09:57.264239Z","caller":"traceutil/trace.go:171","msg":"trace[382428929] range","detail":"{range_begin:/registry/acme.cert-manager.io/orders/; range_end:/registry/acme.cert-manager.io/orders0; response_count:0; response_revision:2170; }","duration":"107.17413ms","start":"2026-08-12T01:09:57.157054Z","end":"2026-08-12T01:09:57.264228Z","steps":["trace[382428929] 'agreement among raft nodes before linearized reading' (duration: 107.081788ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:09:57.738415Z","caller":"traceutil/trace.go:171","msg":"trace[931541009] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"237.808601ms","start":"2026-08-12T01:09:57.500583Z","end":"2026-08-12T01:09:57.738392Z","steps":["trace[931541009] 'process raft request' (duration: 237.697279ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:09:57.83011Z","caller":"traceutil/trace.go:171","msg":"trace[1365238217] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"282.08874ms","start":"2026-08-12T01:09:57.547994Z","end":"2026-08-12T01:09:57.830083Z","steps":["trace[1365238217] 'process raft request' (duration: 282.036529ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:09:57.830338Z","caller":"traceutil/trace.go:171","msg":"trace[952592] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"283.08986ms","start":"2026-08-12T01:09:57.547234Z","end":"2026-08-12T01:09:57.830324Z","steps":["trace[952592] 'process raft request' (duration: 282.390836ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:11:12.825379Z","caller":"traceutil/trace.go:171","msg":"trace[456983369] transaction","detail":"{read_only:false; response_revision:2776; number_of_response:1; }","duration":"125.074397ms","start":"2026-08-12T01:11:12.700268Z","end":"2026-08-12T01:11:12.825342Z","steps":["trace[456983369] 'process raft request' (duration: 124.818353ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:13:39.766049Z","caller":"traceutil/trace.go:171","msg":"trace[1992697133] linearizableReadLoop","detail":"{readStateIndex:3889; appliedIndex:3888; }","duration":"115.380668ms","start":"2026-08-12T01:13:39.650631Z","end":"2026-08-12T01:13:39.766011Z","steps":["trace[1992697133] 'read index received' (duration: 115.227935ms)","trace[1992697133] 'applied index is now lower than readState.Index' (duration: 151.063µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:13:39.766139Z","caller":"traceutil/trace.go:171","msg":"trace[1013804397] transaction","detail":"{read_only:false; response_revision:3748; number_of_response:1; }","duration":"158.933704ms","start":"2026-08-12T01:13:39.607172Z","end":"2026-08-12T01:13:39.766106Z","steps":["trace[1013804397] 'process raft request' (duration: 158.633408ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:13:39.766323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.674145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-12T01:13:39.766434Z","caller":"traceutil/trace.go:171","msg":"trace[725802946] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3748; }","duration":"115.844098ms","start":"2026-08-12T01:13:39.650568Z","end":"2026-08-12T01:13:39.766413Z","steps":["trace[725802946] 'agreement among raft nodes before linearized reading' (duration: 115.574163ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:13:39.870666Z","caller":"traceutil/trace.go:171","msg":"trace[1527904885] linearizableReadLoop","detail":"{readStateIndex:3890; appliedIndex:3889; }","duration":"100.291641ms","start":"2026-08-12T01:13:39.770333Z","end":"2026-08-12T01:13:39.870625Z","steps":["trace[1527904885] 'read index received' (duration: 97.676798ms)","trace[1527904885] 'applied index is now lower than readState.Index' (duration: 2.611893ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:13:39.871066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.68769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-08-12T01:13:39.871192Z","caller":"traceutil/trace.go:171","msg":"trace[1945975820] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3749; }","duration":"100.872233ms","start":"2026-08-12T01:13:39.770291Z","end":"2026-08-12T01:13:39.871163Z","steps":["trace[1945975820] 'agreement among raft nodes before linearized reading' (duration: 100.442214ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:15:18.833668Z","caller":"traceutil/trace.go:171","msg":"trace[1405531529] transaction","detail":"{read_only:false; response_revision:5209; number_of_response:1; }","duration":"132.755026ms","start":"2026-08-12T01:15:18.700887Z","end":"2026-08-12T01:15:18.833642Z","steps":["trace[1405531529] 'process raft request' (duration: 97.000675ms)","trace[1405531529] 'compare' (duration: 35.423764ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:15:19.292735Z","caller":"traceutil/trace.go:171","msg":"trace[1002687798] transaction","detail":"{read_only:false; response_revision:5213; number_of_response:1; }","duration":"410.187242ms","start":"2026-08-12T01:15:18.882523Z","end":"2026-08-12T01:15:19.292711Z","steps":["trace[1002687798] 'process raft request' (duration: 409.967097ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:15:19.292759Z","caller":"traceutil/trace.go:171","msg":"trace[1211907522] transaction","detail":"{read_only:false; response_revision:5214; number_of_response:1; }","duration":"409.417796ms","start":"2026-08-12T01:15:18.883316Z","end":"2026-08-12T01:15:19.292734Z","steps":["trace[1211907522] 'process raft request' (duration: 409.323254ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:15:19.292856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:15:18.882482Z","time spent":"410.309303ms","remote":"127.0.0.1:58632","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1068,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T01:15:19.292901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:15:18.8833Z","time spent":"409.525288ms","remote":"127.0.0.1:58534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:15:19.293011Z","caller":"traceutil/trace.go:171","msg":"trace[183731707] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"409.59556ms","start":"2026-08-12T01:15:18.883399Z","end":"2026-08-12T01:15:19.292995Z","steps":["trace[183731707] 'process raft request' (duration: 409.296424ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:15:19.293074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:15:18.883392Z","time spent":"409.649431ms","remote":"127.0.0.1:58534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:15:19.293169Z","caller":"traceutil/trace.go:171","msg":"trace[800193560] transaction","detail":"{read_only:false; response_revision:5216; number_of_response:1; }","duration":"404.304601ms","start":"2026-08-12T01:15:18.888841Z","end":"2026-08-12T01:15:19.293145Z","steps":["trace[800193560] 'process raft request' (duration: 404.065696ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:15:19.29334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:15:18.888826Z","time spent":"404.432064ms","remote":"127.0.0.1:58546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9560,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:15:19.293284Z","caller":"traceutil/trace.go:171","msg":"trace[1800930776] linearizableReadLoop","detail":"{readStateIndex:5408; appliedIndex:5404; }","duration":"300.245702ms","start":"2026-08-12T01:15:18.992885Z","end":"2026-08-12T01:15:19.293131Z","steps":["trace[1800930776] 'read index received' (duration: 299.565789ms)","trace[1800930776] 'applied index is now lower than readState.Index' (duration: 679.133µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:15:19.293406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.511477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T01:15:19.293506Z","caller":"traceutil/trace.go:171","msg":"trace[1027417682] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5216; }","duration":"300.62518ms","start":"2026-08-12T01:15:18.992843Z","end":"2026-08-12T01:15:19.293468Z","steps":["trace[1027417682] 'agreement among raft nodes before linearized reading' (duration: 300.465487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:15:19.293554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:15:18.992828Z","time spent":"300.716223ms","remote":"127.0.0.1:58860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":21,"response size":30,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"info","ts":"2026-08-12T01:15:19.479466Z","caller":"traceutil/trace.go:171","msg":"trace[1296137410] linearizableReadLoop","detail":"{readStateIndex:5409; appliedIndex:5408; }","duration":"186.045976ms","start":"2026-08-12T01:15:19.293389Z","end":"2026-08-12T01:15:19.479435Z","steps":["trace[1296137410] 'read index received' (duration: 148.963818ms)","trace[1296137410] 'applied index is now lower than readState.Index' (duration: 37.080888ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:15:19.47971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.585073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-12T01:15:19.479677Z","caller":"traceutil/trace.go:171","msg":"trace[223522896] transaction","detail":"{read_only:false; response_revision:5217; number_of_response:1; }","duration":"376.86976ms","start":"2026-08-12T01:15:19.102768Z","end":"2026-08-12T01:15:19.479638Z","steps":["trace[223522896] 'process raft request' (duration: 339.549947ms)","trace[223522896] 'compare' (duration: 37.005417ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:15:19.479776Z","caller":"traceutil/trace.go:171","msg":"trace[1313145502] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:5217; }","duration":"393.706855ms","start":"2026-08-12T01:15:19.086054Z","end":"2026-08-12T01:15:19.479761Z","steps":["trace[1313145502] 'agreement among raft nodes before linearized reading' (duration: 393.533361ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:15:19.479999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:15:19.102737Z","time spent":"377.112355ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T01:15:19.48001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:15:19.086036Z","time spent":"393.92328ms","remote":"127.0.0.1:58546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":43,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"info","ts":"2026-08-12T01:15:19.49229Z","caller":"traceutil/trace.go:171","msg":"trace[2065203249] transaction","detail":"{read_only:false; response_revision:5218; number_of_response:1; }","duration":"193.13157ms","start":"2026-08-12T01:15:19.299137Z","end":"2026-08-12T01:15:19.492268Z","steps":["trace[2065203249] 'process raft request' (duration: 192.944026ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:15:19.492534Z","caller":"traceutil/trace.go:171","msg":"trace[227930014] transaction","detail":"{read_only:false; response_revision:5219; number_of_response:1; }","duration":"193.305865ms","start":"2026-08-12T01:15:19.299207Z","end":"2026-08-12T01:15:19.492513Z","steps":["trace[227930014] 'process raft request' (duration: 192.999608ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:15:19.492708Z","caller":"traceutil/trace.go:171","msg":"trace[1247675594] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"188.923476ms","start":"2026-08-12T01:15:19.303764Z","end":"2026-08-12T01:15:19.492688Z","steps":["trace[1247675594] 'process raft request' (duration: 188.66287ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:15:19.492766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.57497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v2lqm\" ","response":"range_response_count:1 size:6520"} {"level":"warn","ts":"2026-08-12T01:15:19.492775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.192999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T01:15:19.492818Z","caller":"traceutil/trace.go:171","msg":"trace[159345734] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v2lqm; range_end:; response_count:1; response_revision:5220; }","duration":"191.655872ms","start":"2026-08-12T01:15:19.301146Z","end":"2026-08-12T01:15:19.492802Z","steps":["trace[159345734] 'agreement among raft nodes before linearized reading' (duration: 191.469488ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:15:19.492826Z","caller":"traceutil/trace.go:171","msg":"trace[2043842916] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5220; }","duration":"185.27874ms","start":"2026-08-12T01:15:19.307532Z","end":"2026-08-12T01:15:19.492811Z","steps":["trace[2043842916] 'agreement among raft nodes before linearized reading' (duration: 185.194588ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:16:51.247101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2984} {"level":"info","ts":"2026-08-12T01:16:51.32552Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2984,"took":"76.911733ms","hash":1004884702,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":34066432,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-12T01:16:51.325592Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1004884702,"revision":2984,"compact-revision":-1} {"level":"info","ts":"2026-08-12T01:21:50.553092Z","caller":"traceutil/trace.go:171","msg":"trace[1800871038] transaction","detail":"{read_only:false; response_revision:8301; number_of_response:1; }","duration":"128.13675ms","start":"2026-08-12T01:21:50.424933Z","end":"2026-08-12T01:21:50.553069Z","steps":["trace[1800871038] 'process raft request' (duration: 127.951736ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:21:50.578624Z","caller":"traceutil/trace.go:171","msg":"trace[1177239993] transaction","detail":"{read_only:false; response_revision:8302; number_of_response:1; }","duration":"115.120974ms","start":"2026-08-12T01:21:50.463483Z","end":"2026-08-12T01:21:50.578604Z","steps":["trace[1177239993] 'process raft request' (duration: 114.944891ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:21:51.098245Z","caller":"traceutil/trace.go:171","msg":"trace[113646898] transaction","detail":"{read_only:false; response_revision:8306; number_of_response:1; }","duration":"125.966564ms","start":"2026-08-12T01:21:50.972244Z","end":"2026-08-12T01:21:51.098211Z","steps":["trace[113646898] 'process raft request' (duration: 97.647038ms)","trace[113646898] 'compare' (duration: 28.170803ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:21:51.368859Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6139} {"level":"info","ts":"2026-08-12T01:21:51.77294Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6139,"took":"401.949886ms","hash":3805687245,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":23400448,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-12T01:21:51.773028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3805687245,"revision":6139,"compact-revision":2984} {"level":"info","ts":"2026-08-12T01:22:18.278358Z","caller":"traceutil/trace.go:171","msg":"trace[2036346188] transaction","detail":"{read_only:false; response_revision:8502; number_of_response:1; }","duration":"307.925121ms","start":"2026-08-12T01:22:17.970402Z","end":"2026-08-12T01:22:18.278327Z","steps":["trace[2036346188] 'process raft request' (duration: 307.608785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:22:18.278641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:22:17.970375Z","time spent":"308.168206ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:22:18.473868Z","caller":"traceutil/trace.go:171","msg":"trace[1613293628] linearizableReadLoop","detail":"{readStateIndex:8802; appliedIndex:8800; }","duration":"478.204319ms","start":"2026-08-12T01:22:17.995639Z","end":"2026-08-12T01:22:18.473843Z","steps":["trace[1613293628] 'read index received' (duration: 282.369051ms)","trace[1613293628] 'applied index is now lower than readState.Index' (duration: 195.834008ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:22:18.47392Z","caller":"traceutil/trace.go:171","msg":"trace[90907198] transaction","detail":"{read_only:false; response_revision:8503; number_of_response:1; }","duration":"485.190331ms","start":"2026-08-12T01:22:17.988706Z","end":"2026-08-12T01:22:18.473896Z","steps":["trace[90907198] 'process raft request' (duration: 467.844798ms)","trace[90907198] 'compare' (duration: 17.126099ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:22:18.473974Z","caller":"traceutil/trace.go:171","msg":"trace[1587834553] transaction","detail":"{read_only:false; response_revision:8504; number_of_response:1; }","duration":"461.125852ms","start":"2026-08-12T01:22:18.012838Z","end":"2026-08-12T01:22:18.473963Z","steps":["trace[1587834553] 'process raft request' (duration: 460.958748ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:22:18.474279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:22:18.012817Z","time spent":"461.404268ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T01:22:18.474282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:22:17.988691Z","time spent":"485.289474ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T01:22:18.474503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.871443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v2lqm\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-08-12T01:22:18.474541Z","caller":"traceutil/trace.go:171","msg":"trace[162906369] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v2lqm; range_end:; response_count:1; response_revision:8504; }","duration":"478.938894ms","start":"2026-08-12T01:22:17.995592Z","end":"2026-08-12T01:22:18.474531Z","steps":["trace[162906369] 'agreement among raft nodes before linearized reading' (duration: 478.795141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:22:18.474568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:22:17.995579Z","time spent":"478.982416ms","remote":"127.0.0.1:58546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6543,"request content":"key:\"/registry/pods/openstack/keepalived-v2lqm\" "} {"level":"warn","ts":"2026-08-12T01:22:18.486326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.193416ms","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-08-12T01:22:18.486378Z","caller":"traceutil/trace.go:171","msg":"trace[545463425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8505; }","duration":"467.313668ms","start":"2026-08-12T01:22:18.019053Z","end":"2026-08-12T01:22:18.486367Z","steps":["trace[545463425] 'agreement among raft nodes before linearized reading' (duration: 467.178555ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:22:18.486403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:22:18.019028Z","time spent":"467.370218ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-12T01:22:18.486476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.477841ms","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-08-12T01:22:18.486537Z","caller":"traceutil/trace.go:171","msg":"trace[1063993193] transaction","detail":"{read_only:false; response_revision:8505; number_of_response:1; }","duration":"180.636008ms","start":"2026-08-12T01:22:18.305891Z","end":"2026-08-12T01:22:18.486527Z","steps":["trace[1063993193] 'process raft request' (duration: 180.109947ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:22:18.486544Z","caller":"traceutil/trace.go:171","msg":"trace[386244653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8505; }","duration":"467.588683ms","start":"2026-08-12T01:22:18.018939Z","end":"2026-08-12T01:22:18.486527Z","steps":["trace[386244653] 'agreement among raft nodes before linearized reading' (duration: 467.412749ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:22:18.486633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.384612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-12T01:22:18.486616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:22:18.01892Z","time spent":"467.683455ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-12T01:22:18.486663Z","caller":"traceutil/trace.go:171","msg":"trace[751812021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8505; }","duration":"176.440743ms","start":"2026-08-12T01:22:18.310215Z","end":"2026-08-12T01:22:18.486655Z","steps":["trace[751812021] 'agreement among raft nodes before linearized reading' (duration: 176.396363ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:22:22.412451Z","caller":"traceutil/trace.go:171","msg":"trace[1250393465] linearizableReadLoop","detail":"{readStateIndex:8823; appliedIndex:8822; }","duration":"103.927537ms","start":"2026-08-12T01:22:22.3085Z","end":"2026-08-12T01:22:22.412427Z","steps":["trace[1250393465] 'read index received' (duration: 103.777284ms)","trace[1250393465] 'applied index is now lower than readState.Index' (duration: 149.033µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:22:22.412585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.0718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T01:22:22.412567Z","caller":"traceutil/trace.go:171","msg":"trace[1695750537] transaction","detail":"{read_only:false; response_revision:8523; number_of_response:1; }","duration":"119.7807ms","start":"2026-08-12T01:22:22.292753Z","end":"2026-08-12T01:22:22.412534Z","steps":["trace[1695750537] 'process raft request' (duration: 119.521705ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:22:22.412616Z","caller":"traceutil/trace.go:171","msg":"trace[1312758311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8523; }","duration":"104.162842ms","start":"2026-08-12T01:22:22.308444Z","end":"2026-08-12T01:22:22.412607Z","steps":["trace[1312758311] 'agreement among raft nodes before linearized reading' (duration: 104.07484ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:22:31.550131Z","caller":"traceutil/trace.go:171","msg":"trace[301224908] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"139.798097ms","start":"2026-08-12T01:22:31.410307Z","end":"2026-08-12T01:22:31.550106Z","steps":["trace[301224908] 'process raft request' (duration: 139.651863ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:23:09.759313Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000244e.wal"} {"level":"info","ts":"2026-08-12T01:24:29.174582Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-12T01:24:29.184551Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-12T01:24:29.184652Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-12T01:26:51.376413Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8307} {"level":"info","ts":"2026-08-12T01:26:51.459637Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8307,"took":"80.051185ms","hash":3471341087,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":25366528,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-08-12T01:26:51.459713Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3471341087,"revision":8307,"compact-revision":6139} {"level":"info","ts":"2026-08-12T01:31:51.382425Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10789} {"level":"info","ts":"2026-08-12T01:31:51.462241Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10789,"took":"77.612305ms","hash":2988807493,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":27525120,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-12T01:31:51.462324Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2988807493,"revision":10789,"compact-revision":8307} {"level":"warn","ts":"2026-08-12T01:34:33.926133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.620954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T01:34:33.926238Z","caller":"traceutil/trace.go:171","msg":"trace[405478882] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:13978; }","duration":"106.792658ms","start":"2026-08-12T01:34:33.819422Z","end":"2026-08-12T01:34:33.926214Z","steps":["trace[405478882] 'count revisions from in-memory index tree' (duration: 106.533293ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:35:13.236257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.955302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-v2lqm\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-08-12T01:35:13.236371Z","caller":"traceutil/trace.go:171","msg":"trace[198851660] range","detail":"{range_begin:/registry/pods/openstack/keepalived-v2lqm; range_end:; response_count:1; response_revision:14194; }","duration":"296.144246ms","start":"2026-08-12T01:35:12.940203Z","end":"2026-08-12T01:35:13.236348Z","steps":["trace[198851660] 'range keys from in-memory index tree' (duration: 295.758259ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:35:13.236511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.448287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-12T01:35:13.236558Z","caller":"traceutil/trace.go:171","msg":"trace[460912587] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:14194; }","duration":"181.541599ms","start":"2026-08-12T01:35:13.055005Z","end":"2026-08-12T01:35:13.236546Z","steps":["trace[460912587] 'count revisions from in-memory index tree' (duration: 181.373406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:35:13.236585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.804548ms","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-08-12T01:35:13.236677Z","caller":"traceutil/trace.go:171","msg":"trace[117245884] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:14194; }","duration":"293.92242ms","start":"2026-08-12T01:35:12.942735Z","end":"2026-08-12T01:35:13.236657Z","steps":["trace[117245884] 'range keys from in-memory index tree' (duration: 293.596114ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:35:13.236847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.301146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-12T01:35:13.236899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.706432ms","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-08-12T01:35:13.236933Z","caller":"traceutil/trace.go:171","msg":"trace[1343432301] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14194; }","duration":"286.788314ms","start":"2026-08-12T01:35:12.950136Z","end":"2026-08-12T01:35:13.236925Z","steps":["trace[1343432301] 'range keys from in-memory index tree' (duration: 286.59273ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:35:13.236898Z","caller":"traceutil/trace.go:171","msg":"trace[462583255] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:14194; }","duration":"330.401958ms","start":"2026-08-12T01:35:12.906482Z","end":"2026-08-12T01:35:13.236884Z","steps":["trace[462583255] 'count revisions from in-memory index tree' (duration: 330.155333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:35:13.237074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:35:12.906446Z","time spent":"330.615322ms","remote":"127.0.0.1:58528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":9,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-08-12T01:35:23.059501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.230473ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-12T01:35:23.059768Z","caller":"traceutil/trace.go:171","msg":"trace[1700805243] transaction","detail":"{read_only:false; response_revision:14365; number_of_response:1; }","duration":"230.43356ms","start":"2026-08-12T01:35:22.829287Z","end":"2026-08-12T01:35:23.05972Z","steps":["trace[1700805243] 'process raft request' (duration: 109.897901ms)","trace[1700805243] 'compare' (duration: 119.868596ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:36:51.389015Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12961} {"level":"info","ts":"2026-08-12T01:36:51.466392Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12961,"took":"74.348254ms","hash":2285696641,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":29913088,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-12T01:36:51.466441Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2285696641,"revision":12961,"compact-revision":10789} {"level":"info","ts":"2026-08-12T01:37:03.808728Z","caller":"traceutil/trace.go:171","msg":"trace[1696878624] linearizableReadLoop","detail":"{readStateIndex:15983; appliedIndex:15982; }","duration":"100.623751ms","start":"2026-08-12T01:37:03.708081Z","end":"2026-08-12T01:37:03.808704Z","steps":["trace[1696878624] 'read index received' (duration: 100.422116ms)","trace[1696878624] 'applied index is now lower than readState.Index' (duration: 200.365µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:37:03.809085Z","caller":"traceutil/trace.go:171","msg":"trace[620077199] transaction","detail":"{read_only:false; response_revision:15457; number_of_response:1; }","duration":"253.770058ms","start":"2026-08-12T01:37:03.5553Z","end":"2026-08-12T01:37:03.80907Z","steps":["trace[620077199] 'process raft request' (duration: 253.264487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:37:03.809291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.199602ms","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-08-12T01:37:03.809332Z","caller":"traceutil/trace.go:171","msg":"trace[105978542] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15457; }","duration":"101.295544ms","start":"2026-08-12T01:37:03.708024Z","end":"2026-08-12T01:37:03.809319Z","steps":["trace[105978542] 'agreement among raft nodes before linearized reading' (duration: 101.227683ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:37:03.809527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.347905ms","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-08-12T01:37:03.80956Z","caller":"traceutil/trace.go:171","msg":"trace[1564864808] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:15457; }","duration":"101.405767ms","start":"2026-08-12T01:37:03.708146Z","end":"2026-08-12T01:37:03.809552Z","steps":["trace[1564864808] 'agreement among raft nodes before linearized reading' (duration: 101.357346ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:37:03.810162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.940048ms","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-08-12T01:37:03.810203Z","caller":"traceutil/trace.go:171","msg":"trace[216071447] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15457; }","duration":"101.000809ms","start":"2026-08-12T01:37:03.709192Z","end":"2026-08-12T01:37:03.810193Z","steps":["trace[216071447] 'agreement among raft nodes before linearized reading' (duration: 100.899527ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:37:03.810348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.120781ms","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-08-12T01:37:03.810378Z","caller":"traceutil/trace.go:171","msg":"trace[1359776810] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:15457; }","duration":"102.181573ms","start":"2026-08-12T01:37:03.708189Z","end":"2026-08-12T01:37:03.81037Z","steps":["trace[1359776810] 'agreement among raft nodes before linearized reading' (duration: 102.139202ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:37:03.987333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.891876ms","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-08-12T01:37:03.987414Z","caller":"traceutil/trace.go:171","msg":"trace[1122430202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:15457; }","duration":"140.002249ms","start":"2026-08-12T01:37:03.847395Z","end":"2026-08-12T01:37:03.987397Z","steps":["trace[1122430202] 'range keys from in-memory index tree' (duration: 139.780353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:37:03.987717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.504202ms","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-08-12T01:37:03.987752Z","caller":"traceutil/trace.go:171","msg":"trace[1662593294] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15457; }","duration":"148.579704ms","start":"2026-08-12T01:37:03.839164Z","end":"2026-08-12T01:37:03.987743Z","steps":["trace[1662593294] 'range keys from in-memory index tree' (duration: 148.39264ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:39:55.103083Z","caller":"traceutil/trace.go:171","msg":"trace[585518583] transaction","detail":"{read_only:false; response_revision:16845; number_of_response:1; }","duration":"149.482979ms","start":"2026-08-12T01:39:54.953573Z","end":"2026-08-12T01:39:55.103056Z","steps":["trace[585518583] 'process raft request' (duration: 149.304926ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:39:55.1038Z","caller":"traceutil/trace.go:171","msg":"trace[330324326] linearizableReadLoop","detail":"{readStateIndex:17417; appliedIndex:17417; }","duration":"145.445577ms","start":"2026-08-12T01:39:54.95831Z","end":"2026-08-12T01:39:55.103756Z","steps":["trace[330324326] 'read index received' (duration: 145.426306ms)","trace[330324326] 'applied index is now lower than readState.Index' (duration: 16.661µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:39:55.10522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.905067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:90 size:893047"} {"level":"info","ts":"2026-08-12T01:39:55.105313Z","caller":"traceutil/trace.go:171","msg":"trace[844700137] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:90; response_revision:16845; }","duration":"147.05919ms","start":"2026-08-12T01:39:54.958235Z","end":"2026-08-12T01:39:55.105294Z","steps":["trace[844700137] 'agreement among raft nodes before linearized reading' (duration: 145.647752ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:39:55.111833Z","caller":"traceutil/trace.go:171","msg":"trace[1417949937] transaction","detail":"{read_only:false; response_revision:16846; number_of_response:1; }","duration":"147.170741ms","start":"2026-08-12T01:39:54.964639Z","end":"2026-08-12T01:39:55.111809Z","steps":["trace[1417949937] 'process raft request' (duration: 146.887626ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:39:55.112198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.545536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-zmvb2\" ","response":"range_response_count:1 size:22122"} {"level":"info","ts":"2026-08-12T01:39:55.112259Z","caller":"traceutil/trace.go:171","msg":"trace[81039626] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-zmvb2; range_end:; response_count:1; response_revision:16846; }","duration":"109.686458ms","start":"2026-08-12T01:39:55.00256Z","end":"2026-08-12T01:39:55.112247Z","steps":["trace[81039626] 'agreement among raft nodes before linearized reading' (duration: 109.137356ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:41:51.395517Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15394} {"level":"info","ts":"2026-08-12T01:41:51.492742Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15394,"took":"93.839125ms","hash":1182572089,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":31846400,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-12T01:41:51.492789Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1182572089,"revision":15394,"compact-revision":12961} {"level":"info","ts":"2026-08-12T01:42:39.92945Z","caller":"traceutil/trace.go:171","msg":"trace[1798188737] linearizableReadLoop","detail":"{readStateIndex:18642; appliedIndex:18639; }","duration":"148.370776ms","start":"2026-08-12T01:42:39.781026Z","end":"2026-08-12T01:42:39.929397Z","steps":["trace[1798188737] 'read index received' (duration: 76.705285ms)","trace[1798188737] 'applied index is now lower than readState.Index' (duration: 71.664271ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:42:39.929697Z","caller":"traceutil/trace.go:171","msg":"trace[1361338635] transaction","detail":"{read_only:false; response_revision:18031; number_of_response:1; }","duration":"177.879278ms","start":"2026-08-12T01:42:39.751795Z","end":"2026-08-12T01:42:39.929674Z","steps":["trace[1361338635] 'process raft request' (duration: 177.409179ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:42:39.929849Z","caller":"traceutil/trace.go:171","msg":"trace[180118974] transaction","detail":"{read_only:false; response_revision:18032; number_of_response:1; }","duration":"177.587392ms","start":"2026-08-12T01:42:39.752241Z","end":"2026-08-12T01:42:39.929828Z","steps":["trace[180118974] 'process raft request' (duration: 177.096292ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:42:39.930029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.984329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-12T01:42:39.930074Z","caller":"traceutil/trace.go:171","msg":"trace[581341352] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18032; }","duration":"149.074981ms","start":"2026-08-12T01:42:39.780989Z","end":"2026-08-12T01:42:39.930064Z","steps":["trace[581341352] 'agreement among raft nodes before linearized reading' (duration: 148.928118ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:42:39.932892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.23836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-q4pg2\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-08-12T01:42:39.932989Z","caller":"traceutil/trace.go:171","msg":"trace[714121811] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-q4pg2; range_end:; response_count:1; response_revision:18032; }","duration":"137.381422ms","start":"2026-08-12T01:42:39.795578Z","end":"2026-08-12T01:42:39.932959Z","steps":["trace[714121811] 'agreement among raft nodes before linearized reading' (duration: 134.453182ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:42:39.933137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.232789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-08-12T01:42:39.933208Z","caller":"traceutil/trace.go:171","msg":"trace[1083315247] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18032; }","duration":"139.337622ms","start":"2026-08-12T01:42:39.793853Z","end":"2026-08-12T01:42:39.93319Z","steps":["trace[1083315247] 'agreement among raft nodes before linearized reading' (duration: 136.136576ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:42:39.933292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.157419ms","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-08-12T01:42:39.933334Z","caller":"traceutil/trace.go:171","msg":"trace[1786216139] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:18032; }","duration":"116.20218ms","start":"2026-08-12T01:42:39.817122Z","end":"2026-08-12T01:42:39.933324Z","steps":["trace[1786216139] 'agreement among raft nodes before linearized reading' (duration: 112.897122ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:42:47.416663Z","caller":"traceutil/trace.go:171","msg":"trace[597458039] transaction","detail":"{read_only:false; response_revision:18092; number_of_response:1; }","duration":"272.827597ms","start":"2026-08-12T01:42:47.143807Z","end":"2026-08-12T01:42:47.416634Z","steps":["trace[597458039] 'process raft request' (duration: 268.319574ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:42:47.638025Z","caller":"traceutil/trace.go:171","msg":"trace[1318226462] transaction","detail":"{read_only:false; response_revision:18093; number_of_response:1; }","duration":"369.163741ms","start":"2026-08-12T01:42:47.26883Z","end":"2026-08-12T01:42:47.637993Z","steps":["trace[1318226462] 'process raft request' (duration: 329.827418ms)","trace[1318226462] 'compare' (duration: 39.133729ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:42:47.638194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:42:47.268798Z","time spent":"369.310384ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:42:47.638486Z","caller":"traceutil/trace.go:171","msg":"trace[547767386] transaction","detail":"{read_only:false; response_revision:18094; number_of_response:1; }","duration":"368.820214ms","start":"2026-08-12T01:42:47.269639Z","end":"2026-08-12T01:42:47.638459Z","steps":["trace[547767386] 'process raft request' (duration: 368.307614ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:42:47.638634Z","caller":"traceutil/trace.go:171","msg":"trace[915755162] linearizableReadLoop","detail":"{readStateIndex:18706; appliedIndex:18702; }","duration":"328.94487ms","start":"2026-08-12T01:42:47.309579Z","end":"2026-08-12T01:42:47.638524Z","steps":["trace[915755162] 'read index received' (duration: 102.640673ms)","trace[915755162] 'applied index is now lower than readState.Index' (duration: 226.302707ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:42:47.638879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:42:47.269609Z","time spent":"368.933346ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:42:47.638954Z","caller":"traceutil/trace.go:171","msg":"trace[1335562297] transaction","detail":"{read_only:false; response_revision:18095; number_of_response:1; }","duration":"331.264658ms","start":"2026-08-12T01:42:47.307674Z","end":"2026-08-12T01:42:47.638938Z","steps":["trace[1335562297] 'process raft request' (duration: 330.712027ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:42:47.639149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.209871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-zmvb2\" ","response":"range_response_count:1 size:22122"} {"level":"info","ts":"2026-08-12T01:42:47.639196Z","caller":"traceutil/trace.go:171","msg":"trace[1216010452] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-zmvb2; range_end:; response_count:1; response_revision:18095; }","duration":"119.302073ms","start":"2026-08-12T01:42:47.519881Z","end":"2026-08-12T01:42:47.639183Z","steps":["trace[1216010452] 'agreement among raft nodes before linearized reading' (duration: 119.137999ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:42:47.639176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.575713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:42:47.639283Z","caller":"traceutil/trace.go:171","msg":"trace[1106889186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18095; }","duration":"329.714255ms","start":"2026-08-12T01:42:47.309541Z","end":"2026-08-12T01:42:47.639255Z","steps":["trace[1106889186] 'agreement among raft nodes before linearized reading' (duration: 329.512901ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:42:47.639338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:42:47.30952Z","time spent":"329.810118ms","remote":"127.0.0.1:58388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-12T01:42:47.639187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:42:47.307645Z","time spent":"331.348409ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:45:14.474373Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-12T01:45:14.480671Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-12T01:45:14.480755Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-12T01:46:51.410186Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17612} {"level":"info","ts":"2026-08-12T01:46:51.507653Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17612,"took":"93.847405ms","hash":2967290634,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":34066432,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-12T01:46:51.507733Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2967290634,"revision":17612,"compact-revision":15394} {"level":"info","ts":"2026-08-12T01:48:23.143303Z","caller":"traceutil/trace.go:171","msg":"trace[395747769] transaction","detail":"{read_only:false; response_revision:20630; number_of_response:1; }","duration":"131.581684ms","start":"2026-08-12T01:48:23.011676Z","end":"2026-08-12T01:48:23.143257Z","steps":["trace[395747769] 'process raft request' (duration: 125.659913ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:48:23.618403Z","caller":"traceutil/trace.go:171","msg":"trace[1191324388] transaction","detail":"{read_only:false; response_revision:20632; number_of_response:1; }","duration":"286.665087ms","start":"2026-08-12T01:48:23.331712Z","end":"2026-08-12T01:48:23.618377Z","steps":["trace[1191324388] 'process raft request' (duration: 286.483663ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:48:23.665617Z","caller":"traceutil/trace.go:171","msg":"trace[72696256] linearizableReadLoop","detail":"{readStateIndex:21329; appliedIndex:21328; }","duration":"253.199945ms","start":"2026-08-12T01:48:23.412343Z","end":"2026-08-12T01:48:23.665543Z","steps":["trace[72696256] 'read index received' (duration: 206.584353ms)","trace[72696256] 'applied index is now lower than readState.Index' (duration: 46.614322ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:48:23.665909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.529951ms","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-08-12T01:48:23.665948Z","caller":"traceutil/trace.go:171","msg":"trace[450738300] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20633; }","duration":"253.661343ms","start":"2026-08-12T01:48:23.412273Z","end":"2026-08-12T01:48:23.665935Z","steps":["trace[450738300] 'agreement among raft nodes before linearized reading' (duration: 253.440659ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:48:23.665924Z","caller":"traceutil/trace.go:171","msg":"trace[165457863] transaction","detail":"{read_only:false; response_revision:20633; number_of_response:1; }","duration":"311.590736ms","start":"2026-08-12T01:48:23.354305Z","end":"2026-08-12T01:48:23.665896Z","steps":["trace[165457863] 'process raft request' (duration: 310.954803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:48:23.666078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:48:23.354273Z","time spent":"311.723129ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:48:23.810508Z","caller":"traceutil/trace.go:171","msg":"trace[1364742614] transaction","detail":"{read_only:false; response_revision:20634; number_of_response:1; }","duration":"140.094418ms","start":"2026-08-12T01:48:23.670372Z","end":"2026-08-12T01:48:23.810466Z","steps":["trace[1364742614] 'process raft request' (duration: 99.5451ms)","trace[1364742614] 'compare' (duration: 40.369344ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:51:51.417342Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20046} {"level":"info","ts":"2026-08-12T01:51:51.533334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20046,"took":"110.32892ms","hash":2821757876,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":30846976,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-12T01:51:51.533429Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2821757876,"revision":20046,"compact-revision":17612} {"level":"info","ts":"2026-08-12T01:52:18.124516Z","caller":"traceutil/trace.go:171","msg":"trace[412734583] transaction","detail":"{read_only:false; response_revision:23072; number_of_response:1; }","duration":"141.787436ms","start":"2026-08-12T01:52:17.982694Z","end":"2026-08-12T01:52:18.124481Z","steps":["trace[412734583] 'process raft request' (duration: 141.52479ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:52:18.412636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.450769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-12T01:52:18.412722Z","caller":"traceutil/trace.go:171","msg":"trace[584032535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23073; }","duration":"145.581933ms","start":"2026-08-12T01:52:18.26712Z","end":"2026-08-12T01:52:18.412702Z","steps":["trace[584032535] 'range keys from in-memory index tree' (duration: 145.252035ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:52:18.413289Z","caller":"traceutil/trace.go:171","msg":"trace[268112998] transaction","detail":"{read_only:false; response_revision:23074; number_of_response:1; }","duration":"117.369937ms","start":"2026-08-12T01:52:18.295891Z","end":"2026-08-12T01:52:18.413261Z","steps":["trace[268112998] 'process raft request' (duration: 111.387925ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:06.085068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.625939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:06.085209Z","caller":"traceutil/trace.go:171","msg":"trace[1712697677] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:25341; }","duration":"111.852593ms","start":"2026-08-12T01:56:05.97332Z","end":"2026-08-12T01:56:06.085173Z","steps":["trace[1712697677] 'count revisions from in-memory index tree' (duration: 111.427845ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:06.320269Z","caller":"traceutil/trace.go:171","msg":"trace[1704183125] linearizableReadLoop","detail":"{readStateIndex:26174; appliedIndex:26173; }","duration":"130.164897ms","start":"2026-08-12T01:56:06.190083Z","end":"2026-08-12T01:56:06.320248Z","steps":["trace[1704183125] 'read index received' (duration: 129.974054ms)","trace[1704183125] 'applied index is now lower than readState.Index' (duration: 189.403µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:06.320558Z","caller":"traceutil/trace.go:171","msg":"trace[1157354122] transaction","detail":"{read_only:false; response_revision:25342; number_of_response:1; }","duration":"168.266967ms","start":"2026-08-12T01:56:06.152282Z","end":"2026-08-12T01:56:06.320549Z","steps":["trace[1157354122] 'process raft request' (duration: 167.798567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:06.321015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.909713ms","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-08-12T01:56:06.321112Z","caller":"traceutil/trace.go:171","msg":"trace[1719339489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25342; }","duration":"131.060996ms","start":"2026-08-12T01:56:06.19003Z","end":"2026-08-12T01:56:06.321091Z","steps":["trace[1719339489] 'agreement among raft nodes before linearized reading' (duration: 130.74482ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:06.572674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.186239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-08-12T01:56:06.572792Z","caller":"traceutil/trace.go:171","msg":"trace[1564978793] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25343; }","duration":"133.358763ms","start":"2026-08-12T01:56:06.439408Z","end":"2026-08-12T01:56:06.572767Z","steps":["trace[1564978793] 'range keys from in-memory index tree' (duration: 132.989205ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:06.573233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.200433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-12T01:56:06.573317Z","caller":"traceutil/trace.go:171","msg":"trace[1472941774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25343; }","duration":"140.334176ms","start":"2026-08-12T01:56:06.432963Z","end":"2026-08-12T01:56:06.573297Z","steps":["trace[1472941774] 'range keys from in-memory index tree' (duration: 140.03388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:06.573283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.48379ms","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-08-12T01:56:06.573411Z","caller":"traceutil/trace.go:171","msg":"trace[1710730688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25343; }","duration":"141.703115ms","start":"2026-08-12T01:56:06.431683Z","end":"2026-08-12T01:56:06.573386Z","steps":["trace[1710730688] 'range keys from in-memory index tree' (duration: 141.299956ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:06.998276Z","caller":"traceutil/trace.go:171","msg":"trace[113215226] transaction","detail":"{read_only:false; response_revision:25344; number_of_response:1; }","duration":"418.046587ms","start":"2026-08-12T01:56:06.580205Z","end":"2026-08-12T01:56:06.998252Z","steps":["trace[113215226] 'process raft request' (duration: 417.889334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:06.998421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:06.580175Z","time spent":"418.170359ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:07.036603Z","caller":"traceutil/trace.go:171","msg":"trace[1430881882] transaction","detail":"{read_only:false; response_revision:25345; number_of_response:1; }","duration":"456.350969ms","start":"2026-08-12T01:56:06.580216Z","end":"2026-08-12T01:56:07.036567Z","steps":["trace[1430881882] 'process raft request' (duration: 456.057833ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:07.036821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:06.580187Z","time spent":"456.513222ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:07.037028Z","caller":"traceutil/trace.go:171","msg":"trace[1780385567] linearizableReadLoop","detail":"{readStateIndex:26178; appliedIndex:26176; }","duration":"337.864368ms","start":"2026-08-12T01:56:06.699135Z","end":"2026-08-12T01:56:07.036999Z","steps":["trace[1780385567] 'read index received' (duration: 299.69363ms)","trace[1780385567] 'applied index is now lower than readState.Index' (duration: 38.169278ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:07.03709Z","caller":"traceutil/trace.go:171","msg":"trace[536914982] transaction","detail":"{read_only:false; response_revision:25347; number_of_response:1; }","duration":"331.593411ms","start":"2026-08-12T01:56:06.705472Z","end":"2026-08-12T01:56:07.037065Z","steps":["trace[536914982] 'process raft request' (duration: 331.359156ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:07.037183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:06.705436Z","time spent":"331.698413ms","remote":"127.0.0.1:58626","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-08-12T01:56:07.037167Z","caller":"traceutil/trace.go:171","msg":"trace[1836480921] transaction","detail":"{read_only:false; response_revision:25346; number_of_response:1; }","duration":"456.867679ms","start":"2026-08-12T01:56:06.580266Z","end":"2026-08-12T01:56:07.037134Z","steps":["trace[1836480921] 'process raft request' (duration: 456.197196ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:07.037191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.046502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:07.037253Z","caller":"traceutil/trace.go:171","msg":"trace[2032680909] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:25347; }","duration":"338.131734ms","start":"2026-08-12T01:56:06.699103Z","end":"2026-08-12T01:56:07.037234Z","steps":["trace[2032680909] 'agreement among raft nodes before linearized reading' (duration: 338.013022ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:07.037295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:06.699012Z","time spent":"338.271747ms","remote":"127.0.0.1:39802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-08-12T01:56:07.037332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:06.580233Z","time spent":"457.010022ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T01:56:07.349116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.783766ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:56:07.349219Z","caller":"traceutil/trace.go:171","msg":"trace[1230688988] transaction","detail":"{read_only:false; response_revision:25348; number_of_response:1; }","duration":"277.358993ms","start":"2026-08-12T01:56:07.07184Z","end":"2026-08-12T01:56:07.349199Z","steps":["trace[1230688988] 'process raft request' (duration: 110.413174ms)","trace[1230688988] 'compare' (duration: 166.679144ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:07.57645Z","caller":"traceutil/trace.go:171","msg":"trace[1355721161] transaction","detail":"{read_only:false; response_revision:25350; number_of_response:1; }","duration":"499.511411ms","start":"2026-08-12T01:56:07.076915Z","end":"2026-08-12T01:56:07.576426Z","steps":["trace[1355721161] 'process raft request' (duration: 499.44039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:07.576589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:07.076881Z","time spent":"499.632903ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:07.576738Z","caller":"traceutil/trace.go:171","msg":"trace[1060827493] transaction","detail":"{read_only:false; response_revision:25349; number_of_response:1; }","duration":"503.334018ms","start":"2026-08-12T01:56:07.073396Z","end":"2026-08-12T01:56:07.57673Z","steps":["trace[1060827493] 'process raft request' (duration: 419.498027ms)","trace[1060827493] 'compare' (duration: 83.145588ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:07.576776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:07.073383Z","time spent":"503.37042ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:07.576787Z","caller":"traceutil/trace.go:171","msg":"trace[1129329012] transaction","detail":"{read_only:false; response_revision:25351; number_of_response:1; }","duration":"285.717034ms","start":"2026-08-12T01:56:07.291044Z","end":"2026-08-12T01:56:07.576761Z","steps":["trace[1129329012] 'process raft request' (duration: 285.354847ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:07.577186Z","caller":"traceutil/trace.go:171","msg":"trace[1975805684] transaction","detail":"{read_only:false; response_revision:25352; number_of_response:1; }","duration":"149.467031ms","start":"2026-08-12T01:56:07.427711Z","end":"2026-08-12T01:56:07.577178Z","steps":["trace[1975805684] 'process raft request' (duration: 148.959931ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:07.577588Z","caller":"traceutil/trace.go:171","msg":"trace[130444608] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"147.90998ms","start":"2026-08-12T01:56:07.429647Z","end":"2026-08-12T01:56:07.577557Z","steps":["trace[130444608] 'process raft request' (duration: 147.488962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:07.851592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.650834ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:56:07.851686Z","caller":"traceutil/trace.go:171","msg":"trace[1321801950] linearizableReadLoop","detail":"{readStateIndex:26186; appliedIndex:26185; }","duration":"198.913232ms","start":"2026-08-12T01:56:07.652758Z","end":"2026-08-12T01:56:07.851671Z","steps":["trace[1321801950] 'read index received' (duration: 55.074595ms)","trace[1321801950] 'applied index is now lower than readState.Index' (duration: 143.837287ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:07.851754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.996043ms","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-08-12T01:56:07.851771Z","caller":"traceutil/trace.go:171","msg":"trace[848102769] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25354; }","duration":"199.055185ms","start":"2026-08-12T01:56:07.65271Z","end":"2026-08-12T01:56:07.851765Z","steps":["trace[848102769] 'agreement among raft nodes before linearized reading' (duration: 198.998594ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:07.851926Z","caller":"traceutil/trace.go:171","msg":"trace[145479706] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"207.257183ms","start":"2026-08-12T01:56:07.644659Z","end":"2026-08-12T01:56:07.851916Z","steps":["trace[145479706] 'process raft request' (duration: 63.202661ms)","trace[145479706] 'compare' (duration: 142.919559ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:08.157799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.765552ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:56:08.157986Z","caller":"traceutil/trace.go:171","msg":"trace[1548750937] transaction","detail":"{read_only:false; response_revision:25355; number_of_response:1; }","duration":"360.130054ms","start":"2026-08-12T01:56:07.797803Z","end":"2026-08-12T01:56:08.157933Z","steps":["trace[1548750937] 'process raft request' (duration: 199.113736ms)","trace[1548750937] 'compare' (duration: 160.439886ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:08.158059Z","caller":"traceutil/trace.go:171","msg":"trace[403157221] transaction","detail":"{read_only:false; response_revision:25356; number_of_response:1; }","duration":"300.024677ms","start":"2026-08-12T01:56:07.858011Z","end":"2026-08-12T01:56:08.158036Z","steps":["trace[403157221] 'process raft request' (duration: 299.916794ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:08.15814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:07.857999Z","time spent":"300.100978ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:08.158153Z","caller":"traceutil/trace.go:171","msg":"trace[1618358251] linearizableReadLoop","detail":"{readStateIndex:26187; appliedIndex:26186; }","duration":"302.411325ms","start":"2026-08-12T01:56:07.855706Z","end":"2026-08-12T01:56:08.158117Z","steps":["trace[1618358251] 'read index received' (duration: 141.228364ms)","trace[1618358251] 'applied index is now lower than readState.Index' (duration: 161.180711ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:08.158202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:07.797776Z","time spent":"360.307678ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T01:56:08.158311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.579399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:08.158349Z","caller":"traceutil/trace.go:171","msg":"trace[2144041201] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25356; }","duration":"302.662011ms","start":"2026-08-12T01:56:07.855676Z","end":"2026-08-12T01:56:08.158338Z","steps":["trace[2144041201] 'agreement among raft nodes before linearized reading' (duration: 302.549178ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:08.158386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:07.85566Z","time spent":"302.717393ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-08-12T01:56:11.276741Z","caller":"traceutil/trace.go:171","msg":"trace[1805069199] transaction","detail":"{read_only:false; response_revision:25375; number_of_response:1; }","duration":"134.080708ms","start":"2026-08-12T01:56:11.142622Z","end":"2026-08-12T01:56:11.276703Z","steps":["trace[1805069199] 'process raft request' (duration: 122.424709ms)","trace[1805069199] 'compare' (duration: 11.367523ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:11.298138Z","caller":"traceutil/trace.go:171","msg":"trace[2048886688] transaction","detail":"{read_only:false; response_revision:25376; number_of_response:1; }","duration":"153.133206ms","start":"2026-08-12T01:56:11.144963Z","end":"2026-08-12T01:56:11.298097Z","steps":["trace[2048886688] 'process raft request' (duration: 152.657027ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:11.621779Z","caller":"traceutil/trace.go:171","msg":"trace[1622520181] transaction","detail":"{read_only:false; response_revision:25377; number_of_response:1; }","duration":"319.161527ms","start":"2026-08-12T01:56:11.302591Z","end":"2026-08-12T01:56:11.621752Z","steps":["trace[1622520181] 'process raft request' (duration: 318.979014ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:11.621955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:11.302558Z","time spent":"319.302241ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":542,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:11.622182Z","caller":"traceutil/trace.go:171","msg":"trace[1732475073] linearizableReadLoop","detail":"{readStateIndex:26210; appliedIndex:26210; }","duration":"313.133295ms","start":"2026-08-12T01:56:11.309012Z","end":"2026-08-12T01:56:11.622146Z","steps":["trace[1732475073] 'read index received' (duration: 313.124525ms)","trace[1732475073] 'applied index is now lower than readState.Index' (duration: 6.55µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:11.622399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.36127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:11.62244Z","caller":"traceutil/trace.go:171","msg":"trace[660028551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25377; }","duration":"313.465942ms","start":"2026-08-12T01:56:11.308964Z","end":"2026-08-12T01:56:11.62243Z","steps":["trace[660028551] 'agreement among raft nodes before linearized reading' (duration: 313.3642ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:11.622485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:11.308946Z","time spent":"313.532323ms","remote":"127.0.0.1:58388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-12T01:56:11.859326Z","caller":"traceutil/trace.go:171","msg":"trace[1054125691] transaction","detail":"{read_only:false; response_revision:25378; number_of_response:1; }","duration":"534.662428ms","start":"2026-08-12T01:56:11.324635Z","end":"2026-08-12T01:56:11.859297Z","steps":["trace[1054125691] 'process raft request' (duration: 534.30976ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:11.85947Z","caller":"traceutil/trace.go:171","msg":"trace[2141929166] transaction","detail":"{read_only:false; response_revision:25381; number_of_response:1; }","duration":"266.118204ms","start":"2026-08-12T01:56:11.593327Z","end":"2026-08-12T01:56:11.859445Z","steps":["trace[2141929166] 'process raft request' (duration: 265.956641ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:11.859497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:11.324616Z","time spent":"534.78417ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:11.859473Z","caller":"traceutil/trace.go:171","msg":"trace[555259891] transaction","detail":"{read_only:false; response_revision:25380; number_of_response:1; }","duration":"268.984273ms","start":"2026-08-12T01:56:11.590449Z","end":"2026-08-12T01:56:11.859434Z","steps":["trace[555259891] 'process raft request' (duration: 268.783329ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:11.859523Z","caller":"traceutil/trace.go:171","msg":"trace[1856410665] transaction","detail":"{read_only:false; response_revision:25382; number_of_response:1; }","duration":"265.792598ms","start":"2026-08-12T01:56:11.593721Z","end":"2026-08-12T01:56:11.859514Z","steps":["trace[1856410665] 'process raft request' (duration: 265.600374ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:11.859525Z","caller":"traceutil/trace.go:171","msg":"trace[249638932] transaction","detail":"{read_only:false; response_revision:25379; number_of_response:1; }","duration":"499.265916ms","start":"2026-08-12T01:56:11.360227Z","end":"2026-08-12T01:56:11.859493Z","steps":["trace[249638932] 'process raft request' (duration: 498.95876ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:11.859468Z","caller":"traceutil/trace.go:171","msg":"trace[648995718] transaction","detail":"{read_only:false; response_revision:25383; number_of_response:1; }","duration":"265.627974ms","start":"2026-08-12T01:56:11.593822Z","end":"2026-08-12T01:56:11.85945Z","steps":["trace[648995718] 'process raft request' (duration: 265.539692ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:11.859719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:11.360195Z","time spent":"499.44047ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:11.859734Z","caller":"traceutil/trace.go:171","msg":"trace[1700197545] linearizableReadLoop","detail":"{readStateIndex:26217; appliedIndex:26210; }","duration":"237.450659ms","start":"2026-08-12T01:56:11.62227Z","end":"2026-08-12T01:56:11.859721Z","steps":["trace[1700197545] 'read index received' (duration: 236.632201ms)","trace[1700197545] 'applied index is now lower than readState.Index' (duration: 816.288µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:11.859855Z","caller":"traceutil/trace.go:171","msg":"trace[441240161] transaction","detail":"{read_only:false; response_revision:25384; number_of_response:1; }","duration":"265.129104ms","start":"2026-08-12T01:56:11.594706Z","end":"2026-08-12T01:56:11.859835Z","steps":["trace[441240161] 'process raft request' (duration: 264.692665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:11.859881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.321369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-12T01:56:11.859919Z","caller":"traceutil/trace.go:171","msg":"trace[748953726] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:25384; }","duration":"530.37817ms","start":"2026-08-12T01:56:11.32953Z","end":"2026-08-12T01:56:11.859908Z","steps":["trace[748953726] 'agreement among raft nodes before linearized reading' (duration: 530.284059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:11.859954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:11.329462Z","time spent":"530.481883ms","remote":"127.0.0.1:60178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":31,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "} {"level":"warn","ts":"2026-08-12T01:56:11.859944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.551611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-12T01:56:11.860118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.20354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-08-12T01:56:11.860147Z","caller":"traceutil/trace.go:171","msg":"trace[1139034132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25384; }","duration":"236.801926ms","start":"2026-08-12T01:56:11.623335Z","end":"2026-08-12T01:56:11.860137Z","steps":["trace[1139034132] 'agreement among raft nodes before linearized reading' (duration: 236.561901ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:11.860152Z","caller":"traceutil/trace.go:171","msg":"trace[552287107] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:25384; }","duration":"182.348413ms","start":"2026-08-12T01:56:11.677795Z","end":"2026-08-12T01:56:11.860143Z","steps":["trace[552287107] 'agreement among raft nodes before linearized reading' (duration: 182.128949ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:12.31314Z","caller":"traceutil/trace.go:171","msg":"trace[1982844181] transaction","detail":"{read_only:false; response_revision:25386; number_of_response:1; }","duration":"139.592251ms","start":"2026-08-12T01:56:12.173518Z","end":"2026-08-12T01:56:12.31311Z","steps":["trace[1982844181] 'process raft request' (duration: 139.360846ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:13.193425Z","caller":"traceutil/trace.go:171","msg":"trace[323310084] transaction","detail":"{read_only:false; response_revision:25388; number_of_response:1; }","duration":"132.725351ms","start":"2026-08-12T01:56:13.060661Z","end":"2026-08-12T01:56:13.193386Z","steps":["trace[323310084] 'process raft request' (duration: 132.472866ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:13.382688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.626462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18434"} {"level":"info","ts":"2026-08-12T01:56:13.382785Z","caller":"traceutil/trace.go:171","msg":"trace[1218877022] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25391; }","duration":"140.767944ms","start":"2026-08-12T01:56:13.241993Z","end":"2026-08-12T01:56:13.382761Z","steps":["trace[1218877022] 'range keys from in-memory index tree' (duration: 140.392737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:13.382886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.530763ms","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-08-12T01:56:13.382989Z","caller":"traceutil/trace.go:171","msg":"trace[573845255] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25391; }","duration":"101.708058ms","start":"2026-08-12T01:56:13.281253Z","end":"2026-08-12T01:56:13.382961Z","steps":["trace[573845255] 'range keys from in-memory index tree' (duration: 101.231077ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:13.750158Z","caller":"traceutil/trace.go:171","msg":"trace[1333201402] linearizableReadLoop","detail":"{readStateIndex:26226; appliedIndex:26225; }","duration":"308.986851ms","start":"2026-08-12T01:56:13.441149Z","end":"2026-08-12T01:56:13.750136Z","steps":["trace[1333201402] 'read index received' (duration: 308.825397ms)","trace[1333201402] 'applied index is now lower than readState.Index' (duration: 160.484µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:13.750227Z","caller":"traceutil/trace.go:171","msg":"trace[397854278] transaction","detail":"{read_only:false; response_revision:25393; number_of_response:1; }","duration":"360.584474ms","start":"2026-08-12T01:56:13.389599Z","end":"2026-08-12T01:56:13.750184Z","steps":["trace[397854278] 'process raft request' (duration: 360.38879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:13.750272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.114303ms","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-08-12T01:56:13.75031Z","caller":"traceutil/trace.go:171","msg":"trace[1140313901] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25393; }","duration":"309.193545ms","start":"2026-08-12T01:56:13.441107Z","end":"2026-08-12T01:56:13.7503Z","steps":["trace[1140313901] 'agreement among raft nodes before linearized reading' (duration: 309.115803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:13.750335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:13.441085Z","time spent":"309.243196ms","remote":"127.0.0.1:58830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-08-12T01:56:13.750426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:13.389577Z","time spent":"360.735367ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:14.121565Z","caller":"traceutil/trace.go:171","msg":"trace[2052230942] transaction","detail":"{read_only:false; response_revision:25397; number_of_response:1; }","duration":"254.887985ms","start":"2026-08-12T01:56:13.866645Z","end":"2026-08-12T01:56:14.121533Z","steps":["trace[2052230942] 'process raft request' (duration: 254.739162ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:14.121624Z","caller":"traceutil/trace.go:171","msg":"trace[1353165096] transaction","detail":"{read_only:false; response_revision:25396; number_of_response:1; }","duration":"255.037928ms","start":"2026-08-12T01:56:13.866525Z","end":"2026-08-12T01:56:14.121563Z","steps":["trace[1353165096] 'process raft request' (duration: 254.808573ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:14.12161Z","caller":"traceutil/trace.go:171","msg":"trace[1085069648] transaction","detail":"{read_only:false; response_revision:25395; number_of_response:1; }","duration":"255.036517ms","start":"2026-08-12T01:56:13.866505Z","end":"2026-08-12T01:56:14.121542Z","steps":["trace[1085069648] 'process raft request' (duration: 254.516967ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:14.122012Z","caller":"traceutil/trace.go:171","msg":"trace[687212341] transaction","detail":"{read_only:false; response_revision:25399; number_of_response:1; }","duration":"255.250493ms","start":"2026-08-12T01:56:13.866742Z","end":"2026-08-12T01:56:14.121992Z","steps":["trace[687212341] 'process raft request' (duration: 255.017728ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:14.122009Z","caller":"traceutil/trace.go:171","msg":"trace[863998341] linearizableReadLoop","detail":"{readStateIndex:26232; appliedIndex:26226; }","duration":"226.963215ms","start":"2026-08-12T01:56:13.895007Z","end":"2026-08-12T01:56:14.12197Z","steps":["trace[863998341] 'read index received' (duration: 34.361623ms)","trace[863998341] 'applied index is now lower than readState.Index' (duration: 192.589152ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:14.12201Z","caller":"traceutil/trace.go:171","msg":"trace[1535513573] transaction","detail":"{read_only:false; response_revision:25398; number_of_response:1; }","duration":"255.272442ms","start":"2026-08-12T01:56:13.866717Z","end":"2026-08-12T01:56:14.121989Z","steps":["trace[1535513573] 'process raft request' (duration: 254.705811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:14.122324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.256661ms","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-08-12T01:56:14.122399Z","caller":"traceutil/trace.go:171","msg":"trace[1514175446] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25399; }","duration":"227.409003ms","start":"2026-08-12T01:56:13.894968Z","end":"2026-08-12T01:56:14.122377Z","steps":["trace[1514175446] 'agreement among raft nodes before linearized reading' (duration: 227.121727ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:14.660936Z","caller":"traceutil/trace.go:171","msg":"trace[1802351455] linearizableReadLoop","detail":"{readStateIndex:26235; appliedIndex:26234; }","duration":"113.642231ms","start":"2026-08-12T01:56:14.547263Z","end":"2026-08-12T01:56:14.660905Z","steps":["trace[1802351455] 'read index received' (duration: 113.476108ms)","trace[1802351455] 'applied index is now lower than readState.Index' (duration: 164.483µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:14.661272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.959247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-12T01:56:14.66138Z","caller":"traceutil/trace.go:171","msg":"trace[89199975] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:25401; }","duration":"114.136661ms","start":"2026-08-12T01:56:14.547221Z","end":"2026-08-12T01:56:14.661357Z","steps":["trace[89199975] 'agreement among raft nodes before linearized reading' (duration: 113.795494ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:14.779114Z","caller":"traceutil/trace.go:171","msg":"trace[716918891] transaction","detail":"{read_only:false; response_revision:25403; number_of_response:1; }","duration":"112.133199ms","start":"2026-08-12T01:56:14.66695Z","end":"2026-08-12T01:56:14.779084Z","steps":["trace[716918891] 'process raft request' (duration: 112.053518ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:14.779305Z","caller":"traceutil/trace.go:171","msg":"trace[817178181] transaction","detail":"{read_only:false; response_revision:25402; number_of_response:1; }","duration":"117.247024ms","start":"2026-08-12T01:56:14.662023Z","end":"2026-08-12T01:56:14.77927Z","steps":["trace[817178181] 'process raft request' (duration: 102.673527ms)","trace[817178181] 'compare' (duration: 14.101998ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:15.448141Z","caller":"traceutil/trace.go:171","msg":"trace[595185500] linearizableReadLoop","detail":"{readStateIndex:26238; appliedIndex:26237; }","duration":"201.722069ms","start":"2026-08-12T01:56:15.246394Z","end":"2026-08-12T01:56:15.448116Z","steps":["trace[595185500] 'read index received' (duration: 201.438303ms)","trace[595185500] 'applied index is now lower than readState.Index' (duration: 283.035µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:15.44825Z","caller":"traceutil/trace.go:171","msg":"trace[1711816320] transaction","detail":"{read_only:false; response_revision:25404; number_of_response:1; }","duration":"244.597246ms","start":"2026-08-12T01:56:15.203623Z","end":"2026-08-12T01:56:15.44822Z","steps":["trace[1711816320] 'process raft request' (duration: 244.29255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:15.448547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.132387ms","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-08-12T01:56:15.448588Z","caller":"traceutil/trace.go:171","msg":"trace[1845934606] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25404; }","duration":"202.2492ms","start":"2026-08-12T01:56:15.246328Z","end":"2026-08-12T01:56:15.448577Z","steps":["trace[1845934606] 'agreement among raft nodes before linearized reading' (duration: 202.042036ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:15.690157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.013459ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:56:15.690516Z","caller":"traceutil/trace.go:171","msg":"trace[491780707] transaction","detail":"{read_only:false; response_revision:25405; number_of_response:1; }","duration":"237.434899ms","start":"2026-08-12T01:56:15.453058Z","end":"2026-08-12T01:56:15.690493Z","steps":["trace[491780707] 'process raft request' (duration: 118.96793ms)","trace[491780707] 'compare' (duration: 117.54378ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:15.690661Z","caller":"traceutil/trace.go:171","msg":"trace[1944287271] transaction","detail":"{read_only:false; response_revision:25406; number_of_response:1; }","duration":"236.834186ms","start":"2026-08-12T01:56:15.453775Z","end":"2026-08-12T01:56:15.690609Z","steps":["trace[1944287271] 'process raft request' (duration: 236.51542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:16.047445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.257137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:16.047546Z","caller":"traceutil/trace.go:171","msg":"trace[849419512] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:25407; }","duration":"144.42609ms","start":"2026-08-12T01:56:15.903096Z","end":"2026-08-12T01:56:16.047523Z","steps":["trace[849419512] 'count revisions from in-memory index tree' (duration: 144.169284ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:16.047934Z","caller":"traceutil/trace.go:171","msg":"trace[761997760] transaction","detail":"{read_only:false; response_revision:25408; number_of_response:1; }","duration":"111.361155ms","start":"2026-08-12T01:56:15.936554Z","end":"2026-08-12T01:56:16.047915Z","steps":["trace[761997760] 'process raft request' (duration: 100.84096ms)","trace[761997760] 'compare' (duration: 10.058636ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:16.446142Z","caller":"traceutil/trace.go:171","msg":"trace[2049223177] transaction","detail":"{read_only:false; response_revision:25409; number_of_response:1; }","duration":"318.758829ms","start":"2026-08-12T01:56:16.127353Z","end":"2026-08-12T01:56:16.446112Z","steps":["trace[2049223177] 'process raft request' (duration: 318.503144ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:16.446355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:16.127326Z","time spent":"318.913723ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:16.473108Z","caller":"traceutil/trace.go:171","msg":"trace[2076921871] transaction","detail":"{read_only:false; response_revision:25412; number_of_response:1; }","duration":"344.451754ms","start":"2026-08-12T01:56:16.12863Z","end":"2026-08-12T01:56:16.473082Z","steps":["trace[2076921871] 'process raft request' (duration: 344.380303ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:16.473126Z","caller":"traceutil/trace.go:171","msg":"trace[1298229431] transaction","detail":"{read_only:false; response_revision:25410; number_of_response:1; }","duration":"345.485806ms","start":"2026-08-12T01:56:16.127605Z","end":"2026-08-12T01:56:16.473091Z","steps":["trace[1298229431] 'process raft request' (duration: 345.21795ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:16.473176Z","caller":"traceutil/trace.go:171","msg":"trace[1677899966] transaction","detail":"{read_only:false; response_revision:25411; number_of_response:1; }","duration":"344.595627ms","start":"2026-08-12T01:56:16.128551Z","end":"2026-08-12T01:56:16.473147Z","steps":["trace[1677899966] 'process raft request' (duration: 344.417303ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:16.473257Z","caller":"traceutil/trace.go:171","msg":"trace[1434807032] linearizableReadLoop","detail":"{readStateIndex:26247; appliedIndex:26242; }","duration":"335.858129ms","start":"2026-08-12T01:56:16.137381Z","end":"2026-08-12T01:56:16.473239Z","steps":["trace[1434807032] 'read index received' (duration: 308.443679ms)","trace[1434807032] 'applied index is now lower than readState.Index' (duration: 27.41341ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:16.47328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:16.128626Z","time spent":"344.562387ms","remote":"127.0.0.1:58626","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-08-12T01:56:16.473289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:16.128524Z","time spent":"344.704929ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T01:56:16.473297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:16.127594Z","time spent":"345.609938ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-12T01:56:16.473284Z","caller":"traceutil/trace.go:171","msg":"trace[487854399] transaction","detail":"{read_only:false; response_revision:25413; number_of_response:1; }","duration":"343.113967ms","start":"2026-08-12T01:56:16.130121Z","end":"2026-08-12T01:56:16.473235Z","steps":["trace[487854399] 'process raft request' (duration: 342.920494ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:16.473335Z","caller":"traceutil/trace.go:171","msg":"trace[997161916] transaction","detail":"{read_only:false; response_revision:25414; number_of_response:1; }","duration":"136.572729ms","start":"2026-08-12T01:56:16.336715Z","end":"2026-08-12T01:56:16.473287Z","steps":["trace[997161916] 'process raft request' (duration: 136.460836ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:16.473441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.897006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-12T01:56:16.473472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.079413ms","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-08-12T01:56:16.473515Z","caller":"traceutil/trace.go:171","msg":"trace[1311021641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25414; }","duration":"162.977168ms","start":"2026-08-12T01:56:16.310489Z","end":"2026-08-12T01:56:16.473466Z","steps":["trace[1311021641] 'agreement among raft nodes before linearized reading' (duration: 162.919397ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:16.473541Z","caller":"traceutil/trace.go:171","msg":"trace[7388954] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25414; }","duration":"336.198035ms","start":"2026-08-12T01:56:16.137333Z","end":"2026-08-12T01:56:16.473531Z","steps":["trace[7388954] 'agreement among raft nodes before linearized reading' (duration: 336.000711ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:16.47347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:16.130108Z","time spent":"343.26147ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-12T01:56:16.473571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:16.137312Z","time spent":"336.252106ms","remote":"127.0.0.1:58626","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-12T01:56:32.206424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.642196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4e511a37-f22f-4252-a9a5-627c6be51a42\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-08-12T01:56:32.20651Z","caller":"traceutil/trace.go:171","msg":"trace[457354412] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4e511a37-f22f-4252-a9a5-627c6be51a42; range_end:; response_count:1; response_revision:25584; }","duration":"102.784759ms","start":"2026-08-12T01:56:32.103705Z","end":"2026-08-12T01:56:32.206489Z","steps":["trace[457354412] 'range keys from in-memory index tree' (duration: 102.402791ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:32.225062Z","caller":"traceutil/trace.go:171","msg":"trace[1690543562] transaction","detail":"{read_only:false; response_revision:25585; number_of_response:1; }","duration":"104.629177ms","start":"2026-08-12T01:56:32.1204Z","end":"2026-08-12T01:56:32.225029Z","steps":["trace[1690543562] 'process raft request' (duration: 104.275329ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:32.452787Z","caller":"traceutil/trace.go:171","msg":"trace[515881405] linearizableReadLoop","detail":"{readStateIndex:26424; appliedIndex:26423; }","duration":"144.474681ms","start":"2026-08-12T01:56:32.308273Z","end":"2026-08-12T01:56:32.452748Z","steps":["trace[515881405] 'read index received' (duration: 143.106002ms)","trace[515881405] 'applied index is now lower than readState.Index' (duration: 1.366469ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:32.452923Z","caller":"traceutil/trace.go:171","msg":"trace[1387119248] transaction","detail":"{read_only:false; response_revision:25586; number_of_response:1; }","duration":"238.769525ms","start":"2026-08-12T01:56:32.214113Z","end":"2026-08-12T01:56:32.452883Z","steps":["trace[1387119248] 'process raft request' (duration: 237.265324ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:32.453002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.702105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:32.453042Z","caller":"traceutil/trace.go:171","msg":"trace[1117889193] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25586; }","duration":"144.809967ms","start":"2026-08-12T01:56:32.308222Z","end":"2026-08-12T01:56:32.453032Z","steps":["trace[1117889193] 'agreement among raft nodes before linearized reading' (duration: 144.654954ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:32.65064Z","caller":"traceutil/trace.go:171","msg":"trace[540331591] transaction","detail":"{read_only:false; response_revision:25587; number_of_response:1; }","duration":"124.767238ms","start":"2026-08-12T01:56:32.525839Z","end":"2026-08-12T01:56:32.650606Z","steps":["trace[540331591] 'process raft request' (duration: 57.540995ms)","trace[540331591] 'compare' (duration: 66.931547ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:32.709896Z","caller":"traceutil/trace.go:171","msg":"trace[710006372] transaction","detail":"{read_only:false; response_revision:25589; number_of_response:1; }","duration":"157.892264ms","start":"2026-08-12T01:56:32.551966Z","end":"2026-08-12T01:56:32.709859Z","steps":["trace[710006372] 'process raft request' (duration: 157.779842ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:32.710179Z","caller":"traceutil/trace.go:171","msg":"trace[162758624] transaction","detail":"{read_only:false; response_revision:25590; number_of_response:1; }","duration":"156.812632ms","start":"2026-08-12T01:56:32.553339Z","end":"2026-08-12T01:56:32.710152Z","steps":["trace[162758624] 'process raft request' (duration: 156.468845ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:32.710331Z","caller":"traceutil/trace.go:171","msg":"trace[1045718670] transaction","detail":"{read_only:false; response_revision:25588; number_of_response:1; }","duration":"158.774283ms","start":"2026-08-12T01:56:32.551542Z","end":"2026-08-12T01:56:32.710316Z","steps":["trace[1045718670] 'process raft request' (duration: 157.979356ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:32.710743Z","caller":"traceutil/trace.go:171","msg":"trace[1520930048] transaction","detail":"{read_only:false; response_revision:25592; number_of_response:1; }","duration":"143.00659ms","start":"2026-08-12T01:56:32.567725Z","end":"2026-08-12T01:56:32.710732Z","steps":["trace[1520930048] 'process raft request' (duration: 142.897978ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:32.710754Z","caller":"traceutil/trace.go:171","msg":"trace[1451152117] transaction","detail":"{read_only:false; response_revision:25591; number_of_response:1; }","duration":"156.20964ms","start":"2026-08-12T01:56:32.554515Z","end":"2026-08-12T01:56:32.710725Z","steps":["trace[1451152117] 'process raft request' (duration: 155.549227ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:32.892316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.950335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:56:32.892465Z","caller":"traceutil/trace.go:171","msg":"trace[1006005490] transaction","detail":"{read_only:false; response_revision:25593; number_of_response:1; }","duration":"176.973984ms","start":"2026-08-12T01:56:32.715465Z","end":"2026-08-12T01:56:32.892439Z","steps":["trace[1006005490] 'process raft request' (duration: 41.773453ms)","trace[1006005490] 'compare' (duration: 134.632339ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:33.136757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.028464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:56:33.137156Z","caller":"traceutil/trace.go:171","msg":"trace[1383097774] transaction","detail":"{read_only:false; response_revision:25594; number_of_response:1; }","duration":"237.908339ms","start":"2026-08-12T01:56:32.899052Z","end":"2026-08-12T01:56:33.13696Z","steps":["trace[1383097774] 'process raft request' (duration: 108.518557ms)","trace[1383097774] 'compare' (duration: 128.724138ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:33.413768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.872062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddressclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:33.413877Z","caller":"traceutil/trace.go:171","msg":"trace[1375056118] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddressclaims/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddressclaims0; response_count:0; response_revision:25594; }","duration":"130.067306ms","start":"2026-08-12T01:56:33.283787Z","end":"2026-08-12T01:56:33.413854Z","steps":["trace[1375056118] 'count revisions from in-memory index tree' (duration: 129.743449ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:33.699219Z","caller":"traceutil/trace.go:171","msg":"trace[108513621] transaction","detail":"{read_only:false; response_revision:25595; number_of_response:1; }","duration":"108.344183ms","start":"2026-08-12T01:56:33.590836Z","end":"2026-08-12T01:56:33.69918Z","steps":["trace[108513621] 'process raft request' (duration: 108.112738ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:33.940927Z","caller":"traceutil/trace.go:171","msg":"trace[622736502] linearizableReadLoop","detail":"{readStateIndex:26434; appliedIndex:26433; }","duration":"162.956357ms","start":"2026-08-12T01:56:33.777919Z","end":"2026-08-12T01:56:33.940875Z","steps":["trace[622736502] 'read index received' (duration: 66.791734ms)","trace[622736502] 'applied index is now lower than readState.Index' (duration: 96.163123ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:33.94101Z","caller":"traceutil/trace.go:171","msg":"trace[624729718] transaction","detail":"{read_only:false; response_revision:25596; number_of_response:1; }","duration":"342.28276ms","start":"2026-08-12T01:56:33.598699Z","end":"2026-08-12T01:56:33.940982Z","steps":["trace[624729718] 'process raft request' (duration: 246.038935ms)","trace[624729718] 'compare' (duration: 95.846167ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:33.941189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.156621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-08-12T01:56:33.941165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.227684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-12T01:56:33.941246Z","caller":"traceutil/trace.go:171","msg":"trace[1883066847] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25596; }","duration":"137.283984ms","start":"2026-08-12T01:56:33.803949Z","end":"2026-08-12T01:56:33.941233Z","steps":["trace[1883066847] 'agreement among raft nodes before linearized reading' (duration: 137.152511ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:33.941272Z","caller":"traceutil/trace.go:171","msg":"trace[2038168481] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25596; }","duration":"163.394536ms","start":"2026-08-12T01:56:33.777853Z","end":"2026-08-12T01:56:33.941247Z","steps":["trace[2038168481] 'agreement among raft nodes before linearized reading' (duration: 163.160741ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:33.941374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-12T01:56:33.598674Z","time spent":"342.390301ms","remote":"127.0.0.1:58626","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-08-12T01:56:34.068556Z","caller":"traceutil/trace.go:171","msg":"trace[2142192115] transaction","detail":"{read_only:false; response_revision:25598; number_of_response:1; }","duration":"121.39509ms","start":"2026-08-12T01:56:33.94713Z","end":"2026-08-12T01:56:34.068525Z","steps":["trace[2142192115] 'process raft request' (duration: 121.290438ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:34.068703Z","caller":"traceutil/trace.go:171","msg":"trace[305867689] transaction","detail":"{read_only:false; response_revision:25599; number_of_response:1; }","duration":"121.205866ms","start":"2026-08-12T01:56:33.94749Z","end":"2026-08-12T01:56:34.068696Z","steps":["trace[305867689] 'process raft request' (duration: 120.981182ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:34.068567Z","caller":"traceutil/trace.go:171","msg":"trace[182811377] transaction","detail":"{read_only:false; response_revision:25597; number_of_response:1; }","duration":"121.979582ms","start":"2026-08-12T01:56:33.94656Z","end":"2026-08-12T01:56:34.06854Z","steps":["trace[182811377] 'process raft request' (duration: 117.415678ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:34.58647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.848513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-12T01:56:34.586561Z","caller":"traceutil/trace.go:171","msg":"trace[2140802694] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:25600; }","duration":"137.024908ms","start":"2026-08-12T01:56:34.449515Z","end":"2026-08-12T01:56:34.58654Z","steps":["trace[2140802694] 'count revisions from in-memory index tree' (duration: 136.70487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:34.586663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.562904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:34.586752Z","caller":"traceutil/trace.go:171","msg":"trace[1766557798] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:25600; }","duration":"173.743048ms","start":"2026-08-12T01:56:34.412987Z","end":"2026-08-12T01:56:34.58673Z","steps":["trace[1766557798] 'count revisions from in-memory index tree' (duration: 173.36458ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:36.417535Z","caller":"traceutil/trace.go:171","msg":"trace[781768146] linearizableReadLoop","detail":"{readStateIndex:26455; appliedIndex:26454; }","duration":"107.088216ms","start":"2026-08-12T01:56:36.310414Z","end":"2026-08-12T01:56:36.417503Z","steps":["trace[781768146] 'read index received' (duration: 106.938063ms)","trace[781768146] 'applied index is now lower than readState.Index' (duration: 148.873µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:56:36.417713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.273541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:56:36.417743Z","caller":"traceutil/trace.go:171","msg":"trace[1919312171] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25616; }","duration":"107.369542ms","start":"2026-08-12T01:56:36.310365Z","end":"2026-08-12T01:56:36.417735Z","steps":["trace[1919312171] 'agreement among raft nodes before linearized reading' (duration: 107.24809ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:36.418111Z","caller":"traceutil/trace.go:171","msg":"trace[268105477] transaction","detail":"{read_only:false; response_revision:25616; number_of_response:1; }","duration":"109.525826ms","start":"2026-08-12T01:56:36.308575Z","end":"2026-08-12T01:56:36.418101Z","steps":["trace[268105477] 'process raft request' (duration: 108.70327ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:40.853027Z","caller":"traceutil/trace.go:171","msg":"trace[1369299862] transaction","detail":"{read_only:false; response_revision:25674; number_of_response:1; }","duration":"110.490916ms","start":"2026-08-12T01:56:40.742478Z","end":"2026-08-12T01:56:40.852968Z","steps":["trace[1369299862] 'process raft request' (duration: 94.193523ms)","trace[1369299862] 'compare' (duration: 16.024497ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:40.853064Z","caller":"traceutil/trace.go:171","msg":"trace[181399902] transaction","detail":"{read_only:false; response_revision:25675; number_of_response:1; }","duration":"109.400954ms","start":"2026-08-12T01:56:40.743631Z","end":"2026-08-12T01:56:40.853032Z","steps":["trace[181399902] 'process raft request' (duration: 109.232581ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:40.853077Z","caller":"traceutil/trace.go:171","msg":"trace[846002566] transaction","detail":"{read_only:false; response_revision:25676; number_of_response:1; }","duration":"109.159238ms","start":"2026-08-12T01:56:40.74389Z","end":"2026-08-12T01:56:40.853049Z","steps":["trace[846002566] 'process raft request' (duration: 109.044066ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:40.853268Z","caller":"traceutil/trace.go:171","msg":"trace[176915952] transaction","detail":"{read_only:false; response_revision:25677; number_of_response:1; }","duration":"109.279232ms","start":"2026-08-12T01:56:40.743957Z","end":"2026-08-12T01:56:40.853236Z","steps":["trace[176915952] 'process raft request' (duration: 109.040996ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:43.600024Z","caller":"traceutil/trace.go:171","msg":"trace[1587400210] linearizableReadLoop","detail":"{readStateIndex:26540; appliedIndex:26539; }","duration":"160.669951ms","start":"2026-08-12T01:56:43.439329Z","end":"2026-08-12T01:56:43.599999Z","steps":["trace[1587400210] 'read index received' (duration: 160.511597ms)","trace[1587400210] 'applied index is now lower than readState.Index' (duration: 157.034µs)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:56:43.600612Z","caller":"traceutil/trace.go:171","msg":"trace[1250202224] transaction","detail":"{read_only:false; response_revision:25700; number_of_response:1; }","duration":"205.941045ms","start":"2026-08-12T01:56:43.394386Z","end":"2026-08-12T01:56:43.600327Z","steps":["trace[1250202224] 'process raft request' (duration: 205.375854ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:43.60063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.770181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-12T01:56:43.600717Z","caller":"traceutil/trace.go:171","msg":"trace[252355953] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:25700; }","duration":"156.931684ms","start":"2026-08-12T01:56:43.443763Z","end":"2026-08-12T01:56:43.600695Z","steps":["trace[252355953] 'agreement among raft nodes before linearized reading' (duration: 156.70004ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:56:43.600831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.443316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-08-12T01:56:43.600952Z","caller":"traceutil/trace.go:171","msg":"trace[312666630] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25700; }","duration":"161.65602ms","start":"2026-08-12T01:56:43.439266Z","end":"2026-08-12T01:56:43.600922Z","steps":["trace[312666630] 'agreement among raft nodes before linearized reading' (duration: 161.255262ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:56:51.423639Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22321} {"level":"info","ts":"2026-08-12T01:56:51.53247Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22321,"took":"103.607366ms","hash":785958516,"current-db-size-bytes":58011648,"current-db-size":"58 MB","current-db-size-in-use-bytes":45015040,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-08-12T01:56:51.532662Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":785958516,"revision":22321,"compact-revision":20046} {"level":"warn","ts":"2026-08-12T01:57:04.338543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.806672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-08-12T01:57:04.338634Z","caller":"traceutil/trace.go:171","msg":"trace[658133487] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25860; }","duration":"109.917454ms","start":"2026-08-12T01:57:04.228694Z","end":"2026-08-12T01:57:04.338611Z","steps":["trace[658133487] 'range keys from in-memory index tree' (duration: 109.565178ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:57:04.338854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.541113ms","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-08-12T01:57:04.338959Z","caller":"traceutil/trace.go:171","msg":"trace[311868929] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25860; }","duration":"102.940143ms","start":"2026-08-12T01:57:04.235992Z","end":"2026-08-12T01:57:04.338932Z","steps":["trace[311868929] 'range keys from in-memory index tree' (duration: 102.32588ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:04.556406Z","caller":"traceutil/trace.go:171","msg":"trace[934160735] transaction","detail":"{read_only:false; response_revision:25863; number_of_response:1; }","duration":"211.075991ms","start":"2026-08-12T01:57:04.345292Z","end":"2026-08-12T01:57:04.556368Z","steps":["trace[934160735] 'process raft request' (duration: 129.375843ms)","trace[934160735] 'compare' (duration: 81.422643ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:04.607113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.31162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.77\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-08-12T01:57:04.608537Z","caller":"traceutil/trace.go:171","msg":"trace[62543500] range","detail":"{range_begin:/registry/masterleases/199.204.45.77; range_end:; response_count:1; response_revision:25865; }","duration":"103.781699ms","start":"2026-08-12T01:57:04.504717Z","end":"2026-08-12T01:57:04.608498Z","steps":["trace[62543500] 'agreement among raft nodes before linearized reading' (duration: 102.272669ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:57:04.979417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.593742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:57:04.979637Z","caller":"traceutil/trace.go:171","msg":"trace[95472141] linearizableReadLoop","detail":"{readStateIndex:26714; appliedIndex:26712; }","duration":"101.516702ms","start":"2026-08-12T01:57:04.878104Z","end":"2026-08-12T01:57:04.97962Z","steps":["trace[95472141] 'read index received' (duration: 96.776895ms)","trace[95472141] 'applied index is now lower than readState.Index' (duration: 4.738717ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:04.979726Z","caller":"traceutil/trace.go:171","msg":"trace[1521142720] transaction","detail":"{read_only:false; response_revision:25867; number_of_response:1; }","duration":"166.244614ms","start":"2026-08-12T01:57:04.813453Z","end":"2026-08-12T01:57:04.979697Z","steps":["trace[1521142720] 'process raft request' (duration: 23.203123ms)","trace[1521142720] 'compare' (duration: 142.281606ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:04.979823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.720667ms","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-08-12T01:57:04.979845Z","caller":"traceutil/trace.go:171","msg":"trace[1999289530] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25868; }","duration":"101.786998ms","start":"2026-08-12T01:57:04.878049Z","end":"2026-08-12T01:57:04.979836Z","steps":["trace[1999289530] 'agreement among raft nodes before linearized reading' (duration: 101.614634ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:04.979869Z","caller":"traceutil/trace.go:171","msg":"trace[281812929] transaction","detail":"{read_only:false; response_revision:25868; number_of_response:1; }","duration":"101.747247ms","start":"2026-08-12T01:57:04.87803Z","end":"2026-08-12T01:57:04.979777Z","steps":["trace[281812929] 'process raft request' (duration: 101.497622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:57:05.23759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.067685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:57:05.237845Z","caller":"traceutil/trace.go:171","msg":"trace[50047638] linearizableReadLoop","detail":"{readStateIndex:26718; appliedIndex:26714; }","duration":"254.399985ms","start":"2026-08-12T01:57:04.983431Z","end":"2026-08-12T01:57:05.237831Z","steps":["trace[50047638] 'read index received' (duration: 129.011764ms)","trace[50047638] 'applied index is now lower than readState.Index' (duration: 125.387091ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:05.237961Z","caller":"traceutil/trace.go:171","msg":"trace[10670449] transaction","detail":"{read_only:false; response_revision:25872; number_of_response:1; }","duration":"278.909065ms","start":"2026-08-12T01:57:04.959012Z","end":"2026-08-12T01:57:05.237921Z","steps":["trace[10670449] 'process raft request' (duration: 278.787323ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:57:05.238026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.596109ms","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-08-12T01:57:05.238054Z","caller":"traceutil/trace.go:171","msg":"trace[1242211171] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25872; }","duration":"254.624109ms","start":"2026-08-12T01:57:04.983422Z","end":"2026-08-12T01:57:05.238046Z","steps":["trace[1242211171] 'agreement among raft nodes before linearized reading' (duration: 254.496257ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:05.238097Z","caller":"traceutil/trace.go:171","msg":"trace[726470579] transaction","detail":"{read_only:false; response_revision:25871; number_of_response:1; }","duration":"280.684132ms","start":"2026-08-12T01:57:04.95738Z","end":"2026-08-12T01:57:05.238064Z","steps":["trace[726470579] 'process raft request' (duration: 280.389446ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:05.238276Z","caller":"traceutil/trace.go:171","msg":"trace[1622350562] transaction","detail":"{read_only:false; response_revision:25869; number_of_response:1; }","duration":"292.424301ms","start":"2026-08-12T01:57:04.945842Z","end":"2026-08-12T01:57:05.238267Z","steps":["trace[1622350562] 'process raft request' (duration: 166.568991ms)","trace[1622350562] 'compare' (duration: 124.897591ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:05.238299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.619591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-12T01:57:05.238389Z","caller":"traceutil/trace.go:171","msg":"trace[928157238] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25872; }","duration":"114.777384ms","start":"2026-08-12T01:57:05.123584Z","end":"2026-08-12T01:57:05.238361Z","steps":["trace[928157238] 'agreement among raft nodes before linearized reading' (duration: 114.477108ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:05.237965Z","caller":"traceutil/trace.go:171","msg":"trace[127433183] transaction","detail":"{read_only:false; response_revision:25870; number_of_response:1; }","duration":"280.657921ms","start":"2026-08-12T01:57:04.95725Z","end":"2026-08-12T01:57:05.237908Z","steps":["trace[127433183] 'process raft request' (duration: 280.437426ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:57:05.470326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.81293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:57:05.470445Z","caller":"traceutil/trace.go:171","msg":"trace[1494641385] linearizableReadLoop","detail":"{readStateIndex:26719; appliedIndex:26718; }","duration":"159.719142ms","start":"2026-08-12T01:57:05.310708Z","end":"2026-08-12T01:57:05.470427Z","steps":["trace[1494641385] 'read index received' (duration: 54.678597ms)","trace[1494641385] 'applied index is now lower than readState.Index' (duration: 105.038605ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:05.470667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.919176ms","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-08-12T01:57:05.470762Z","caller":"traceutil/trace.go:171","msg":"trace[281285891] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25873; }","duration":"160.081559ms","start":"2026-08-12T01:57:05.310655Z","end":"2026-08-12T01:57:05.470736Z","steps":["trace[281285891] 'agreement among raft nodes before linearized reading' (duration: 159.917406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:57:05.47074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.70573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:57:05.470831Z","caller":"traceutil/trace.go:171","msg":"trace[1659652277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25873; }","duration":"156.816943ms","start":"2026-08-12T01:57:05.313991Z","end":"2026-08-12T01:57:05.470807Z","steps":["trace[1659652277] 'agreement among raft nodes before linearized reading' (duration: 156.639899ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:05.470886Z","caller":"traceutil/trace.go:171","msg":"trace[88528063] transaction","detail":"{read_only:false; response_revision:25873; number_of_response:1; }","duration":"221.85317ms","start":"2026-08-12T01:57:05.248978Z","end":"2026-08-12T01:57:05.470831Z","steps":["trace[88528063] 'process raft request' (duration: 116.405307ms)","trace[88528063] 'compare' (duration: 104.608216ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:05.471077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.736886ms","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-08-12T01:57:05.471169Z","caller":"traceutil/trace.go:171","msg":"trace[762958602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25873; }","duration":"146.840288ms","start":"2026-08-12T01:57:05.324304Z","end":"2026-08-12T01:57:05.471145Z","steps":["trace[762958602] 'agreement among raft nodes before linearized reading' (duration: 146.544722ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:06.534489Z","caller":"traceutil/trace.go:171","msg":"trace[986154676] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"110.470185ms","start":"2026-08-12T01:57:06.423986Z","end":"2026-08-12T01:57:06.534456Z","steps":["trace[986154676] 'process raft request' (duration: 110.23436ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:06.572874Z","caller":"traceutil/trace.go:171","msg":"trace[1427244330] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"147.446632ms","start":"2026-08-12T01:57:06.425407Z","end":"2026-08-12T01:57:06.572853Z","steps":["trace[1427244330] 'process raft request' (duration: 147.143456ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:06.727856Z","caller":"traceutil/trace.go:171","msg":"trace[769405649] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"113.496098ms","start":"2026-08-12T01:57:06.614328Z","end":"2026-08-12T01:57:06.727824Z","steps":["trace[769405649] 'process raft request' (duration: 113.417306ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:06.727871Z","caller":"traceutil/trace.go:171","msg":"trace[469869524] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"149.119614ms","start":"2026-08-12T01:57:06.578729Z","end":"2026-08-12T01:57:06.727848Z","steps":["trace[469869524] 'process raft request' (duration: 63.877984ms)","trace[469869524] 'compare' (duration: 84.801362ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:07.171337Z","caller":"traceutil/trace.go:171","msg":"trace[1751983775] transaction","detail":"{read_only:false; response_revision:25882; number_of_response:1; }","duration":"180.624858ms","start":"2026-08-12T01:57:06.990676Z","end":"2026-08-12T01:57:07.171301Z","steps":["trace[1751983775] 'process raft request' (duration: 148.523673ms)","trace[1751983775] 'compare' (duration: 31.86908ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:07.17159Z","caller":"traceutil/trace.go:171","msg":"trace[1607840070] linearizableReadLoop","detail":"{readStateIndex:26729; appliedIndex:26727; }","duration":"119.749355ms","start":"2026-08-12T01:57:07.0518Z","end":"2026-08-12T01:57:07.17155Z","steps":["trace[1607840070] 'read index received' (duration: 87.495017ms)","trace[1607840070] 'applied index is now lower than readState.Index' (duration: 32.252508ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:07.171618Z","caller":"traceutil/trace.go:171","msg":"trace[822971642] transaction","detail":"{read_only:false; response_revision:25883; number_of_response:1; }","duration":"128.151546ms","start":"2026-08-12T01:57:07.043423Z","end":"2026-08-12T01:57:07.171575Z","steps":["trace[822971642] 'process raft request' (duration: 127.791359ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:57:07.171754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.961389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:57:07.171821Z","caller":"traceutil/trace.go:171","msg":"trace[35673471] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:25883; }","duration":"120.080311ms","start":"2026-08-12T01:57:07.051722Z","end":"2026-08-12T01:57:07.171802Z","steps":["trace[35673471] 'agreement among raft nodes before linearized reading' (duration: 119.937948ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:07.412912Z","caller":"traceutil/trace.go:171","msg":"trace[1448087000] transaction","detail":"{read_only:false; response_revision:25884; number_of_response:1; }","duration":"168.469661ms","start":"2026-08-12T01:57:07.244408Z","end":"2026-08-12T01:57:07.412878Z","steps":["trace[1448087000] 'process raft request' (duration: 86.750561ms)","trace[1448087000] 'compare' (duration: 81.540085ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:07.457536Z","caller":"traceutil/trace.go:171","msg":"trace[994740639] linearizableReadLoop","detail":"{readStateIndex:26733; appliedIndex:26729; }","duration":"147.508591ms","start":"2026-08-12T01:57:07.310003Z","end":"2026-08-12T01:57:07.457512Z","steps":["trace[994740639] 'read index received' (duration: 21.428667ms)","trace[994740639] 'applied index is now lower than readState.Index' (duration: 126.078294ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:07.457556Z","caller":"traceutil/trace.go:171","msg":"trace[1317316209] transaction","detail":"{read_only:false; response_revision:25885; number_of_response:1; }","duration":"212.723854ms","start":"2026-08-12T01:57:07.244779Z","end":"2026-08-12T01:57:07.457503Z","steps":["trace[1317316209] 'process raft request' (duration: 212.429008ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:07.457611Z","caller":"traceutil/trace.go:171","msg":"trace[595217378] transaction","detail":"{read_only:false; response_revision:25886; number_of_response:1; }","duration":"212.140972ms","start":"2026-08-12T01:57:07.245444Z","end":"2026-08-12T01:57:07.457585Z","steps":["trace[595217378] 'process raft request' (duration: 211.927587ms)"],"step_count":1} {"level":"warn","ts":"2026-08-12T01:57:07.457734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.39866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-12T01:57:07.457739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.734837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:57:07.457715Z","caller":"traceutil/trace.go:171","msg":"trace[1476401156] transaction","detail":"{read_only:false; response_revision:25887; number_of_response:1; }","duration":"207.19254ms","start":"2026-08-12T01:57:07.250464Z","end":"2026-08-12T01:57:07.457657Z","steps":["trace[1476401156] 'process raft request' (duration: 206.959555ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:07.457794Z","caller":"traceutil/trace.go:171","msg":"trace[2087015727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25887; }","duration":"147.473712ms","start":"2026-08-12T01:57:07.310307Z","end":"2026-08-12T01:57:07.457781Z","steps":["trace[2087015727] 'agreement among raft nodes before linearized reading' (duration: 147.361798ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:07.457808Z","caller":"traceutil/trace.go:171","msg":"trace[1007934450] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:25887; }","duration":"147.87526ms","start":"2026-08-12T01:57:07.309913Z","end":"2026-08-12T01:57:07.457789Z","steps":["trace[1007934450] 'agreement among raft nodes before linearized reading' (duration: 147.753136ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:07.621704Z","caller":"traceutil/trace.go:171","msg":"trace[2020835329] transaction","detail":"{read_only:false; response_revision:25889; number_of_response:1; }","duration":"109.878974ms","start":"2026-08-12T01:57:07.511784Z","end":"2026-08-12T01:57:07.621663Z","steps":["trace[2020835329] 'process raft request' (duration: 42.225453ms)","trace[2020835329] 'compare' (duration: 67.181871ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:08.412794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.817509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:57:08.412894Z","caller":"traceutil/trace.go:171","msg":"trace[1416558927] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25890; }","duration":"102.005883ms","start":"2026-08-12T01:57:08.310864Z","end":"2026-08-12T01:57:08.41287Z","steps":["trace[1416558927] 'range keys from in-memory index tree' (duration: 101.654276ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:08.709781Z","caller":"traceutil/trace.go:171","msg":"trace[584231225] transaction","detail":"{read_only:false; response_revision:25892; number_of_response:1; }","duration":"128.465792ms","start":"2026-08-12T01:57:08.581286Z","end":"2026-08-12T01:57:08.709752Z","steps":["trace[584231225] 'process raft request' (duration: 70.144912ms)","trace[584231225] 'compare' (duration: 58.192858ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:08.935346Z","caller":"traceutil/trace.go:171","msg":"trace[1690124485] transaction","detail":"{read_only:false; response_revision:25893; number_of_response:1; }","duration":"200.966144ms","start":"2026-08-12T01:57:08.734347Z","end":"2026-08-12T01:57:08.935313Z","steps":["trace[1690124485] 'process raft request' (duration: 147.360609ms)","trace[1690124485] 'compare' (duration: 53.432131ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:08.938587Z","caller":"traceutil/trace.go:171","msg":"trace[1627525386] transaction","detail":"{read_only:false; response_revision:25894; number_of_response:1; }","duration":"202.089857ms","start":"2026-08-12T01:57:08.736474Z","end":"2026-08-12T01:57:08.938564Z","steps":["trace[1627525386] 'process raft request' (duration: 201.985405ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:09.172701Z","caller":"traceutil/trace.go:171","msg":"trace[789112375] linearizableReadLoop","detail":"{readStateIndex:26741; appliedIndex:26740; }","duration":"116.997109ms","start":"2026-08-12T01:57:09.055684Z","end":"2026-08-12T01:57:09.172682Z","steps":["trace[789112375] 'read index received' (duration: 109.70675ms)","trace[789112375] 'applied index is now lower than readState.Index' (duration: 7.289229ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:09.172868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.168353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:57:09.172904Z","caller":"traceutil/trace.go:171","msg":"trace[420499420] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:25895; }","duration":"117.264295ms","start":"2026-08-12T01:57:09.055629Z","end":"2026-08-12T01:57:09.172893Z","steps":["trace[420499420] 'agreement among raft nodes before linearized reading' (duration: 117.141312ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:09.173312Z","caller":"traceutil/trace.go:171","msg":"trace[73474236] transaction","detail":"{read_only:false; response_revision:25895; number_of_response:1; }","duration":"127.965814ms","start":"2026-08-12T01:57:09.045291Z","end":"2026-08-12T01:57:09.173256Z","steps":["trace[73474236] 'process raft request' (duration: 120.44412ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:18.917946Z","caller":"traceutil/trace.go:171","msg":"trace[997992138] linearizableReadLoop","detail":"{readStateIndex:26826; appliedIndex:26825; }","duration":"128.214317ms","start":"2026-08-12T01:57:18.789705Z","end":"2026-08-12T01:57:18.91792Z","steps":["trace[997992138] 'read index received' (duration: 128.027364ms)","trace[997992138] 'applied index is now lower than readState.Index' (duration: 185.603µs)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:18.918108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.37115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-12T01:57:18.918146Z","caller":"traceutil/trace.go:171","msg":"trace[1211256321] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:25978; }","duration":"128.454124ms","start":"2026-08-12T01:57:18.789679Z","end":"2026-08-12T01:57:18.918134Z","steps":["trace[1211256321] 'agreement among raft nodes before linearized reading' (duration: 128.359831ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:18.918131Z","caller":"traceutil/trace.go:171","msg":"trace[1493041727] transaction","detail":"{read_only:false; response_revision:25978; number_of_response:1; }","duration":"160.246334ms","start":"2026-08-12T01:57:18.757843Z","end":"2026-08-12T01:57:18.918089Z","steps":["trace[1493041727] 'process raft request' (duration: 159.886496ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:19.133674Z","caller":"traceutil/trace.go:171","msg":"trace[1912217186] linearizableReadLoop","detail":"{readStateIndex:26827; appliedIndex:26826; }","duration":"151.82267ms","start":"2026-08-12T01:57:18.981825Z","end":"2026-08-12T01:57:19.133647Z","steps":["trace[1912217186] 'read index received' (duration: 130.160078ms)","trace[1912217186] 'applied index is now lower than readState.Index' (duration: 21.660992ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:19.133967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.124428ms","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-08-12T01:57:19.134056Z","caller":"traceutil/trace.go:171","msg":"trace[1077656774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25979; }","duration":"152.274971ms","start":"2026-08-12T01:57:18.981767Z","end":"2026-08-12T01:57:19.134042Z","steps":["trace[1077656774] 'agreement among raft nodes before linearized reading' (duration: 152.064526ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:19.134213Z","caller":"traceutil/trace.go:171","msg":"trace[374631855] transaction","detail":"{read_only:false; response_revision:25979; number_of_response:1; }","duration":"159.563299ms","start":"2026-08-12T01:57:18.974636Z","end":"2026-08-12T01:57:19.134199Z","steps":["trace[374631855] 'process raft request' (duration: 137.333895ms)","trace[374631855] 'compare' (duration: 21.546909ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:19.377584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.216345ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-12T01:57:19.377706Z","caller":"traceutil/trace.go:171","msg":"trace[1936187821] transaction","detail":"{read_only:false; response_revision:25980; number_of_response:1; }","duration":"239.061833ms","start":"2026-08-12T01:57:19.138606Z","end":"2026-08-12T01:57:19.377668Z","steps":["trace[1936187821] 'process raft request' (duration: 94.658013ms)","trace[1936187821] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/plndr-svcs-lock; req_size:420; } (duration: 143.48742ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:19.435768Z","caller":"traceutil/trace.go:171","msg":"trace[863989295] transaction","detail":"{read_only:false; response_revision:25982; number_of_response:1; }","duration":"221.284129ms","start":"2026-08-12T01:57:19.214464Z","end":"2026-08-12T01:57:19.435749Z","steps":["trace[863989295] 'process raft request' (duration: 221.233628ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:19.436157Z","caller":"traceutil/trace.go:171","msg":"trace[1362596001] transaction","detail":"{read_only:false; response_revision:25981; number_of_response:1; }","duration":"221.882391ms","start":"2026-08-12T01:57:19.214262Z","end":"2026-08-12T01:57:19.436144Z","steps":["trace[1362596001] 'process raft request' (duration: 221.33052ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:19.452829Z","caller":"traceutil/trace.go:171","msg":"trace[1008450363] transaction","detail":"{read_only:false; response_revision:25983; number_of_response:1; }","duration":"189.265104ms","start":"2026-08-12T01:57:19.263534Z","end":"2026-08-12T01:57:19.452799Z","steps":["trace[1008450363] 'process raft request' (duration: 189.105811ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:19.805967Z","caller":"traceutil/trace.go:171","msg":"trace[896212137] transaction","detail":"{read_only:false; response_revision:25985; number_of_response:1; }","duration":"223.065515ms","start":"2026-08-12T01:57:19.582787Z","end":"2026-08-12T01:57:19.805853Z","steps":["trace[896212137] 'process raft request' (duration: 190.717764ms)","trace[896212137] 'compare' (duration: 32.026344ms)"],"step_count":2} {"level":"info","ts":"2026-08-12T01:57:19.806237Z","caller":"traceutil/trace.go:171","msg":"trace[1685682553] transaction","detail":"{read_only:false; response_revision:25986; number_of_response:1; }","duration":"221.548815ms","start":"2026-08-12T01:57:19.584669Z","end":"2026-08-12T01:57:19.806218Z","steps":["trace[1685682553] 'process raft request' (duration: 221.116765ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:19.806424Z","caller":"traceutil/trace.go:171","msg":"trace[1991317178] linearizableReadLoop","detail":"{readStateIndex:26835; appliedIndex:26831; }","duration":"212.746255ms","start":"2026-08-12T01:57:19.593665Z","end":"2026-08-12T01:57:19.806411Z","steps":["trace[1991317178] 'read index received' (duration: 20.450888ms)","trace[1991317178] 'applied index is now lower than readState.Index' (duration: 192.294067ms)"],"step_count":2} {"level":"warn","ts":"2026-08-12T01:57:19.806679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.145773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-12T01:57:19.806678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.99624ms","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-08-12T01:57:19.806721Z","caller":"traceutil/trace.go:171","msg":"trace[1688753199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25987; }","duration":"120.244876ms","start":"2026-08-12T01:57:19.686458Z","end":"2026-08-12T01:57:19.806703Z","steps":["trace[1688753199] 'agreement among raft nodes before linearized reading' (duration: 120.092043ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:19.806723Z","caller":"traceutil/trace.go:171","msg":"trace[1421418907] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25987; }","duration":"213.111692ms","start":"2026-08-12T01:57:19.593597Z","end":"2026-08-12T01:57:19.806709Z","steps":["trace[1421418907] 'agreement among raft nodes before linearized reading' (duration: 212.923578ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:19.806686Z","caller":"traceutil/trace.go:171","msg":"trace[345938836] transaction","detail":"{read_only:false; response_revision:25987; number_of_response:1; }","duration":"220.949952ms","start":"2026-08-12T01:57:19.585697Z","end":"2026-08-12T01:57:19.806647Z","steps":["trace[345938836] 'process raft request' (duration: 220.384209ms)"],"step_count":1} {"level":"info","ts":"2026-08-12T01:57:29.854618Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006921.wal"} {"level":"info","ts":"2026-08-12T02:01:51.430049Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25761} {"level":"info","ts":"2026-08-12T02:01:51.612676Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25761,"took":"177.74505ms","hash":1026594092,"current-db-size-bytes":58511360,"current-db-size":"58 MB","current-db-size-in-use-bytes":37036032,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-08-12T02:01:51.61276Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1026594092,"revision":25761,"compact-revision":22321} {"level":"info","ts":"2026-08-12T02:02:41.18303Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-12T02:02:41.190055Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-12T02:02:41.190304Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-08-12T02:06:51.437497Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28704} {"level":"info","ts":"2026-08-12T02:06:51.574939Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28704,"took":"132.41896ms","hash":2259325846,"current-db-size-bytes":58511360,"current-db-size":"58 MB","current-db-size-in-use-bytes":32301056,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-12T02:06:51.575018Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2259325846,"revision":28704,"compact-revision":25761} {"level":"info","ts":"2026-08-12T02:11:51.444917Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30966} {"level":"info","ts":"2026-08-12T02:11:51.586948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30966,"took":"135.781854ms","hash":2318343647,"current-db-size-bytes":58511360,"current-db-size":"58 MB","current-db-size-in-use-bytes":31444992,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-12T02:11:51.587032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2318343647,"revision":30966,"compact-revision":28704} {"level":"info","ts":"2026-08-12T02:16:51.452358Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33225} {"level":"info","ts":"2026-08-12T02:16:51.597283Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33225,"took":"139.795486ms","hash":891074492,"current-db-size-bytes":58511360,"current-db-size":"58 MB","current-db-size-in-use-bytes":30781440,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-12T02:16:51.597381Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":891074492,"revision":33225,"compact-revision":30966} {"level":"info","ts":"2026-08-12T02:21:51.461767Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35455} {"level":"info","ts":"2026-08-12T02:21:51.611912Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35455,"took":"144.983771ms","hash":4164368590,"current-db-size-bytes":59420672,"current-db-size":"59 MB","current-db-size-in-use-bytes":32141312,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-12T02:21:51.612016Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4164368590,"revision":35455,"compact-revision":33225} {"level":"info","ts":"2026-08-12T02:24:08.556412Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9133559b3198d4ec","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-12T02:24:08.563349Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-08-12T02:24:08.563501Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-08-12T02:26:51.470294Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37750} {"level":"info","ts":"2026-08-12T02:26:51.5888Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37750,"took":"113.885615ms","hash":74966365,"current-db-size-bytes":60272640,"current-db-size":"60 MB","current-db-size-in-use-bytes":31604736,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-12T02:26:51.588872Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":74966365,"revision":37750,"compact-revision":35455} {"level":"info","ts":"2026-08-12T02:31:51.480959Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":40026} {"level":"info","ts":"2026-08-12T02:31:51.627555Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":40026,"took":"142.835148ms","hash":1432678406,"current-db-size-bytes":60694528,"current-db-size":"61 MB","current-db-size-in-use-bytes":31875072,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-12T02:31:51.62763Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1432678406,"revision":40026,"compact-revision":37750}