{"level":"warn","ts":"2026-04-13T02:46:12.012694Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T02:46:12.012787Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.110:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.110:2380","--initial-cluster=instance=https://162.253.55.110:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.110:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.110: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-04-13T02:46:12.012945Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-13T02:46:12.012961Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-04-13T02:46:12.012983Z","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-04-13T02:46:12.01375Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"]} {"level":"info","ts":"2026-04-13T02:46:12.013837Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.110: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-04-13T02:46:12.019311Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.223107ms"} {"level":"info","ts":"2026-04-13T02:46:12.028696Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f52f30d5714009d5","cluster-id":"650981a7a383c714"} {"level":"info","ts":"2026-04-13T02:46:12.029127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=()"} {"level":"info","ts":"2026-04-13T02:46:12.02918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 0"} {"level":"info","ts":"2026-04-13T02:46:12.029206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f52f30d5714009d5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-13T02:46:12.029233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became follower at term 1"} {"level":"info","ts":"2026-04-13T02:46:12.029311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"warn","ts":"2026-04-13T02:46:12.035398Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-13T02:46:12.038948Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-13T02:46:12.041911Z","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-04-13T02:46:12.046635Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f52f30d5714009d5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-13T02:46:12.046969Z","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-04-13T02:46:12.047046Z","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-04-13T02:46:12.047134Z","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-04-13T02:46:12.047054Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f52f30d5714009d5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-13T02:46:12.047633Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 switched to configuration voters=(17667393556483934677)"} {"level":"info","ts":"2026-04-13T02:46:12.047752Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","added-peer-id":"f52f30d5714009d5","added-peer-peer-urls":["https://162.253.55.110:2380"]} {"level":"info","ts":"2026-04-13T02:46:12.050289Z","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-04-13T02:46:12.050439Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-04-13T02:46:12.050484Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.110:2380"} {"level":"info","ts":"2026-04-13T02:46:12.0507Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f52f30d5714009d5","initial-advertise-peer-urls":["https://162.253.55.110:2380"],"listen-peer-urls":["https://162.253.55.110:2380"],"advertise-client-urls":["https://162.253.55.110:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.110:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-13T02:46:12.050767Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-13T02:46:12.230289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 is starting a new election at term 1"} {"level":"info","ts":"2026-04-13T02:46:12.230348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-13T02:46:12.230392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgPreVoteResp from f52f30d5714009d5 at term 1"} {"level":"info","ts":"2026-04-13T02:46:12.230412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became candidate at term 2"} {"level":"info","ts":"2026-04-13T02:46:12.230423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 received MsgVoteResp from f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-04-13T02:46:12.230439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f52f30d5714009d5 became leader at term 2"} {"level":"info","ts":"2026-04-13T02:46:12.230453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f52f30d5714009d5 elected leader f52f30d5714009d5 at term 2"} {"level":"info","ts":"2026-04-13T02:46:12.232328Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f52f30d5714009d5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.110:2379]}","request-path":"/0/members/f52f30d5714009d5/attributes","cluster-id":"650981a7a383c714","publish-timeout":"7s"} {"level":"info","ts":"2026-04-13T02:46:12.232563Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T02:46:12.232864Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T02:46:12.233135Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-13T02:46:12.233171Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-13T02:46:12.233065Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-13T02:46:12.234293Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"650981a7a383c714","local-member-id":"f52f30d5714009d5","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T02:46:12.234541Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T02:46:12.234584Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-13T02:46:12.237588Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-13T02:46:12.242265Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.110:2379"} {"level":"info","ts":"2026-04-13T02:46:46.011253Z","caller":"traceutil/trace.go:171","msg":"trace[1827848392] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"179.736219ms","start":"2026-04-13T02:46:45.83148Z","end":"2026-04-13T02:46:46.011216Z","steps":["trace[1827848392] 'process raft request' (duration: 179.428085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:46:46.43368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.623182ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-13T02:46:46.433932Z","caller":"traceutil/trace.go:171","msg":"trace[1362109337] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:589; }","duration":"318.003263ms","start":"2026-04-13T02:46:46.115908Z","end":"2026-04-13T02:46:46.433912Z","steps":["trace[1362109337] 'read index received' (duration: 166.48189ms)","trace[1362109337] 'applied index is now lower than readState.Index' (duration: 151.518853ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T02:46:46.43411Z","caller":"traceutil/trace.go:171","msg":"trace[1460351493] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"407.084162ms","start":"2026-04-13T02:46:46.026997Z","end":"2026-04-13T02:46:46.434081Z","steps":["trace[1460351493] 'process raft request' (duration: 255.379327ms)","trace[1460351493] 'compare' (duration: 150.375579ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T02:46:46.434153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.233076ms","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-04-13T02:46:46.434162Z","caller":"traceutil/trace.go:171","msg":"trace[822532534] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"407.011581ms","start":"2026-04-13T02:46:46.027132Z","end":"2026-04-13T02:46:46.434143Z","steps":["trace[822532534] 'process raft request' (duration: 406.683957ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:46:46.434199Z","caller":"traceutil/trace.go:171","msg":"trace[596094339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:571; }","duration":"318.313016ms","start":"2026-04-13T02:46:46.115872Z","end":"2026-04-13T02:46:46.434185Z","steps":["trace[596094339] 'agreement among raft nodes before linearized reading' (duration: 318.110684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:46:46.43425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:46:46.115859Z","time spent":"318.378547ms","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-13T02:46:46.434251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:46:46.027115Z","time spent":"407.089552ms","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T02:46:46.434253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:46:46.026979Z","time spent":"407.200493ms","remote":"127.0.0.1:50502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T02:46:46.900402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.713091ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-13T02:46:46.900497Z","caller":"traceutil/trace.go:171","msg":"trace[1095008611] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"106.325685ms","start":"2026-04-13T02:46:46.794156Z","end":"2026-04-13T02:46:46.900481Z","steps":["trace[1095008611] 'read index received' (duration: 33.35µs)","trace[1095008611] 'applied index is now lower than readState.Index' (duration: 106.291265ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T02:46:46.900601Z","caller":"traceutil/trace.go:171","msg":"trace[1824489463] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"397.061667ms","start":"2026-04-13T02:46:46.50351Z","end":"2026-04-13T02:46:46.900571Z","steps":["trace[1824489463] 'process raft request' (duration: 243.115474ms)","trace[1824489463] 'compare' (duration: 153.575269ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T02:46:46.900678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.527588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-13T02:46:46.900705Z","caller":"traceutil/trace.go:171","msg":"trace[1699080770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:574; }","duration":"106.598489ms","start":"2026-04-13T02:46:46.794099Z","end":"2026-04-13T02:46:46.900697Z","steps":["trace[1699080770] 'agreement among raft nodes before linearized reading' (duration: 106.427216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:46:46.900721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:46:46.503485Z","time spent":"397.190318ms","remote":"127.0.0.1:50562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-13T02:46:48.12779Z","caller":"traceutil/trace.go:171","msg":"trace[1809183833] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"105.39498ms","start":"2026-04-13T02:46:48.022373Z","end":"2026-04-13T02:46:48.127768Z","steps":["trace[1809183833] 'read index received' (duration: 4.990632ms)","trace[1809183833] 'applied index is now lower than readState.Index' (duration: 100.403438ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T02:46:48.127925Z","caller":"traceutil/trace.go:171","msg":"trace[1734227293] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"111.074651ms","start":"2026-04-13T02:46:48.01682Z","end":"2026-04-13T02:46:48.127895Z","steps":["trace[1734227293] 'process raft request' (duration: 110.829188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:46:48.128006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.596583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T02:46:48.128087Z","caller":"traceutil/trace.go:171","msg":"trace[1485080548] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"105.718844ms","start":"2026-04-13T02:46:48.022349Z","end":"2026-04-13T02:46:48.128067Z","steps":["trace[1485080548] 'agreement among raft nodes before linearized reading' (duration: 105.561402ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:47:02.622081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.25647ms","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-04-13T02:47:02.622172Z","caller":"traceutil/trace.go:171","msg":"trace[486214305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:736; }","duration":"126.419333ms","start":"2026-04-13T02:47:02.495734Z","end":"2026-04-13T02:47:02.622154Z","steps":["trace[486214305] 'range keys from in-memory index tree' (duration: 126.019967ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:47:34.411051Z","caller":"traceutil/trace.go:171","msg":"trace[2084771301] linearizableReadLoop","detail":"{readStateIndex:1175; appliedIndex:1174; }","duration":"210.399881ms","start":"2026-04-13T02:47:34.200625Z","end":"2026-04-13T02:47:34.411025Z","steps":["trace[2084771301] 'read index received' (duration: 210.334529ms)","trace[2084771301] 'applied index is now lower than readState.Index' (duration: 63.512µs)"],"step_count":2} {"level":"warn","ts":"2026-04-13T02:47:34.41127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.627379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-13T02:47:34.411348Z","caller":"traceutil/trace.go:171","msg":"trace[690771555] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1144; }","duration":"210.756703ms","start":"2026-04-13T02:47:34.200572Z","end":"2026-04-13T02:47:34.411328Z","steps":["trace[690771555] 'agreement among raft nodes before linearized reading' (duration: 210.569747ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:47:34.411277Z","caller":"traceutil/trace.go:171","msg":"trace[2007638161] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"232.873092ms","start":"2026-04-13T02:47:34.178383Z","end":"2026-04-13T02:47:34.411256Z","steps":["trace[2007638161] 'process raft request' (duration: 232.490689ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:48:20.159852Z","caller":"traceutil/trace.go:171","msg":"trace[1690880253] linearizableReadLoop","detail":"{readStateIndex:1880; appliedIndex:1879; }","duration":"207.566712ms","start":"2026-04-13T02:48:19.952259Z","end":"2026-04-13T02:48:20.159826Z","steps":["trace[1690880253] 'read index received' (duration: 207.438619ms)","trace[1690880253] 'applied index is now lower than readState.Index' (duration: 126.863µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T02:48:20.159917Z","caller":"traceutil/trace.go:171","msg":"trace[2116463773] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"257.535915ms","start":"2026-04-13T02:48:19.902346Z","end":"2026-04-13T02:48:20.159882Z","steps":["trace[2116463773] 'process raft request' (duration: 257.32989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:48:20.160288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.985212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ad740679-8aab-45c2-8015-707508e9e77e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-13T02:48:20.160408Z","caller":"traceutil/trace.go:171","msg":"trace[713227675] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ad740679-8aab-45c2-8015-707508e9e77e; range_end:; response_count:1; response_revision:1814; }","duration":"208.136866ms","start":"2026-04-13T02:48:19.952243Z","end":"2026-04-13T02:48:20.16038Z","steps":["trace[713227675] 'agreement among raft nodes before linearized reading' (duration: 207.697854ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:48:20.56555Z","caller":"traceutil/trace.go:171","msg":"trace[1133036827] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"153.37388ms","start":"2026-04-13T02:48:20.412151Z","end":"2026-04-13T02:48:20.565525Z","steps":["trace[1133036827] 'process raft request' (duration: 153.136425ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:49:00.520912Z","caller":"traceutil/trace.go:171","msg":"trace[1385915741] transaction","detail":"{read_only:false; response_revision:2085; number_of_response:1; }","duration":"108.941129ms","start":"2026-04-13T02:49:00.411936Z","end":"2026-04-13T02:49:00.520877Z","steps":["trace[1385915741] 'process raft request' (duration: 108.666253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:49:00.940727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.247838ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-13T02:49:00.944771Z","caller":"traceutil/trace.go:171","msg":"trace[706503662] linearizableReadLoop","detail":"{readStateIndex:2162; appliedIndex:2161; }","duration":"110.236082ms","start":"2026-04-13T02:49:00.834511Z","end":"2026-04-13T02:49:00.944747Z","steps":["trace[706503662] 'read index received' (duration: 109.968207ms)","trace[706503662] 'applied index is now lower than readState.Index' (duration: 266.745µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T02:49:00.944848Z","caller":"traceutil/trace.go:171","msg":"trace[602002194] transaction","detail":"{read_only:false; response_revision:2086; number_of_response:1; }","duration":"194.160347ms","start":"2026-04-13T02:49:00.750642Z","end":"2026-04-13T02:49:00.944802Z","steps":["trace[602002194] 'process raft request' (duration: 193.926573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:49:00.945111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.567288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-13T02:49:00.94522Z","caller":"traceutil/trace.go:171","msg":"trace[946202199] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2086; }","duration":"110.721931ms","start":"2026-04-13T02:49:00.834475Z","end":"2026-04-13T02:49:00.945197Z","steps":["trace[946202199] 'agreement among raft nodes before linearized reading' (duration: 110.391425ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:49:52.084171Z","caller":"traceutil/trace.go:171","msg":"trace[537742207] transaction","detail":"{read_only:false; response_revision:2471; number_of_response:1; }","duration":"168.942796ms","start":"2026-04-13T02:49:51.915211Z","end":"2026-04-13T02:49:52.084154Z","steps":["trace[537742207] 'process raft request' (duration: 168.785952ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:50:23.592681Z","caller":"traceutil/trace.go:171","msg":"trace[1686625723] linearizableReadLoop","detail":"{readStateIndex:2739; appliedIndex:2738; }","duration":"183.560648ms","start":"2026-04-13T02:50:23.409091Z","end":"2026-04-13T02:50:23.592651Z","steps":["trace[1686625723] 'read index received' (duration: 96.397414ms)","trace[1686625723] 'applied index is now lower than readState.Index' (duration: 87.157104ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T02:50:23.592989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.882423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T02:50:23.593106Z","caller":"traceutil/trace.go:171","msg":"trace[821811855] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2645; }","duration":"184.042976ms","start":"2026-04-13T02:50:23.409048Z","end":"2026-04-13T02:50:23.593091Z","steps":["trace[821811855] 'agreement among raft nodes before linearized reading' (duration: 183.835823ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:50:23.593511Z","caller":"traceutil/trace.go:171","msg":"trace[857746222] transaction","detail":"{read_only:false; response_revision:2645; number_of_response:1; }","duration":"218.806695ms","start":"2026-04-13T02:50:23.374668Z","end":"2026-04-13T02:50:23.593474Z","steps":["trace[857746222] 'process raft request' (duration: 130.865289ms)","trace[857746222] 'compare' (duration: 86.990532ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T02:54:14.570712Z","caller":"traceutil/trace.go:171","msg":"trace[1037228905] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"311.680239ms","start":"2026-04-13T02:54:14.259002Z","end":"2026-04-13T02:54:14.570682Z","steps":["trace[1037228905] 'process raft request' (duration: 274.696905ms)","trace[1037228905] 'compare' (duration: 36.758188ms)"],"step_count":2} {"level":"warn","ts":"2026-04-13T02:54:14.571184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:54:14.258979Z","time spent":"311.806022ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1283,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T02:54:14.574408Z","caller":"traceutil/trace.go:171","msg":"trace[352907738] transaction","detail":"{read_only:false; response_revision:4635; number_of_response:1; }","duration":"314.704043ms","start":"2026-04-13T02:54:14.259668Z","end":"2026-04-13T02:54:14.574372Z","steps":["trace[352907738] 'process raft request' (duration: 314.449047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:54:14.574529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:54:14.259655Z","time spent":"314.813777ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T02:54:14.574642Z","caller":"traceutil/trace.go:171","msg":"trace[1319236321] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"307.199145ms","start":"2026-04-13T02:54:14.267423Z","end":"2026-04-13T02:54:14.574622Z","steps":["trace[1319236321] 'process raft request' (duration: 306.951778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:54:14.574774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:54:14.267409Z","time spent":"307.297289ms","remote":"127.0.0.1:50502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11833,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T02:54:14.574762Z","caller":"traceutil/trace.go:171","msg":"trace[356339745] transaction","detail":"{read_only:false; response_revision:4636; number_of_response:1; }","duration":"314.90367ms","start":"2026-04-13T02:54:14.259777Z","end":"2026-04-13T02:54:14.57468Z","steps":["trace[356339745] 'process raft request' (duration: 314.459047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:54:14.574919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:54:14.25977Z","time spent":"315.070744ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1455,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T02:54:14.575057Z","caller":"traceutil/trace.go:171","msg":"trace[978885290] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"136.100853ms","start":"2026-04-13T02:54:14.438943Z","end":"2026-04-13T02:54:14.575044Z","steps":["trace[978885290] 'process raft request' (duration: 135.959389ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:54:14.575059Z","caller":"traceutil/trace.go:171","msg":"trace[794347036] linearizableReadLoop","detail":"{readStateIndex:4810; appliedIndex:4804; }","duration":"210.918508ms","start":"2026-04-13T02:54:14.364117Z","end":"2026-04-13T02:54:14.575036Z","steps":["trace[794347036] 'read index received' (duration: 169.657184ms)","trace[794347036] 'applied index is now lower than readState.Index' (duration: 41.260364ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T02:54:14.57505Z","caller":"traceutil/trace.go:171","msg":"trace[827653288] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"281.235527ms","start":"2026-04-13T02:54:14.293799Z","end":"2026-04-13T02:54:14.575034Z","steps":["trace[827653288] 'process raft request' (duration: 280.779134ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:54:14.575202Z","caller":"traceutil/trace.go:171","msg":"trace[1408999354] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"127.136565ms","start":"2026-04-13T02:54:14.448054Z","end":"2026-04-13T02:54:14.575191Z","steps":["trace[1408999354] 'process raft request' (duration: 126.934509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:54:14.575372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.238226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-13T02:54:14.575425Z","caller":"traceutil/trace.go:171","msg":"trace[1123517197] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4641; }","duration":"211.347889ms","start":"2026-04-13T02:54:14.364065Z","end":"2026-04-13T02:54:14.575413Z","steps":["trace[1123517197] 'agreement among raft nodes before linearized reading' (duration: 211.255767ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:54:14.574442Z","caller":"traceutil/trace.go:171","msg":"trace[1804204749] transaction","detail":"{read_only:false; response_revision:4637; number_of_response:1; }","duration":"314.161228ms","start":"2026-04-13T02:54:14.260257Z","end":"2026-04-13T02:54:14.574418Z","steps":["trace[1804204749] 'process raft request' (duration: 314.031624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:54:14.575848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T02:54:14.260241Z","time spent":"315.532057ms","remote":"127.0.0.1:50606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1869,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T02:54:28.284707Z","caller":"traceutil/trace.go:171","msg":"trace[1451838665] linearizableReadLoop","detail":"{readStateIndex:5011; appliedIndex:5010; }","duration":"119.964275ms","start":"2026-04-13T02:54:28.164714Z","end":"2026-04-13T02:54:28.284679Z","steps":["trace[1451838665] 'read index received' (duration: 119.607165ms)","trace[1451838665] 'applied index is now lower than readState.Index' (duration: 356.17µs)"],"step_count":2} {"level":"info","ts":"2026-04-13T02:54:28.284923Z","caller":"traceutil/trace.go:171","msg":"trace[1744093792] transaction","detail":"{read_only:false; response_revision:4834; number_of_response:1; }","duration":"190.166532ms","start":"2026-04-13T02:54:28.094694Z","end":"2026-04-13T02:54:28.284861Z","steps":["trace[1744093792] 'process raft request' (duration: 189.807113ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T02:54:28.285298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.550282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-04-13T02:54:28.285394Z","caller":"traceutil/trace.go:171","msg":"trace[1419861365] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4834; }","duration":"120.709116ms","start":"2026-04-13T02:54:28.16466Z","end":"2026-04-13T02:54:28.285369Z","steps":["trace[1419861365] 'agreement among raft nodes before linearized reading' (duration: 120.390627ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T02:56:12.514689Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2903} {"level":"info","ts":"2026-04-13T02:56:12.61709Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2903,"took":"100.649378ms","hash":32957752,"current-db-size-bytes":54013952,"current-db-size":"54 MB","current-db-size-in-use-bytes":29532160,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-13T02:56:12.617173Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":32957752,"revision":2903,"compact-revision":-1} {"level":"warn","ts":"2026-04-13T03:01:09.789388Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.150009761s","expected-duration":"1s"} {"level":"info","ts":"2026-04-13T03:01:09.789671Z","caller":"traceutil/trace.go:171","msg":"trace[1447632341] transaction","detail":"{read_only:false; response_revision:7409; number_of_response:1; }","duration":"1.150383533s","start":"2026-04-13T03:01:08.63927Z","end":"2026-04-13T03:01:09.789654Z","steps":["trace[1447632341] 'process raft request' (duration: 1.150266109s)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:09.789774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:08.639251Z","time spent":"1.150442985s","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-13T03:01:12.322388Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":708645709787268263,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-13T03:01:12.349255Z","caller":"traceutil/trace.go:171","msg":"trace[1888164908] transaction","detail":"{read_only:false; response_revision:7420; number_of_response:1; }","duration":"529.793653ms","start":"2026-04-13T03:01:11.81942Z","end":"2026-04-13T03:01:12.349213Z","steps":["trace[1888164908] 'process raft request' (duration: 529.515144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.349458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:11.819396Z","time spent":"529.945839ms","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T03:01:12.350192Z","caller":"traceutil/trace.go:171","msg":"trace[488655719] linearizableReadLoop","detail":"{readStateIndex:7693; appliedIndex:7688; }","duration":"528.100016ms","start":"2026-04-13T03:01:11.822016Z","end":"2026-04-13T03:01:12.350116Z","steps":["trace[488655719] 'read index received' (duration: 526.950576ms)","trace[488655719] 'applied index is now lower than readState.Index' (duration: 1.148249ms)"],"step_count":2} {"level":"info","ts":"2026-04-13T03:01:12.350292Z","caller":"traceutil/trace.go:171","msg":"trace[1669602007] transaction","detail":"{read_only:false; response_revision:7422; number_of_response:1; }","duration":"348.605899ms","start":"2026-04-13T03:01:12.001669Z","end":"2026-04-13T03:01:12.350275Z","steps":["trace[1669602007] 'process raft request' (duration: 348.35148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.350403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:12.001642Z","time spent":"348.710653ms","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-13T03:01:12.350316Z","caller":"traceutil/trace.go:171","msg":"trace[1320922120] transaction","detail":"{read_only:false; response_revision:7423; number_of_response:1; }","duration":"155.477655ms","start":"2026-04-13T03:01:12.194827Z","end":"2026-04-13T03:01:12.350305Z","steps":["trace[1320922120] 'process raft request' (duration: 155.228817ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T03:01:12.350668Z","caller":"traceutil/trace.go:171","msg":"trace[2056836390] transaction","detail":"{read_only:false; response_revision:7421; number_of_response:1; }","duration":"529.496903ms","start":"2026-04-13T03:01:11.821162Z","end":"2026-04-13T03:01:12.350659Z","steps":["trace[2056836390] 'process raft request' (duration: 528.697536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.350718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:11.821128Z","time spent":"529.566795ms","remote":"127.0.0.1:50598","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-04-13T03:01:12.350709Z","caller":"traceutil/trace.go:171","msg":"trace[1738752084] transaction","detail":"{read_only:false; response_revision:7424; number_of_response:1; }","duration":"155.201204ms","start":"2026-04-13T03:01:12.1955Z","end":"2026-04-13T03:01:12.350702Z","steps":["trace[1738752084] 'process raft request' (duration: 154.579793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.350883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.773899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1095"} {"level":"info","ts":"2026-04-13T03:01:12.350911Z","caller":"traceutil/trace.go:171","msg":"trace[1774863770] range","detail":"{range_begin:/registry/services/endpoints/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:7424; }","duration":"512.843801ms","start":"2026-04-13T03:01:11.83806Z","end":"2026-04-13T03:01:12.350904Z","steps":["trace[1774863770] 'agreement among raft nodes before linearized reading' (duration: 512.730757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.350933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:11.838036Z","time spent":"512.892763ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1118,"request content":"key:\"/registry/services/endpoints/auth-system/keycloak-headless\" "} {"level":"warn","ts":"2026-04-13T03:01:12.351088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.023514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1007"} {"level":"info","ts":"2026-04-13T03:01:12.351112Z","caller":"traceutil/trace.go:171","msg":"trace[593584216] range","detail":"{range_begin:/registry/services/endpoints/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:7424; }","duration":"475.061975ms","start":"2026-04-13T03:01:11.876044Z","end":"2026-04-13T03:01:12.351107Z","steps":["trace[593584216] 'agreement among raft nodes before linearized reading' (duration: 474.988463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.351109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.831361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/auth-system/\" range_end:\"/registry/secrets/auth-system0\" limit:500 ","response":"range_response_count:4 size:81045"} {"level":"warn","ts":"2026-04-13T03:01:12.351133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:11.875967Z","time spent":"475.159438ms","remote":"127.0.0.1:50480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1030,"request content":"key:\"/registry/services/endpoints/auth-system/keycloak-metrics\" "} {"level":"info","ts":"2026-04-13T03:01:12.351143Z","caller":"traceutil/trace.go:171","msg":"trace[1016399838] range","detail":"{range_begin:/registry/secrets/auth-system/; range_end:/registry/secrets/auth-system0; response_count:4; response_revision:7424; }","duration":"426.909724ms","start":"2026-04-13T03:01:11.924223Z","end":"2026-04-13T03:01:12.351133Z","steps":["trace[1016399838] 'agreement among raft nodes before linearized reading' (duration: 426.750249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.351177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:11.9242Z","time spent":"426.969286ms","remote":"127.0.0.1:50402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":4,"response size":81068,"request content":"key:\"/registry/secrets/auth-system/\" range_end:\"/registry/secrets/auth-system0\" limit:500 "} {"level":"warn","ts":"2026-04-13T03:01:12.351245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.304011ms","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-04-13T03:01:12.351269Z","caller":"traceutil/trace.go:171","msg":"trace[66669920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7424; }","duration":"479.342962ms","start":"2026-04-13T03:01:11.87192Z","end":"2026-04-13T03:01:12.351263Z","steps":["trace[66669920] 'agreement among raft nodes before linearized reading' (duration: 479.2821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.351286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:11.871908Z","time spent":"479.374313ms","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-13T03:01:12.351372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.353058ms","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":"warn","ts":"2026-04-13T03:01:12.351387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.31363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/cert-manager/\" range_end:\"/registry/roles/cert-manager0\" limit:500 ","response":"range_response_count:3 size:3402"} {"level":"info","ts":"2026-04-13T03:01:12.3514Z","caller":"traceutil/trace.go:171","msg":"trace[1139679883] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7424; }","duration":"529.40463ms","start":"2026-04-13T03:01:11.821988Z","end":"2026-04-13T03:01:12.351393Z","steps":["trace[1139679883] 'agreement among raft nodes before linearized reading' (duration: 529.335807ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T03:01:12.351403Z","caller":"traceutil/trace.go:171","msg":"trace[81901140] range","detail":"{range_begin:/registry/roles/cert-manager/; range_end:/registry/roles/cert-manager0; response_count:3; response_revision:7424; }","duration":"509.379643ms","start":"2026-04-13T03:01:11.842018Z","end":"2026-04-13T03:01:12.351398Z","steps":["trace[81901140] 'agreement among raft nodes before linearized reading' (duration: 509.312081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.35142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:11.82198Z","time spent":"529.43474ms","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-13T03:01:12.351421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:11.841995Z","time spent":"509.421265ms","remote":"127.0.0.1:50650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":3,"response size":3425,"request content":"key:\"/registry/roles/cert-manager/\" range_end:\"/registry/roles/cert-manager0\" limit:500 "} {"level":"warn","ts":"2026-04-13T03:01:12.351487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.296593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T03:01:12.351548Z","caller":"traceutil/trace.go:171","msg":"trace[399497793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7424; }","duration":"326.464149ms","start":"2026-04-13T03:01:12.025062Z","end":"2026-04-13T03:01:12.351526Z","steps":["trace[399497793] 'agreement among raft nodes before linearized reading' (duration: 326.289463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-13T03:01:12.351624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-13T03:01:12.025048Z","time spent":"326.564942ms","remote":"127.0.0.1:50324","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-04-13T03:01:12.351646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.117066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-13T03:01:12.351851Z","caller":"traceutil/trace.go:171","msg":"trace[107661584] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:7424; }","duration":"135.408027ms","start":"2026-04-13T03:01:12.216383Z","end":"2026-04-13T03:01:12.351791Z","steps":["trace[107661584] 'agreement among raft nodes before linearized reading' (duration: 135.069206ms)"],"step_count":1} {"level":"info","ts":"2026-04-13T03:01:12.52158Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5622} {"level":"info","ts":"2026-04-13T03:01:12.608386Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5622,"took":"85.155395ms","hash":3088024570,"current-db-size-bytes":54013952,"current-db-size":"54 MB","current-db-size-in-use-bytes":18321408,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-13T03:01:12.608459Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3088024570,"revision":5622,"compact-revision":2903}