{"level":"warn","ts":"2026-06-05T06:03:45.06033Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T06:03:45.060548Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.248: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.248:2380","--initial-cluster=instance=https://199.204.45.248:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.248:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.248: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-06-05T06:03:45.060765Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-05T06:03:45.060884Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-06-05T06:03:45.061011Z","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-06-05T06:03:45.062636Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"]} {"level":"info","ts":"2026-06-05T06:03:45.062836Z","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.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.248: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-06-05T06:03:45.067495Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.321673ms"} {"level":"info","ts":"2026-06-05T06:03:45.074091Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"39582465ceaa2f67","cluster-id":"87fd8ddedde3be45"} {"level":"info","ts":"2026-06-05T06:03:45.074178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=()"} {"level":"info","ts":"2026-06-05T06:03:45.074217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 0"} {"level":"info","ts":"2026-06-05T06:03:45.074247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 39582465ceaa2f67 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-05T06:03:45.074261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became follower at term 1"} {"level":"info","ts":"2026-06-05T06:03:45.074317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"warn","ts":"2026-06-05T06:03:45.086414Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-05T06:03:45.08844Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-05T06:03:45.090033Z","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-06-05T06:03:45.092449Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"39582465ceaa2f67","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-05T06:03:45.092569Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"39582465ceaa2f67","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-05T06:03:45.092756Z","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-06-05T06:03:45.092924Z","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-06-05T06:03:45.092978Z","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-06-05T06:03:45.0934Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 switched to configuration voters=(4132092677789986663)"} {"level":"info","ts":"2026-06-05T06:03:45.093514Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","added-peer-id":"39582465ceaa2f67","added-peer-peer-urls":["https://199.204.45.248:2380"]} {"level":"info","ts":"2026-06-05T06:03:45.095306Z","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-06-05T06:03:45.095413Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-06-05T06:03:45.09545Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.248:2380"} {"level":"info","ts":"2026-06-05T06:03:45.09553Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"39582465ceaa2f67","initial-advertise-peer-urls":["https://199.204.45.248:2380"],"listen-peer-urls":["https://199.204.45.248:2380"],"advertise-client-urls":["https://199.204.45.248:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.248:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-05T06:03:45.095576Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-05T06:03:45.27584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 is starting a new election at term 1"} {"level":"info","ts":"2026-06-05T06:03:45.275885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-05T06:03:45.275907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgPreVoteResp from 39582465ceaa2f67 at term 1"} {"level":"info","ts":"2026-06-05T06:03:45.27592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became candidate at term 2"} {"level":"info","ts":"2026-06-05T06:03:45.275926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 received MsgVoteResp from 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-06-05T06:03:45.275936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"39582465ceaa2f67 became leader at term 2"} {"level":"info","ts":"2026-06-05T06:03:45.275945Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 39582465ceaa2f67 elected leader 39582465ceaa2f67 at term 2"} {"level":"info","ts":"2026-06-05T06:03:45.283927Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T06:03:45.292018Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"39582465ceaa2f67","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.248:2379]}","request-path":"/0/members/39582465ceaa2f67/attributes","cluster-id":"87fd8ddedde3be45","publish-timeout":"7s"} {"level":"info","ts":"2026-06-05T06:03:45.292086Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T06:03:45.292021Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-05T06:03:45.292632Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"87fd8ddedde3be45","local-member-id":"39582465ceaa2f67","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T06:03:45.292822Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T06:03:45.292867Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-05T06:03:45.295075Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-05T06:03:45.295473Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.248:2379"} {"level":"info","ts":"2026-06-05T06:03:45.295821Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-05T06:03:45.295857Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-06-05T06:03:59.087231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.661471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-05T06:03:59.087377Z","caller":"traceutil/trace.go:171","msg":"trace[2044971765] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:356; }","duration":"167.856506ms","start":"2026-06-05T06:03:58.919501Z","end":"2026-06-05T06:03:59.087357Z","steps":["trace[2044971765] 'range keys from in-memory index tree' (duration: 167.546868ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:03:59.44951Z","caller":"traceutil/trace.go:171","msg":"trace[1107726363] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"358.323535ms","start":"2026-06-05T06:03:59.091164Z","end":"2026-06-05T06:03:59.449488Z","steps":["trace[1107726363] 'process raft request' (duration: 358.18136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:03:59.450378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:59.091147Z","time spent":"358.442889ms","remote":"127.0.0.1:38950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T06:03:59.637423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.90269ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:03:59.637586Z","caller":"traceutil/trace.go:171","msg":"trace[804289497] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"545.794568ms","start":"2026-06-05T06:03:59.09175Z","end":"2026-06-05T06:03:59.637545Z","steps":["trace[804289497] 'process raft request' (duration: 403.474927ms)","trace[804289497] 'compare' (duration: 141.734884ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:03:59.637866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:03:59.091741Z","time spent":"545.940072ms","remote":"127.0.0.1:38950","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-06-05T06:04:23.467989Z","caller":"traceutil/trace.go:171","msg":"trace[589988020] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"104.123856ms","start":"2026-06-05T06:04:23.363843Z","end":"2026-06-05T06:04:23.467967Z","steps":["trace[589988020] 'process raft request' (duration: 104.007743ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.552185Z","caller":"traceutil/trace.go:171","msg":"trace[1653227650] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"185.203179ms","start":"2026-06-05T06:04:23.36694Z","end":"2026-06-05T06:04:23.552143Z","steps":["trace[1653227650] 'process raft request' (duration: 158.958914ms)","trace[1653227650] 'compare' (duration: 26.012339ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:23.552261Z","caller":"traceutil/trace.go:171","msg":"trace[2027720624] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"184.19215ms","start":"2026-06-05T06:04:23.368036Z","end":"2026-06-05T06:04:23.552229Z","steps":["trace[2027720624] 'process raft request' (duration: 183.991904ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.552362Z","caller":"traceutil/trace.go:171","msg":"trace[48478050] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"176.158091ms","start":"2026-06-05T06:04:23.376191Z","end":"2026-06-05T06:04:23.552349Z","steps":["trace[48478050] 'process raft request' (duration: 176.044278ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.55244Z","caller":"traceutil/trace.go:171","msg":"trace[726711496] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"177.373416ms","start":"2026-06-05T06:04:23.375058Z","end":"2026-06-05T06:04:23.552431Z","steps":["trace[726711496] 'process raft request' (duration: 177.124099ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.552466Z","caller":"traceutil/trace.go:171","msg":"trace[1095220962] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"174.915046ms","start":"2026-06-05T06:04:23.377538Z","end":"2026-06-05T06:04:23.552453Z","steps":["trace[1095220962] 'process raft request' (duration: 174.736191ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.552543Z","caller":"traceutil/trace.go:171","msg":"trace[373401639] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"174.719982ms","start":"2026-06-05T06:04:23.377815Z","end":"2026-06-05T06:04:23.552535Z","steps":["trace[373401639] 'process raft request' (duration: 174.501405ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.552557Z","caller":"traceutil/trace.go:171","msg":"trace[1298549172] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"172.467688ms","start":"2026-06-05T06:04:23.380062Z","end":"2026-06-05T06:04:23.55253Z","steps":["trace[1298549172] 'process raft request' (duration: 172.293742ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.5526Z","caller":"traceutil/trace.go:171","msg":"trace[551044467] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:503; }","duration":"154.233751ms","start":"2026-06-05T06:04:23.398347Z","end":"2026-06-05T06:04:23.55258Z","steps":["trace[551044467] 'read index received' (duration: 69.515674ms)","trace[551044467] 'applied index is now lower than readState.Index' (duration: 84.717177ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:23.552628Z","caller":"traceutil/trace.go:171","msg":"trace[606012131] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"143.121455ms","start":"2026-06-05T06:04:23.409498Z","end":"2026-06-05T06:04:23.552619Z","steps":["trace[606012131] 'process raft request' (duration: 142.97886ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.552694Z","caller":"traceutil/trace.go:171","msg":"trace[1183539126] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"158.951314ms","start":"2026-06-05T06:04:23.393735Z","end":"2026-06-05T06:04:23.552686Z","steps":["trace[1183539126] 'process raft request' (duration: 158.678635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.552704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.340383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:04:23.552735Z","caller":"traceutil/trace.go:171","msg":"trace[1779609996] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:492; }","duration":"154.409716ms","start":"2026-06-05T06:04:23.398316Z","end":"2026-06-05T06:04:23.552725Z","steps":["trace[1779609996] 'agreement among raft nodes before linearized reading' (duration: 154.329723ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.552765Z","caller":"traceutil/trace.go:171","msg":"trace[1643566100] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"132.100542ms","start":"2026-06-05T06:04:23.420625Z","end":"2026-06-05T06:04:23.552726Z","steps":["trace[1643566100] 'process raft request' (duration: 131.907436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.867561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.00087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:04:23.867931Z","caller":"traceutil/trace.go:171","msg":"trace[64673942] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"393.424941ms","start":"2026-06-05T06:04:23.474471Z","end":"2026-06-05T06:04:23.867896Z","steps":["trace[64673942] 'process raft request' (duration: 287.01163ms)","trace[64673942] 'compare' (duration: 105.831585ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:23.868083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.474417Z","time spent":"393.591465ms","remote":"127.0.0.1:39200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T06:04:23.868139Z","caller":"traceutil/trace.go:171","msg":"trace[33889384] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"392.168615ms","start":"2026-06-05T06:04:23.475945Z","end":"2026-06-05T06:04:23.868113Z","steps":["trace[33889384] 'process raft request' (duration: 391.887327ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.868296Z","caller":"traceutil/trace.go:171","msg":"trace[255167240] transaction","detail":"{read_only:false; number_of_response:1; response_revision:494; }","duration":"391.841426ms","start":"2026-06-05T06:04:23.476443Z","end":"2026-06-05T06:04:23.868284Z","steps":["trace[255167240] 'process raft request' (duration: 391.493236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.868294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.475935Z","time spent":"392.280848ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T06:04:23.868383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.476426Z","time spent":"391.903868ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T06:04:23.868617Z","caller":"traceutil/trace.go:171","msg":"trace[245592877] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"339.300524ms","start":"2026-06-05T06:04:23.529303Z","end":"2026-06-05T06:04:23.868604Z","steps":["trace[245592877] 'process raft request' (duration: 338.81369ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.868613Z","caller":"traceutil/trace.go:171","msg":"trace[1989732723] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"308.841819ms","start":"2026-06-05T06:04:23.559755Z","end":"2026-06-05T06:04:23.868597Z","steps":["trace[1989732723] 'process raft request' (duration: 308.708725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.868675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.529277Z","time spent":"339.372206ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T06:04:23.868688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.559734Z","time spent":"308.925792ms","remote":"127.0.0.1:39200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T06:04:23.868872Z","caller":"traceutil/trace.go:171","msg":"trace[1812747875] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"304.853535ms","start":"2026-06-05T06:04:23.564005Z","end":"2026-06-05T06:04:23.868859Z","steps":["trace[1812747875] 'process raft request' (duration: 304.592738ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.868862Z","caller":"traceutil/trace.go:171","msg":"trace[1773194877] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"304.859245ms","start":"2026-06-05T06:04:23.563973Z","end":"2026-06-05T06:04:23.868833Z","steps":["trace[1773194877] 'process raft request' (duration: 304.591208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.868944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.564002Z","time spent":"304.920377ms","remote":"127.0.0.1:39200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T06:04:23.869034Z","caller":"traceutil/trace.go:171","msg":"trace[649357942] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"304.485236ms","start":"2026-06-05T06:04:23.564533Z","end":"2026-06-05T06:04:23.869018Z","steps":["trace[649357942] 'process raft request' (duration: 304.204018ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.869047Z","caller":"traceutil/trace.go:171","msg":"trace[661099101] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"309.116547ms","start":"2026-06-05T06:04:23.559921Z","end":"2026-06-05T06:04:23.869037Z","steps":["trace[661099101] 'process raft request' (duration: 308.606183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.8691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.559911Z","time spent":"309.169269ms","remote":"127.0.0.1:39200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T06:04:23.869131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.564526Z","time spent":"304.553498ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T06:04:23.869255Z","caller":"traceutil/trace.go:171","msg":"trace[2142682956] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"300.443842ms","start":"2026-06-05T06:04:23.568793Z","end":"2026-06-05T06:04:23.869237Z","steps":["trace[2142682956] 'process raft request' (duration: 300.028299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.872118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.56877Z","time spent":"303.294783ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T06:04:23.868985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.563967Z","time spent":"304.970648ms","remote":"127.0.0.1:39200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-05T06:04:23.873221Z","caller":"traceutil/trace.go:171","msg":"trace[1488218913] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"304.308091ms","start":"2026-06-05T06:04:23.56889Z","end":"2026-06-05T06:04:23.873198Z","steps":["trace[1488218913] 'process raft request' (duration: 300.111651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.873349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.568871Z","time spent":"304.400724ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T06:04:23.873464Z","caller":"traceutil/trace.go:171","msg":"trace[2011624678] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"302.928791ms","start":"2026-06-05T06:04:23.570436Z","end":"2026-06-05T06:04:23.873365Z","steps":["trace[2011624678] 'process raft request' (duration: 298.809015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.87369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.570427Z","time spent":"303.166708ms","remote":"127.0.0.1:38704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T06:04:23.880385Z","caller":"traceutil/trace.go:171","msg":"trace[818534313] linearizableReadLoop","detail":"{readStateIndex:518; appliedIndex:514; }","duration":"326.260534ms","start":"2026-06-05T06:04:23.554084Z","end":"2026-06-05T06:04:23.880344Z","steps":["trace[818534313] 'read index received' (duration: 207.469061ms)","trace[818534313] 'applied index is now lower than readState.Index' (duration: 118.790883ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:23.880627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.895363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-05T06:04:23.880625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.47423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:04:23.880702Z","caller":"traceutil/trace.go:171","msg":"trace[1730920721] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:503; }","duration":"313.985576ms","start":"2026-06-05T06:04:23.566702Z","end":"2026-06-05T06:04:23.880687Z","steps":["trace[1730920721] 'agreement among raft nodes before linearized reading' (duration: 313.854352ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:23.8808Z","caller":"traceutil/trace.go:171","msg":"trace[1500922158] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:503; }","duration":"326.692107ms","start":"2026-06-05T06:04:23.554051Z","end":"2026-06-05T06:04:23.880743Z","steps":["trace[1500922158] 'agreement among raft nodes before linearized reading' (duration: 326.395068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:23.880884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.554037Z","time spent":"326.834621ms","remote":"127.0.0.1:38676","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-05T06:04:23.880865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:23.566695Z","time spent":"314.13812ms","remote":"127.0.0.1:38950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-05T06:04:23.880906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.731005ms","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-06-05T06:04:23.881081Z","caller":"traceutil/trace.go:171","msg":"trace[1361184782] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:503; }","duration":"104.011803ms","start":"2026-06-05T06:04:23.77704Z","end":"2026-06-05T06:04:23.881052Z","steps":["trace[1361184782] 'agreement among raft nodes before linearized reading' (duration: 103.580521ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:30.844214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.957199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:04:30.84435Z","caller":"traceutil/trace.go:171","msg":"trace[1241126565] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"433.316524ms","start":"2026-06-05T06:04:30.41101Z","end":"2026-06-05T06:04:30.844327Z","steps":["trace[1241126565] 'read index received' (duration: 278.23749ms)","trace[1241126565] 'applied index is now lower than readState.Index' (duration: 155.076843ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:04:30.844439Z","caller":"traceutil/trace.go:171","msg":"trace[492886044] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"493.704529ms","start":"2026-06-05T06:04:30.350695Z","end":"2026-06-05T06:04:30.8444Z","steps":["trace[492886044] 'process raft request' (duration: 338.493852ms)","trace[492886044] 'compare' (duration: 154.840516ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:30.844607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:30.35067Z","time spent":"493.869614ms","remote":"127.0.0.1:39012","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-05T06:04:30.844653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.626613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-05T06:04:30.844703Z","caller":"traceutil/trace.go:171","msg":"trace[1001353537] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"433.714846ms","start":"2026-06-05T06:04:30.410973Z","end":"2026-06-05T06:04:30.844688Z","steps":["trace[1001353537] 'agreement among raft nodes before linearized reading' (duration: 433.477498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:30.844761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:30.410955Z","time spent":"433.792528ms","remote":"127.0.0.1:38950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-05T06:04:30.84481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.891827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-pq74c\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-05T06:04:30.844909Z","caller":"traceutil/trace.go:171","msg":"trace[694761665] range","detail":"{range_begin:/registry/pods/kube-system/cilium-pq74c; range_end:; response_count:1; response_revision:584; }","duration":"181.054962ms","start":"2026-06-05T06:04:30.663829Z","end":"2026-06-05T06:04:30.844884Z","steps":["trace[694761665] 'agreement among raft nodes before linearized reading' (duration: 180.776844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:44.275889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"875.624663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:04:44.275952Z","caller":"traceutil/trace.go:171","msg":"trace[1475280281] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:728; }","duration":"875.728866ms","start":"2026-06-05T06:04:43.40021Z","end":"2026-06-05T06:04:44.275939Z","steps":["trace[1475280281] 'range keys from in-memory index tree' (duration: 875.557382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:44.275998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:04:43.400192Z","time spent":"875.799589ms","remote":"127.0.0.1:38664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-05T06:04:44.27912Z","caller":"traceutil/trace.go:171","msg":"trace[604127154] linearizableReadLoop","detail":"{readStateIndex:757; appliedIndex:756; }","duration":"206.031339ms","start":"2026-06-05T06:04:44.073076Z","end":"2026-06-05T06:04:44.279108Z","steps":["trace[604127154] 'read index received' (duration: 202.113308ms)","trace[604127154] 'applied index is now lower than readState.Index' (duration: 3.917211ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:04:44.279278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.196234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-05T06:04:44.279387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.553228ms","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-06-05T06:04:44.279399Z","caller":"traceutil/trace.go:171","msg":"trace[1162923632] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:728; }","duration":"206.323888ms","start":"2026-06-05T06:04:44.073017Z","end":"2026-06-05T06:04:44.279341Z","steps":["trace[1162923632] 'agreement among raft nodes before linearized reading' (duration: 206.132552ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:04:44.279415Z","caller":"traceutil/trace.go:171","msg":"trace[1750716801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:728; }","duration":"204.606479ms","start":"2026-06-05T06:04:44.074801Z","end":"2026-06-05T06:04:44.279408Z","steps":["trace[1750716801] 'agreement among raft nodes before linearized reading' (duration: 204.506897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:04:44.279401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.050402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-05T06:04:44.279491Z","caller":"traceutil/trace.go:171","msg":"trace[955937156] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:728; }","duration":"205.172105ms","start":"2026-06-05T06:04:44.074297Z","end":"2026-06-05T06:04:44.279469Z","steps":["trace[955937156] 'agreement among raft nodes before linearized reading' (duration: 204.934028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:06:03.554454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.547343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:06:03.554537Z","caller":"traceutil/trace.go:171","msg":"trace[1500026071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1826; }","duration":"158.681926ms","start":"2026-06-05T06:06:03.395832Z","end":"2026-06-05T06:06:03.554514Z","steps":["trace[1500026071] 'range keys from in-memory index tree' (duration: 158.46763ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:03.554631Z","caller":"traceutil/trace.go:171","msg":"trace[42507906] linearizableReadLoop","detail":"{readStateIndex:1902; appliedIndex:1901; }","duration":"127.590616ms","start":"2026-06-05T06:06:03.427019Z","end":"2026-06-05T06:06:03.554609Z","steps":["trace[42507906] 'read index received' (duration: 119.451973ms)","trace[42507906] 'applied index is now lower than readState.Index' (duration: 8.137523ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:06:03.55472Z","caller":"traceutil/trace.go:171","msg":"trace[784184232] transaction","detail":"{read_only:false; response_revision:1827; number_of_response:1; }","duration":"132.232338ms","start":"2026-06-05T06:06:03.422459Z","end":"2026-06-05T06:06:03.554691Z","steps":["trace[784184232] 'process raft request' (duration: 124.040263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:06:03.554859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.833114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-05T06:06:03.5549Z","caller":"traceutil/trace.go:171","msg":"trace[727660222] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1827; }","duration":"127.932626ms","start":"2026-06-05T06:06:03.426955Z","end":"2026-06-05T06:06:03.554887Z","steps":["trace[727660222] 'agreement among raft nodes before linearized reading' (duration: 127.794212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:06:03.988515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.320012ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-05T06:06:04.017547Z","caller":"traceutil/trace.go:171","msg":"trace[485813886] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"161.900849ms","start":"2026-06-05T06:06:03.855614Z","end":"2026-06-05T06:06:04.017515Z","steps":["trace[485813886] 'process raft request' (duration: 161.709953ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:17.745537Z","caller":"traceutil/trace.go:171","msg":"trace[641600903] transaction","detail":"{read_only:false; response_revision:1944; number_of_response:1; }","duration":"144.392796ms","start":"2026-06-05T06:06:17.601093Z","end":"2026-06-05T06:06:17.745485Z","steps":["trace[641600903] 'process raft request' (duration: 144.196611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:06:53.209528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.308624ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:06:53.209711Z","caller":"traceutil/trace.go:171","msg":"trace[1003227277] linearizableReadLoop","detail":"{readStateIndex:2240; appliedIndex:2238; }","duration":"125.453975ms","start":"2026-06-05T06:06:53.084238Z","end":"2026-06-05T06:06:53.209692Z","steps":["trace[1003227277] 'read index received' (duration: 78.17274ms)","trace[1003227277] 'applied index is now lower than readState.Index' (duration: 47.280315ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:06:53.209795Z","caller":"traceutil/trace.go:171","msg":"trace[1798482084] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"174.952472ms","start":"2026-06-05T06:06:53.034834Z","end":"2026-06-05T06:06:53.209786Z","steps":["trace[1798482084] 'process raft request' (duration: 174.806437ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:53.209878Z","caller":"traceutil/trace.go:171","msg":"trace[1132725620] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"207.150245ms","start":"2026-06-05T06:06:53.002688Z","end":"2026-06-05T06:06:53.209838Z","steps":["trace[1132725620] 'process raft request' (duration: 32.44352ms)","trace[1132725620] 'compare' (duration: 174.136229ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:06:53.210286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.036761ms","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-06-05T06:06:53.21048Z","caller":"traceutil/trace.go:171","msg":"trace[1419172781] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2154; }","duration":"126.238327ms","start":"2026-06-05T06:06:53.08422Z","end":"2026-06-05T06:06:53.210459Z","steps":["trace[1419172781] 'agreement among raft nodes before linearized reading' (duration: 125.794144ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:54.088033Z","caller":"traceutil/trace.go:171","msg":"trace[139304101] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"125.703471ms","start":"2026-06-05T06:06:53.962294Z","end":"2026-06-05T06:06:54.087997Z","steps":["trace[139304101] 'process raft request' (duration: 125.457223ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:59.379597Z","caller":"traceutil/trace.go:171","msg":"trace[1664184530] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"152.585952ms","start":"2026-06-05T06:06:59.226986Z","end":"2026-06-05T06:06:59.379572Z","steps":["trace[1664184530] 'process raft request' (duration: 152.383476ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:59.554061Z","caller":"traceutil/trace.go:171","msg":"trace[1426056275] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"170.131415ms","start":"2026-06-05T06:06:59.383832Z","end":"2026-06-05T06:06:59.553963Z","steps":["trace[1426056275] 'process raft request' (duration: 126.632118ms)","trace[1426056275] 'compare' (duration: 43.084575ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:06:59.62101Z","caller":"traceutil/trace.go:171","msg":"trace[1401276630] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"236.585679ms","start":"2026-06-05T06:06:59.384389Z","end":"2026-06-05T06:06:59.620975Z","steps":["trace[1401276630] 'process raft request' (duration: 236.527747ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:06:59.621084Z","caller":"traceutil/trace.go:171","msg":"trace[1835071672] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"237.144914ms","start":"2026-06-05T06:06:59.383893Z","end":"2026-06-05T06:06:59.621038Z","steps":["trace[1835071672] 'process raft request' (duration: 236.817565ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:08:31.903948Z","caller":"traceutil/trace.go:171","msg":"trace[1114906218] transaction","detail":"{read_only:false; response_revision:2874; number_of_response:1; }","duration":"203.829948ms","start":"2026-06-05T06:08:31.700073Z","end":"2026-06-05T06:08:31.903903Z","steps":["trace[1114906218] 'process raft request' (duration: 113.051168ms)","trace[1114906218] 'compare' (duration: 90.264766ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:10:57.673052Z","caller":"traceutil/trace.go:171","msg":"trace[1263618245] transaction","detail":"{read_only:false; response_revision:3846; number_of_response:1; }","duration":"129.308346ms","start":"2026-06-05T06:10:57.543717Z","end":"2026-06-05T06:10:57.673025Z","steps":["trace[1263618245] 'process raft request' (duration: 129.154312ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:21.06311Z","caller":"traceutil/trace.go:171","msg":"trace[1040864440] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"108.809826ms","start":"2026-06-05T06:12:20.954277Z","end":"2026-06-05T06:12:21.063086Z","steps":["trace[1040864440] 'process raft request' (duration: 89.933528ms)","trace[1040864440] 'compare' (duration: 18.386585ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:12:26.46783Z","caller":"traceutil/trace.go:171","msg":"trace[24688185] transaction","detail":"{read_only:false; response_revision:4907; number_of_response:1; }","duration":"143.247701ms","start":"2026-06-05T06:12:26.324555Z","end":"2026-06-05T06:12:26.467803Z","steps":["trace[24688185] 'process raft request' (duration: 143.126328ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:26.467833Z","caller":"traceutil/trace.go:171","msg":"trace[1123743481] transaction","detail":"{read_only:false; response_revision:4906; number_of_response:1; }","duration":"143.407996ms","start":"2026-06-05T06:12:26.324394Z","end":"2026-06-05T06:12:26.467802Z","steps":["trace[1123743481] 'process raft request' (duration: 95.94873ms)","trace[1123743481] 'compare' (duration: 47.229029ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:12:26.467979Z","caller":"traceutil/trace.go:171","msg":"trace[1432513723] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"143.324513ms","start":"2026-06-05T06:12:26.324599Z","end":"2026-06-05T06:12:26.467924Z","steps":["trace[1432513723] 'process raft request' (duration: 143.119008ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:26.468211Z","caller":"traceutil/trace.go:171","msg":"trace[254336157] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"143.55569ms","start":"2026-06-05T06:12:26.32463Z","end":"2026-06-05T06:12:26.468186Z","steps":["trace[254336157] 'process raft request' (duration: 143.113667ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:26.468351Z","caller":"traceutil/trace.go:171","msg":"trace[159311464] transaction","detail":"{read_only:false; response_revision:4910; number_of_response:1; }","duration":"143.513079ms","start":"2026-06-05T06:12:26.32479Z","end":"2026-06-05T06:12:26.468303Z","steps":["trace[159311464] 'process raft request' (duration: 142.977004ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:26.468594Z","caller":"traceutil/trace.go:171","msg":"trace[475796058] linearizableReadLoop","detail":"{readStateIndex:5104; appliedIndex:5098; }","duration":"143.375665ms","start":"2026-06-05T06:12:26.325103Z","end":"2026-06-05T06:12:26.468479Z","steps":["trace[475796058] 'read index received' (duration: 22.794721ms)","trace[475796058] 'applied index is now lower than readState.Index' (duration: 120.579404ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:12:26.468681Z","caller":"traceutil/trace.go:171","msg":"trace[1083500575] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"135.068607ms","start":"2026-06-05T06:12:26.333451Z","end":"2026-06-05T06:12:26.468519Z","steps":["trace[1083500575] 'process raft request' (duration: 134.370938ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:12:26.468711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.587461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-06-05T06:12:26.468765Z","caller":"traceutil/trace.go:171","msg":"trace[200440156] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4911; }","duration":"143.680974ms","start":"2026-06-05T06:12:26.325068Z","end":"2026-06-05T06:12:26.468749Z","steps":["trace[200440156] 'agreement among raft nodes before linearized reading' (duration: 143.515199ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:30.684126Z","caller":"traceutil/trace.go:171","msg":"trace[1618983063] transaction","detail":"{read_only:false; response_revision:5072; number_of_response:1; }","duration":"180.846079ms","start":"2026-06-05T06:12:30.503242Z","end":"2026-06-05T06:12:30.684088Z","steps":["trace[1618983063] 'process raft request' (duration: 164.135821ms)","trace[1618983063] 'compare' (duration: 16.381919ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:12:32.321873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.802594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:12:32.321996Z","caller":"traceutil/trace.go:171","msg":"trace[946314284] linearizableReadLoop","detail":"{readStateIndex:5311; appliedIndex:5310; }","duration":"230.341773ms","start":"2026-06-05T06:12:32.091637Z","end":"2026-06-05T06:12:32.321979Z","steps":["trace[946314284] 'read index received' (duration: 53.661µs)","trace[946314284] 'applied index is now lower than readState.Index' (duration: 230.286962ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:12:32.322118Z","caller":"traceutil/trace.go:171","msg":"trace[282398666] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"236.442617ms","start":"2026-06-05T06:12:32.085629Z","end":"2026-06-05T06:12:32.322071Z","steps":["trace[282398666] 'compare' (duration: 232.68338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:12:32.322353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.93622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:12:32.322438Z","caller":"traceutil/trace.go:171","msg":"trace[652897252] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:5110; }","duration":"211.039863ms","start":"2026-06-05T06:12:32.111379Z","end":"2026-06-05T06:12:32.322419Z","steps":["trace[652897252] 'agreement among raft nodes before linearized reading' (duration: 210.856587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:12:32.322776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.143587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:413130"} {"level":"info","ts":"2026-06-05T06:12:32.322821Z","caller":"traceutil/trace.go:171","msg":"trace[826016577] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:5110; }","duration":"231.270891ms","start":"2026-06-05T06:12:32.091537Z","end":"2026-06-05T06:12:32.322808Z","steps":["trace[826016577] 'agreement among raft nodes before linearized reading' (duration: 231.040524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:12:32.322518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.28996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/goldpinger\" ","response":"range_response_count:1 size:799"} {"level":"info","ts":"2026-06-05T06:12:32.323097Z","caller":"traceutil/trace.go:171","msg":"trace[1659499305] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/goldpinger; range_end:; response_count:1; response_revision:5110; }","duration":"140.920057ms","start":"2026-06-05T06:12:32.182155Z","end":"2026-06-05T06:12:32.323075Z","steps":["trace[1659499305] 'agreement among raft nodes before linearized reading' (duration: 140.146385ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:51.051098Z","caller":"traceutil/trace.go:171","msg":"trace[86124497] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"117.378445ms","start":"2026-06-05T06:12:50.933695Z","end":"2026-06-05T06:12:51.051073Z","steps":["trace[86124497] 'process raft request' (duration: 117.234241ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:51.366154Z","caller":"traceutil/trace.go:171","msg":"trace[1424059] linearizableReadLoop","detail":"{readStateIndex:5656; appliedIndex:5654; }","duration":"155.080503ms","start":"2026-06-05T06:12:51.211036Z","end":"2026-06-05T06:12:51.366117Z","steps":["trace[1424059] 'read index received' (duration: 3.463209ms)","trace[1424059] 'applied index is now lower than readState.Index' (duration: 151.616644ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:12:51.366227Z","caller":"traceutil/trace.go:171","msg":"trace[1755729603] transaction","detail":"{read_only:false; response_revision:5446; number_of_response:1; }","duration":"175.473275ms","start":"2026-06-05T06:12:51.190722Z","end":"2026-06-05T06:12:51.366195Z","steps":["trace[1755729603] 'process raft request' (duration: 130.252602ms)","trace[1755729603] 'compare' (duration: 45.036578ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:12:51.366486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.434303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-258c3a13-c946-412b-ae6a-a8d06337fb11\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-05T06:12:51.36652Z","caller":"traceutil/trace.go:171","msg":"trace[2008833075] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-258c3a13-c946-412b-ae6a-a8d06337fb11; range_end:; response_count:1; response_revision:5446; }","duration":"155.525125ms","start":"2026-06-05T06:12:51.210986Z","end":"2026-06-05T06:12:51.366512Z","steps":["trace[2008833075] 'agreement among raft nodes before linearized reading' (duration: 155.287288ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:51.529821Z","caller":"traceutil/trace.go:171","msg":"trace[1168292918] transaction","detail":"{read_only:false; response_revision:5449; number_of_response:1; }","duration":"155.175695ms","start":"2026-06-05T06:12:51.374627Z","end":"2026-06-05T06:12:51.529802Z","steps":["trace[1168292918] 'process raft request' (duration: 155.138454ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:12:51.530014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.472876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:12:51.530114Z","caller":"traceutil/trace.go:171","msg":"trace[1540439538] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5449; }","duration":"132.61627ms","start":"2026-06-05T06:12:51.397479Z","end":"2026-06-05T06:12:51.530095Z","steps":["trace[1540439538] 'agreement among raft nodes before linearized reading' (duration: 132.395304ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:51.530512Z","caller":"traceutil/trace.go:171","msg":"trace[962902890] transaction","detail":"{read_only:false; response_revision:5448; number_of_response:1; }","duration":"156.587116ms","start":"2026-06-05T06:12:51.373912Z","end":"2026-06-05T06:12:51.530499Z","steps":["trace[962902890] 'process raft request' (duration: 155.743262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:12:53.475991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.539309ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:12:53.476193Z","caller":"traceutil/trace.go:171","msg":"trace[678164900] transaction","detail":"{read_only:false; response_revision:5480; number_of_response:1; }","duration":"104.624741ms","start":"2026-06-05T06:12:53.371551Z","end":"2026-06-05T06:12:53.476176Z","steps":["trace[678164900] 'process raft request' (duration: 104.551779ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:12:53.476388Z","caller":"traceutil/trace.go:171","msg":"trace[1669862458] transaction","detail":"{read_only:false; response_revision:5479; number_of_response:1; }","duration":"201.128259ms","start":"2026-06-05T06:12:53.275222Z","end":"2026-06-05T06:12:53.47635Z","steps":["trace[1669862458] 'process raft request' (duration: 96.142328ms)","trace[1669862458] 'compare' (duration: 104.323112ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:12:53.476535Z","caller":"traceutil/trace.go:171","msg":"trace[598187061] linearizableReadLoop","detail":"{readStateIndex:5690; appliedIndex:5689; }","duration":"199.421539ms","start":"2026-06-05T06:12:53.277076Z","end":"2026-06-05T06:12:53.476497Z","steps":["trace[598187061] 'read index received' (duration: 94.254623ms)","trace[598187061] 'applied index is now lower than readState.Index' (duration: 105.163066ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:12:53.47671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.633336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-05T06:12:53.476777Z","caller":"traceutil/trace.go:171","msg":"trace[255484722] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:5480; }","duration":"199.728878ms","start":"2026-06-05T06:12:53.277033Z","end":"2026-06-05T06:12:53.476762Z","steps":["trace[255484722] 'agreement among raft nodes before linearized reading' (duration: 199.562154ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:13:45.619474Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2951} {"level":"info","ts":"2026-06-05T06:13:45.695129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2951,"took":"73.653215ms","hash":1405425096,"current-db-size-bytes":58044416,"current-db-size":"58 MB","current-db-size-in-use-bytes":33443840,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-05T06:13:45.695218Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1405425096,"revision":2951,"compact-revision":-1} {"level":"info","ts":"2026-06-05T06:15:38.072706Z","caller":"traceutil/trace.go:171","msg":"trace[1172582799] transaction","detail":"{read_only:false; response_revision:6711; number_of_response:1; }","duration":"224.999171ms","start":"2026-06-05T06:15:37.847666Z","end":"2026-06-05T06:15:38.072665Z","steps":["trace[1172582799] 'process raft request' (duration: 222.080288ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:18:45.6249Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5997} {"level":"info","ts":"2026-06-05T06:18:45.720766Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5997,"took":"92.840297ms","hash":3400279499,"current-db-size-bytes":58044416,"current-db-size":"58 MB","current-db-size-in-use-bytes":21639168,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-06-05T06:18:45.720837Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3400279499,"revision":5997,"compact-revision":2951} {"level":"info","ts":"2026-06-05T06:19:10.190892Z","caller":"traceutil/trace.go:171","msg":"trace[1369624069] transaction","detail":"{read_only:false; response_revision:8381; number_of_response:1; }","duration":"148.778067ms","start":"2026-06-05T06:19:10.042087Z","end":"2026-06-05T06:19:10.190865Z","steps":["trace[1369624069] 'process raft request' (duration: 148.585512ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:19:20.946109Z","caller":"traceutil/trace.go:171","msg":"trace[320566641] transaction","detail":"{read_only:false; response_revision:8434; number_of_response:1; }","duration":"113.58767ms","start":"2026-06-05T06:19:20.832496Z","end":"2026-06-05T06:19:20.946083Z","steps":["trace[320566641] 'process raft request' (duration: 113.446876ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:19:21.488727Z","caller":"traceutil/trace.go:171","msg":"trace[98273317] transaction","detail":"{read_only:false; response_revision:8438; number_of_response:1; }","duration":"101.146264ms","start":"2026-06-05T06:19:21.38754Z","end":"2026-06-05T06:19:21.488686Z","steps":["trace[98273317] 'process raft request' (duration: 100.902187ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:19:49.973398Z","caller":"traceutil/trace.go:171","msg":"trace[1365105549] linearizableReadLoop","detail":"{readStateIndex:8960; appliedIndex:8959; }","duration":"265.482938ms","start":"2026-06-05T06:19:49.707889Z","end":"2026-06-05T06:19:49.973372Z","steps":["trace[1365105549] 'read index received' (duration: 265.250891ms)","trace[1365105549] 'applied index is now lower than readState.Index' (duration: 231.157µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:19:49.973427Z","caller":"traceutil/trace.go:171","msg":"trace[904187942] transaction","detail":"{read_only:false; response_revision:8644; number_of_response:1; }","duration":"281.366331ms","start":"2026-06-05T06:19:49.692034Z","end":"2026-06-05T06:19:49.973401Z","steps":["trace[904187942] 'process raft request' (duration: 281.176776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:19:49.973608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.688683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T06:19:49.97372Z","caller":"traceutil/trace.go:171","msg":"trace[1461456828] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:8644; }","duration":"265.849498ms","start":"2026-06-05T06:19:49.707847Z","end":"2026-06-05T06:19:49.973697Z","steps":["trace[1461456828] 'agreement among raft nodes before linearized reading' (duration: 265.668293ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:19:49.973872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.995812ms","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-06-05T06:19:49.973914Z","caller":"traceutil/trace.go:171","msg":"trace[901481663] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8644; }","duration":"164.072535ms","start":"2026-06-05T06:19:49.80983Z","end":"2026-06-05T06:19:49.973903Z","steps":["trace[901481663] 'agreement among raft nodes before linearized reading' (duration: 163.992552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:19:49.973656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.362851ms","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-06-05T06:19:49.974038Z","caller":"traceutil/trace.go:171","msg":"trace[347824173] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8644; }","duration":"166.799103ms","start":"2026-06-05T06:19:49.807227Z","end":"2026-06-05T06:19:49.974026Z","steps":["trace[347824173] 'agreement among raft nodes before linearized reading' (duration: 166.306609ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:19:50.14567Z","caller":"traceutil/trace.go:171","msg":"trace[1356625879] transaction","detail":"{read_only:false; response_revision:8645; number_of_response:1; }","duration":"168.146273ms","start":"2026-06-05T06:19:49.977498Z","end":"2026-06-05T06:19:50.145644Z","steps":["trace[1356625879] 'process raft request' (duration: 167.848134ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:19:50.157379Z","caller":"traceutil/trace.go:171","msg":"trace[528256855] transaction","detail":"{read_only:false; response_revision:8646; number_of_response:1; }","duration":"179.473176ms","start":"2026-06-05T06:19:49.977886Z","end":"2026-06-05T06:19:50.157359Z","steps":["trace[528256855] 'process raft request' (duration: 178.94479ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:19:50.157388Z","caller":"traceutil/trace.go:171","msg":"trace[195040314] linearizableReadLoop","detail":"{readStateIndex:8963; appliedIndex:8960; }","duration":"126.620874ms","start":"2026-06-05T06:19:50.030732Z","end":"2026-06-05T06:19:50.157353Z","steps":["trace[195040314] 'read index received' (duration: 114.649371ms)","trace[195040314] 'applied index is now lower than readState.Index' (duration: 11.969653ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:19:50.157532Z","caller":"traceutil/trace.go:171","msg":"trace[918463121] transaction","detail":"{read_only:false; response_revision:8647; number_of_response:1; }","duration":"179.432595ms","start":"2026-06-05T06:19:49.978039Z","end":"2026-06-05T06:19:50.157471Z","steps":["trace[918463121] 'process raft request' (duration: 179.225429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:19:50.15776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.000475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x22gv\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-05T06:19:50.157804Z","caller":"traceutil/trace.go:171","msg":"trace[1946265592] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x22gv; range_end:; response_count:1; response_revision:8647; }","duration":"127.108088ms","start":"2026-06-05T06:19:50.030685Z","end":"2026-06-05T06:19:50.157793Z","steps":["trace[1946265592] 'agreement among raft nodes before linearized reading' (duration: 126.8117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:19:54.14898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.374307ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-05T06:19:54.149087Z","caller":"traceutil/trace.go:171","msg":"trace[595385052] linearizableReadLoop","detail":"{readStateIndex:8982; appliedIndex:8981; }","duration":"134.812159ms","start":"2026-06-05T06:19:54.014257Z","end":"2026-06-05T06:19:54.149069Z","steps":["trace[595385052] 'read index received' (duration: 54.061µs)","trace[595385052] 'applied index is now lower than readState.Index' (duration: 134.756248ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:19:54.149256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.987063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-05T06:19:54.149297Z","caller":"traceutil/trace.go:171","msg":"trace[1900224075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8665; }","duration":"135.081327ms","start":"2026-06-05T06:19:54.014202Z","end":"2026-06-05T06:19:54.149283Z","steps":["trace[1900224075] 'agreement among raft nodes before linearized reading' (duration: 134.923072ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:20:03.384645Z","caller":"traceutil/trace.go:171","msg":"trace[794440903] linearizableReadLoop","detail":"{readStateIndex:9081; appliedIndex:9080; }","duration":"135.254801ms","start":"2026-06-05T06:20:03.249367Z","end":"2026-06-05T06:20:03.384621Z","steps":["trace[794440903] 'read index received' (duration: 120.263374ms)","trace[794440903] 'applied index is now lower than readState.Index' (duration: 14.990167ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:20:03.384671Z","caller":"traceutil/trace.go:171","msg":"trace[1202700574] transaction","detail":"{read_only:false; response_revision:8760; number_of_response:1; }","duration":"137.204737ms","start":"2026-06-05T06:20:03.247447Z","end":"2026-06-05T06:20:03.384652Z","steps":["trace[1202700574] 'process raft request' (duration: 122.169198ms)","trace[1202700574] 'compare' (duration: 14.657189ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:20:03.385446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.051655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:20:03.385551Z","caller":"traceutil/trace.go:171","msg":"trace[550657958] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8760; }","duration":"136.200649ms","start":"2026-06-05T06:20:03.249331Z","end":"2026-06-05T06:20:03.385532Z","steps":["trace[550657958] 'agreement among raft nodes before linearized reading' (duration: 135.418046ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:20:03.949015Z","caller":"traceutil/trace.go:171","msg":"trace[819851773] linearizableReadLoop","detail":"{readStateIndex:9084; appliedIndex:9083; }","duration":"128.839959ms","start":"2026-06-05T06:20:03.820131Z","end":"2026-06-05T06:20:03.948971Z","steps":["trace[819851773] 'read index received' (duration: 128.723846ms)","trace[819851773] 'applied index is now lower than readState.Index' (duration: 114.803µs)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:20:03.94904Z","caller":"traceutil/trace.go:171","msg":"trace[1390938284] transaction","detail":"{read_only:false; response_revision:8763; number_of_response:1; }","duration":"187.534734ms","start":"2026-06-05T06:20:03.761472Z","end":"2026-06-05T06:20:03.949007Z","steps":["trace[1390938284] 'process raft request' (duration: 187.266987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:20:03.949178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.012724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:20:03.949222Z","caller":"traceutil/trace.go:171","msg":"trace[385549108] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:8763; }","duration":"129.112737ms","start":"2026-06-05T06:20:03.820095Z","end":"2026-06-05T06:20:03.949208Z","steps":["trace[385549108] 'agreement among raft nodes before linearized reading' (duration: 129.013484ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:20:04.279588Z","caller":"traceutil/trace.go:171","msg":"trace[1613099466] linearizableReadLoop","detail":"{readStateIndex:9085; appliedIndex:9084; }","duration":"171.166307ms","start":"2026-06-05T06:20:04.10839Z","end":"2026-06-05T06:20:04.279556Z","steps":["trace[1613099466] 'read index received' (duration: 78.405759ms)","trace[1613099466] 'applied index is now lower than readState.Index' (duration: 92.758158ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:20:04.279849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.424054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-05T06:20:04.280067Z","caller":"traceutil/trace.go:171","msg":"trace[64194631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:8763; }","duration":"171.6417ms","start":"2026-06-05T06:20:04.108384Z","end":"2026-06-05T06:20:04.280025Z","steps":["trace[64194631] 'agreement among raft nodes before linearized reading' (duration: 171.333562ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:20:04.391245Z","caller":"traceutil/trace.go:171","msg":"trace[655102858] transaction","detail":"{read_only:false; response_revision:8765; number_of_response:1; }","duration":"106.947373ms","start":"2026-06-05T06:20:04.284267Z","end":"2026-06-05T06:20:04.391214Z","steps":["trace[655102858] 'process raft request' (duration: 98.344388ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:20:20.934585Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242a.wal"} {"level":"info","ts":"2026-06-05T06:21:37.011561Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-05T06:21:37.01802Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-05T06:21:37.018106Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-05T06:23:45.63126Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8075} {"level":"info","ts":"2026-06-05T06:23:45.695618Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8075,"took":"61.968694ms","hash":484646980,"current-db-size-bytes":58044416,"current-db-size":"58 MB","current-db-size-in-use-bytes":28278784,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-06-05T06:23:45.695693Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":484646980,"revision":8075,"compact-revision":5997} {"level":"info","ts":"2026-06-05T06:26:14.733451Z","caller":"traceutil/trace.go:171","msg":"trace[952237276] transaction","detail":"{read_only:false; response_revision:11506; number_of_response:1; }","duration":"110.366351ms","start":"2026-06-05T06:26:14.623059Z","end":"2026-06-05T06:26:14.733426Z","steps":["trace[952237276] 'process raft request' (duration: 110.202336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:26:56.427386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.537537ms","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-06-05T06:26:56.427474Z","caller":"traceutil/trace.go:171","msg":"trace[1875837431] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11931; }","duration":"146.678041ms","start":"2026-06-05T06:26:56.280778Z","end":"2026-06-05T06:26:56.427456Z","steps":["trace[1875837431] 'range keys from in-memory index tree' (duration: 146.347481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:26:56.427395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.210109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-05T06:26:56.427721Z","caller":"traceutil/trace.go:171","msg":"trace[1791369327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11931; }","duration":"122.594651ms","start":"2026-06-05T06:26:56.305103Z","end":"2026-06-05T06:26:56.427698Z","steps":["trace[1791369327] 'range keys from in-memory index tree' (duration: 122.026744ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:26:57.02052Z","caller":"traceutil/trace.go:171","msg":"trace[1718399433] transaction","detail":"{read_only:false; response_revision:11936; number_of_response:1; }","duration":"141.060209ms","start":"2026-06-05T06:26:56.879423Z","end":"2026-06-05T06:26:57.020484Z","steps":["trace[1718399433] 'process raft request' (duration: 140.870134ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:26:57.08434Z","caller":"traceutil/trace.go:171","msg":"trace[818959997] transaction","detail":"{read_only:false; response_revision:11938; number_of_response:1; }","duration":"183.400351ms","start":"2026-06-05T06:26:56.900914Z","end":"2026-06-05T06:26:57.084314Z","steps":["trace[818959997] 'process raft request' (duration: 183.316579ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:26:57.084361Z","caller":"traceutil/trace.go:171","msg":"trace[565524886] transaction","detail":"{read_only:false; response_revision:11937; number_of_response:1; }","duration":"203.309593ms","start":"2026-06-05T06:26:56.881015Z","end":"2026-06-05T06:26:57.084325Z","steps":["trace[565524886] 'process raft request' (duration: 203.073576ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:28:45.637911Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10485} {"level":"info","ts":"2026-06-05T06:28:45.721021Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10485,"took":"80.720561ms","hash":2202408031,"current-db-size-bytes":58044416,"current-db-size":"58 MB","current-db-size-in-use-bytes":26050560,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-05T06:28:45.721107Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2202408031,"revision":10485,"compact-revision":8075} {"level":"info","ts":"2026-06-05T06:33:30.699746Z","caller":"traceutil/trace.go:171","msg":"trace[1541792464] linearizableReadLoop","detail":"{readStateIndex:15069; appliedIndex:15068; }","duration":"199.324971ms","start":"2026-06-05T06:33:30.500403Z","end":"2026-06-05T06:33:30.699728Z","steps":["trace[1541792464] 'read index received' (duration: 119.273712ms)","trace[1541792464] 'applied index is now lower than readState.Index' (duration: 80.050649ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:33:30.699811Z","caller":"traceutil/trace.go:171","msg":"trace[1098802374] transaction","detail":"{read_only:false; response_revision:14557; number_of_response:1; }","duration":"215.496443ms","start":"2026-06-05T06:33:30.484287Z","end":"2026-06-05T06:33:30.699783Z","steps":["trace[1098802374] 'process raft request' (duration: 135.355162ms)","trace[1098802374] 'compare' (duration: 79.981007ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:33:30.699892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.479416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:33:30.699963Z","caller":"traceutil/trace.go:171","msg":"trace[1535348463] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:14557; }","duration":"199.605849ms","start":"2026-06-05T06:33:30.500342Z","end":"2026-06-05T06:33:30.699948Z","steps":["trace[1535348463] 'agreement among raft nodes before linearized reading' (duration: 199.486796ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:33:30.700284Z","caller":"traceutil/trace.go:171","msg":"trace[1228011836] transaction","detail":"{read_only:false; response_revision:14558; number_of_response:1; }","duration":"197.20026ms","start":"2026-06-05T06:33:30.503077Z","end":"2026-06-05T06:33:30.700277Z","steps":["trace[1228011836] 'process raft request' (duration: 197.030876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:33:30.700284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.884835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:33:30.700331Z","caller":"traceutil/trace.go:171","msg":"trace[600180956] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:14558; }","duration":"143.974138ms","start":"2026-06-05T06:33:30.556343Z","end":"2026-06-05T06:33:30.700317Z","steps":["trace[600180956] 'agreement among raft nodes before linearized reading' (duration: 143.878935ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:33:45.643942Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12675} {"level":"info","ts":"2026-06-05T06:33:45.925754Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12675,"took":"279.723249ms","hash":3738274011,"current-db-size-bytes":58044416,"current-db-size":"58 MB","current-db-size-in-use-bytes":26730496,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-05T06:33:45.925842Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3738274011,"revision":12675,"compact-revision":10485} {"level":"info","ts":"2026-06-05T06:33:46.974116Z","caller":"traceutil/trace.go:171","msg":"trace[1393386327] transaction","detail":"{read_only:false; response_revision:14656; number_of_response:1; }","duration":"457.105835ms","start":"2026-06-05T06:33:46.516957Z","end":"2026-06-05T06:33:46.974063Z","steps":["trace[1393386327] 'process raft request' (duration: 456.748564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:33:46.97427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:33:46.516928Z","time spent":"457.26716ms","remote":"127.0.0.1:38950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-05T06:33:46.974349Z","caller":"traceutil/trace.go:171","msg":"trace[587189739] transaction","detail":"{read_only:false; response_revision:14657; number_of_response:1; }","duration":"456.827256ms","start":"2026-06-05T06:33:46.517501Z","end":"2026-06-05T06:33:46.974329Z","steps":["trace[587189739] 'process raft request' (duration: 456.407174ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:33:46.974538Z","caller":"traceutil/trace.go:171","msg":"trace[1355166661] transaction","detail":"{read_only:false; response_revision:14659; number_of_response:1; }","duration":"222.185726ms","start":"2026-06-05T06:33:46.752333Z","end":"2026-06-05T06:33:46.974518Z","steps":["trace[1355166661] 'process raft request' (duration: 222.149725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:33:46.974556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:33:46.517486Z","time spent":"456.939469ms","remote":"127.0.0.1:38950","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-05T06:33:46.974629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.453295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-x22gv\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-05T06:33:46.974669Z","caller":"traceutil/trace.go:171","msg":"trace[79829334] transaction","detail":"{read_only:false; response_revision:14658; number_of_response:1; }","duration":"224.937895ms","start":"2026-06-05T06:33:46.749724Z","end":"2026-06-05T06:33:46.974662Z","steps":["trace[79829334] 'process raft request' (duration: 224.685388ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:33:46.974686Z","caller":"traceutil/trace.go:171","msg":"trace[1289508025] range","detail":"{range_begin:/registry/pods/openstack/keepalived-x22gv; range_end:; response_count:1; response_revision:14659; }","duration":"392.557618ms","start":"2026-06-05T06:33:46.582114Z","end":"2026-06-05T06:33:46.974672Z","steps":["trace[1289508025] 'agreement among raft nodes before linearized reading' (duration: 392.379783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:33:46.974724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-05T06:33:46.582086Z","time spent":"392.63015ms","remote":"127.0.0.1:38856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6554,"request content":"key:\"/registry/pods/openstack/keepalived-x22gv\" "} {"level":"info","ts":"2026-06-05T06:33:46.975059Z","caller":"traceutil/trace.go:171","msg":"trace[733077916] linearizableReadLoop","detail":"{readStateIndex:15175; appliedIndex:15173; }","duration":"392.117095ms","start":"2026-06-05T06:33:46.582171Z","end":"2026-06-05T06:33:46.974288Z","steps":["trace[733077916] 'read index received' (duration: 391.485716ms)","trace[733077916] 'applied index is now lower than readState.Index' (duration: 630.579µs)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:34:07.983564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.157767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:34:07.983646Z","caller":"traceutil/trace.go:171","msg":"trace[1924283757] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:14958; }","duration":"106.28329ms","start":"2026-06-05T06:34:07.877344Z","end":"2026-06-05T06:34:07.983627Z","steps":["trace[1924283757] 'count revisions from in-memory index tree' (duration: 106.076414ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:34:08.195569Z","caller":"traceutil/trace.go:171","msg":"trace[1866372916] transaction","detail":"{read_only:false; response_revision:14959; number_of_response:1; }","duration":"136.504155ms","start":"2026-06-05T06:34:08.059017Z","end":"2026-06-05T06:34:08.195521Z","steps":["trace[1866372916] 'process raft request' (duration: 136.30912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:35:34.208993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.296156ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-05T06:35:34.20928Z","caller":"traceutil/trace.go:171","msg":"trace[7931741] linearizableReadLoop","detail":"{readStateIndex:16326; appliedIndex:16325; }","duration":"213.887967ms","start":"2026-06-05T06:35:33.995371Z","end":"2026-06-05T06:35:34.209259Z","steps":["trace[7931741] 'read index received' (duration: 68.152379ms)","trace[7931741] 'applied index is now lower than readState.Index' (duration: 145.734088ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:35:34.209406Z","caller":"traceutil/trace.go:171","msg":"trace[1408380296] transaction","detail":"{read_only:false; response_revision:15771; number_of_response:1; }","duration":"225.712806ms","start":"2026-06-05T06:35:33.983652Z","end":"2026-06-05T06:35:34.209365Z","steps":["trace[1408380296] 'process raft request' (duration: 79.955957ms)","trace[1408380296] 'compare' (duration: 145.180063ms)"],"step_count":2} {"level":"warn","ts":"2026-06-05T06:35:34.209544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.157245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-7x5gj\" ","response":"range_response_count:1 size:22099"} {"level":"info","ts":"2026-06-05T06:35:34.209652Z","caller":"traceutil/trace.go:171","msg":"trace[252038355] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-7x5gj; range_end:; response_count:1; response_revision:15771; }","duration":"214.289309ms","start":"2026-06-05T06:35:33.995337Z","end":"2026-06-05T06:35:34.209626Z","steps":["trace[252038355] 'agreement among raft nodes before linearized reading' (duration: 214.059112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-05T06:35:34.551056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.114648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-05T06:35:34.551131Z","caller":"traceutil/trace.go:171","msg":"trace[581917283] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:15771; }","duration":"154.223871ms","start":"2026-06-05T06:35:34.396888Z","end":"2026-06-05T06:35:34.551112Z","steps":["trace[581917283] 'range keys from in-memory index tree' (duration: 154.054476ms)"],"step_count":1} {"level":"info","ts":"2026-06-05T06:35:34.551374Z","caller":"traceutil/trace.go:171","msg":"trace[507516004] transaction","detail":"{read_only:false; response_revision:15772; number_of_response:1; }","duration":"124.732448ms","start":"2026-06-05T06:35:34.426615Z","end":"2026-06-05T06:35:34.551347Z","steps":["trace[507516004] 'process raft request' (duration: 111.51389ms)","trace[507516004] 'compare' (duration: 12.499547ms)"],"step_count":2} {"level":"info","ts":"2026-06-05T06:38:45.649944Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14650} {"level":"info","ts":"2026-06-05T06:38:45.722541Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14650,"took":"70.268728ms","hash":2108459774,"current-db-size-bytes":58044416,"current-db-size":"58 MB","current-db-size-in-use-bytes":33832960,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-05T06:38:45.722619Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2108459774,"revision":14650,"compact-revision":12675} {"level":"info","ts":"2026-06-05T06:43:45.656757Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17318} {"level":"info","ts":"2026-06-05T06:43:45.747047Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17318,"took":"87.770414ms","hash":3904107270,"current-db-size-bytes":58044416,"current-db-size":"58 MB","current-db-size-in-use-bytes":30298112,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-05T06:43:45.747102Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3904107270,"revision":17318,"compact-revision":14650} {"level":"info","ts":"2026-06-05T06:44:29.267005Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"39582465ceaa2f67","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-05T06:44:29.273839Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-05T06:44:29.274077Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-05T06:48:45.664314Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19092} {"level":"info","ts":"2026-06-05T06:48:45.754088Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19092,"took":"86.475218ms","hash":3341548121,"current-db-size-bytes":58044416,"current-db-size":"58 MB","current-db-size-in-use-bytes":23674880,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-05T06:48:45.754166Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3341548121,"revision":19092,"compact-revision":17318}