{"level":"warn","ts":"2026-04-07T05:47:06.43177Z","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-07T05:47:06.431888Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244: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-07T05:47:06.431996Z","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-07T05:47:06.432029Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-04-07T05:47:06.432059Z","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-07T05:47:06.432659Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]} {"level":"info","ts":"2026-04-07T05:47:06.432756Z","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://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244: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-07T05:47:06.437053Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.95903ms"} {"level":"info","ts":"2026-04-07T05:47:06.444156Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"} {"level":"info","ts":"2026-04-07T05:47:06.44426Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T05:47:06.444316Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"} {"level":"info","ts":"2026-04-07T05:47:06.444355Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T05:47:06.444381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"} {"level":"info","ts":"2026-04-07T05:47:06.444445Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"warn","ts":"2026-04-07T05:47:06.452063Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T05:47:06.453761Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T05:47:06.455047Z","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-07T05:47:06.458044Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T05:47:06.458208Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T05:47:06.458247Z","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-07T05:47:06.458323Z","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-07T05:47:06.45834Z","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-07T05:47:06.460134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"info","ts":"2026-04-07T05:47:06.460348Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-04-07T05:47:06.462323Z","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-07T05:47:06.462391Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-04-07T05:47:06.462423Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-04-07T05:47:06.462651Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T05:47:06.462726Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T05:47:07.345584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T05:47:07.345659Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T05:47:07.345682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"} {"level":"info","ts":"2026-04-07T05:47:07.345703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"} {"level":"info","ts":"2026-04-07T05:47:07.345714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-04-07T05:47:07.345744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"} {"level":"info","ts":"2026-04-07T05:47:07.345763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-04-07T05:47:07.351796Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:47:07.358186Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T05:47:07.35823Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:47:07.358328Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:47:07.358623Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T05:47:07.358707Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T05:47:07.361558Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"} {"level":"info","ts":"2026-04-07T05:47:07.362263Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:47:07.362369Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:47:07.362406Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:47:07.3626Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T05:47:34.798316Z","caller":"traceutil/trace.go:171","msg":"trace[1140671888] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"216.727209ms","start":"2026-04-07T05:47:34.581564Z","end":"2026-04-07T05:47:34.798291Z","steps":["trace[1140671888] 'process raft request' (duration: 216.508473ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.805055Z","caller":"traceutil/trace.go:171","msg":"trace[1389053873] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"192.794922ms","start":"2026-04-07T05:47:34.61224Z","end":"2026-04-07T05:47:34.805035Z","steps":["trace[1389053873] 'process raft request' (duration: 192.69316ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.805048Z","caller":"traceutil/trace.go:171","msg":"trace[725392097] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"213.917401ms","start":"2026-04-07T05:47:34.591095Z","end":"2026-04-07T05:47:34.805013Z","steps":["trace[725392097] 'process raft request' (duration: 213.806119ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.805173Z","caller":"traceutil/trace.go:171","msg":"trace[960447002] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"218.567854ms","start":"2026-04-07T05:47:34.586595Z","end":"2026-04-07T05:47:34.805162Z","steps":["trace[960447002] 'process raft request' (duration: 218.201887ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.805209Z","caller":"traceutil/trace.go:171","msg":"trace[2049129357] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"184.010878ms","start":"2026-04-07T05:47:34.621188Z","end":"2026-04-07T05:47:34.805199Z","steps":["trace[2049129357] 'process raft request' (duration: 183.844754ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.805265Z","caller":"traceutil/trace.go:171","msg":"trace[1888840519] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"189.509357ms","start":"2026-04-07T05:47:34.615745Z","end":"2026-04-07T05:47:34.805254Z","steps":["trace[1888840519] 'process raft request' (duration: 189.228031ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.80534Z","caller":"traceutil/trace.go:171","msg":"trace[2037310566] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"176.521558ms","start":"2026-04-07T05:47:34.62881Z","end":"2026-04-07T05:47:34.805332Z","steps":["trace[2037310566] 'process raft request' (duration: 176.284403ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.805406Z","caller":"traceutil/trace.go:171","msg":"trace[1234577700] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"184.242703ms","start":"2026-04-07T05:47:34.621152Z","end":"2026-04-07T05:47:34.805395Z","steps":["trace[1234577700] 'process raft request' (duration: 183.852024ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.805392Z","caller":"traceutil/trace.go:171","msg":"trace[1489452964] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"180.272333ms","start":"2026-04-07T05:47:34.62506Z","end":"2026-04-07T05:47:34.805332Z","steps":["trace[1489452964] 'process raft request' (duration: 179.999757ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.805503Z","caller":"traceutil/trace.go:171","msg":"trace[1926429405] linearizableReadLoop","detail":"{readStateIndex:484; appliedIndex:474; }","duration":"156.737635ms","start":"2026-04-07T05:47:34.648739Z","end":"2026-04-07T05:47:34.805477Z","steps":["trace[1926429405] 'read index received' (duration: 149.419379ms)","trace[1926429405] 'applied index is now lower than readState.Index' (duration: 7.317466ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:47:34.805534Z","caller":"traceutil/trace.go:171","msg":"trace[521921074] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"155.010471ms","start":"2026-04-07T05:47:34.650514Z","end":"2026-04-07T05:47:34.805525Z","steps":["trace[521921074] 'process raft request' (duration: 154.664843ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:34.80561Z","caller":"traceutil/trace.go:171","msg":"trace[2056824945] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"173.178833ms","start":"2026-04-07T05:47:34.632422Z","end":"2026-04-07T05:47:34.805601Z","steps":["trace[2056824945] 'process raft request' (duration: 172.710603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:34.805759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.00068ms","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-07T05:47:34.805843Z","caller":"traceutil/trace.go:171","msg":"trace[174819475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:474; }","duration":"157.120403ms","start":"2026-04-07T05:47:34.648707Z","end":"2026-04-07T05:47:34.805828Z","steps":["trace[174819475] 'agreement among raft nodes before linearized reading' (duration: 156.94772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:34.811459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.543562ms","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-07T05:47:34.811498Z","caller":"traceutil/trace.go:171","msg":"trace[404610393] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:475; }","duration":"159.614523ms","start":"2026-04-07T05:47:34.651875Z","end":"2026-04-07T05:47:34.81149Z","steps":["trace[404610393] 'agreement among raft nodes before linearized reading' (duration: 159.522621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:39.406196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.866716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:47:39.406289Z","caller":"traceutil/trace.go:171","msg":"trace[1945300710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:556; }","duration":"343.007029ms","start":"2026-04-07T05:47:39.063261Z","end":"2026-04-07T05:47:39.406268Z","steps":["trace[1945300710] 'range keys from in-memory index tree' (duration: 342.789075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:39.406333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:47:39.063244Z","time spent":"343.08017ms","remote":"127.0.0.1:60266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T05:47:39.413164Z","caller":"traceutil/trace.go:171","msg":"trace[2042713126] linearizableReadLoop","detail":"{readStateIndex:575; appliedIndex:574; }","duration":"283.812521ms","start":"2026-04-07T05:47:39.129303Z","end":"2026-04-07T05:47:39.413116Z","steps":["trace[2042713126] 'read index received' (duration: 283.051665ms)","trace[2042713126] 'applied index is now lower than readState.Index' (duration: 759.946µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:47:39.413583Z","caller":"traceutil/trace.go:171","msg":"trace[213993707] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"344.710454ms","start":"2026-04-07T05:47:39.068694Z","end":"2026-04-07T05:47:39.413404Z","steps":["trace[213993707] 'process raft request' (duration: 343.892837ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:39.413949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.631857ms","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-04-07T05:47:39.414021Z","caller":"traceutil/trace.go:171","msg":"trace[848716564] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:557; }","duration":"284.729809ms","start":"2026-04-07T05:47:39.129255Z","end":"2026-04-07T05:47:39.413985Z","steps":["trace[848716564] 'agreement among raft nodes before linearized reading' (duration: 284.001025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:39.41442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:47:39.068673Z","time spent":"344.970248ms","remote":"127.0.0.1:60356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036201,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:47:40.99771Z","caller":"traceutil/trace.go:171","msg":"trace[1033106245] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:587; }","duration":"150.008469ms","start":"2026-04-07T05:47:40.847679Z","end":"2026-04-07T05:47:40.997688Z","steps":["trace[1033106245] 'read index received' (duration: 149.119452ms)","trace[1033106245] 'applied index is now lower than readState.Index' (duration: 888.157µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:47:40.998066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.810825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-07T05:47:40.998112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.409268ms","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-07T05:47:40.998157Z","caller":"traceutil/trace.go:171","msg":"trace[1071515146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:569; }","duration":"144.918147ms","start":"2026-04-07T05:47:40.853219Z","end":"2026-04-07T05:47:40.998137Z","steps":["trace[1071515146] 'agreement among raft nodes before linearized reading' (duration: 144.65292ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:40.998196Z","caller":"traceutil/trace.go:171","msg":"trace[213750097] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:569; }","duration":"150.509349ms","start":"2026-04-07T05:47:40.847641Z","end":"2026-04-07T05:47:40.99815Z","steps":["trace[213750097] 'agreement among raft nodes before linearized reading' (duration: 150.278063ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:40.997826Z","caller":"traceutil/trace.go:171","msg":"trace[1562763914] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"182.844718ms","start":"2026-04-07T05:47:40.81497Z","end":"2026-04-07T05:47:40.997815Z","steps":["trace[1562763914] 'process raft request' (duration: 182.127914ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:41.473873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.997388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:47:41.474048Z","caller":"traceutil/trace.go:171","msg":"trace[1285800146] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"431.719392ms","start":"2026-04-07T05:47:41.042308Z","end":"2026-04-07T05:47:41.474027Z","steps":["trace[1285800146] 'process raft request' (duration: 316.308956ms)","trace[1285800146] 'compare' (duration: 114.815095ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:47:41.474162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:47:41.042287Z","time spent":"431.832286ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:47:41.474248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.873833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:47:41.473981Z","caller":"traceutil/trace.go:171","msg":"trace[2003349567] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"410.619177ms","start":"2026-04-07T05:47:41.063347Z","end":"2026-04-07T05:47:41.473966Z","steps":["trace[2003349567] 'read index received' (duration: 295.199651ms)","trace[2003349567] 'applied index is now lower than readState.Index' (duration: 115.418326ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:47:41.474366Z","caller":"traceutil/trace.go:171","msg":"trace[1059178615] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"411.037407ms","start":"2026-04-07T05:47:41.063313Z","end":"2026-04-07T05:47:41.47435Z","steps":["trace[1059178615] 'agreement among raft nodes before linearized reading' (duration: 410.852533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:41.474455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:47:41.063298Z","time spent":"411.150179ms","remote":"127.0.0.1:60262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T05:47:41.708855Z","caller":"traceutil/trace.go:171","msg":"trace[987390230] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"234.520227ms","start":"2026-04-07T05:47:41.474309Z","end":"2026-04-07T05:47:41.708829Z","steps":["trace[987390230] 'read index received' (duration: 222.050235ms)","trace[987390230] 'applied index is now lower than readState.Index' (duration: 12.469022ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:47:41.7091Z","caller":"traceutil/trace.go:171","msg":"trace[794051225] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"643.982163ms","start":"2026-04-07T05:47:41.065077Z","end":"2026-04-07T05:47:41.709059Z","steps":["trace[794051225] 'process raft request' (duration: 631.375298ms)","trace[794051225] 'compare' (duration: 12.245898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:47:41.709312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:47:41.065064Z","time spent":"644.147826ms","remote":"127.0.0.1:60752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:47:41.709363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.778962ms","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-04-07T05:47:41.709492Z","caller":"traceutil/trace.go:171","msg":"trace[1639237952] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"285.953516ms","start":"2026-04-07T05:47:41.423526Z","end":"2026-04-07T05:47:41.70948Z","steps":["trace[1639237952] 'agreement among raft nodes before linearized reading' (duration: 285.412574ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:43.425077Z","caller":"traceutil/trace.go:171","msg":"trace[555431559] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"220.710325ms","start":"2026-04-07T05:47:43.204346Z","end":"2026-04-07T05:47:43.425056Z","steps":["trace[555431559] 'process raft request' (duration: 220.557022ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:43.425029Z","caller":"traceutil/trace.go:171","msg":"trace[566524613] transaction","detail":"{read_only:false; number_of_response:0; response_revision:607; }","duration":"224.8889ms","start":"2026-04-07T05:47:43.200108Z","end":"2026-04-07T05:47:43.424997Z","steps":["trace[566524613] 'process raft request' (duration: 214.329225ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:43.425221Z","caller":"traceutil/trace.go:171","msg":"trace[409006332] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"219.542832ms","start":"2026-04-07T05:47:43.205666Z","end":"2026-04-07T05:47:43.425209Z","steps":["trace[409006332] 'process raft request' (duration: 219.329068ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:43.426834Z","caller":"traceutil/trace.go:171","msg":"trace[1794547495] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"104.893582ms","start":"2026-04-07T05:47:43.321923Z","end":"2026-04-07T05:47:43.426816Z","steps":["trace[1794547495] 'process raft request' (duration: 104.677748ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:57.260601Z","caller":"traceutil/trace.go:171","msg":"trace[1073128474] transaction","detail":"{read_only:false; response_revision:733; number_of_response:1; }","duration":"102.267429ms","start":"2026-04-07T05:47:57.158313Z","end":"2026-04-07T05:47:57.26058Z","steps":["trace[1073128474] 'process raft request' (duration: 94.855115ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:57.26109Z","caller":"traceutil/trace.go:171","msg":"trace[1020453340] transaction","detail":"{read_only:false; response_revision:734; number_of_response:1; }","duration":"102.646926ms","start":"2026-04-07T05:47:57.158423Z","end":"2026-04-07T05:47:57.26107Z","steps":["trace[1020453340] 'process raft request' (duration: 102.123684ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:57.261123Z","caller":"traceutil/trace.go:171","msg":"trace[858788662] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"100.070414ms","start":"2026-04-07T05:47:57.161Z","end":"2026-04-07T05:47:57.26107Z","steps":["trace[858788662] 'process raft request' (duration: 99.822269ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:48:49.636592Z","caller":"traceutil/trace.go:171","msg":"trace[804950010] linearizableReadLoop","detail":"{readStateIndex:1432; appliedIndex:1431; }","duration":"153.095836ms","start":"2026-04-07T05:48:49.483472Z","end":"2026-04-07T05:48:49.636567Z","steps":["trace[804950010] 'read index received' (duration: 152.893942ms)","trace[804950010] 'applied index is now lower than readState.Index' (duration: 201.004µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:48:49.636715Z","caller":"traceutil/trace.go:171","msg":"trace[691773355] transaction","detail":"{read_only:false; response_revision:1394; number_of_response:1; }","duration":"214.075458ms","start":"2026-04-07T05:48:49.422629Z","end":"2026-04-07T05:48:49.636705Z","steps":["trace[691773355] 'process raft request' (duration: 213.787533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:48:49.636904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.395272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T05:48:49.636939Z","caller":"traceutil/trace.go:171","msg":"trace[1851501455] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1394; }","duration":"153.494644ms","start":"2026-04-07T05:48:49.483433Z","end":"2026-04-07T05:48:49.636928Z","steps":["trace[1851501455] 'agreement among raft nodes before linearized reading' (duration: 153.401312ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:48:49.637192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.375734ms","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-07T05:48:49.637267Z","caller":"traceutil/trace.go:171","msg":"trace[1619934210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1394; }","duration":"127.487807ms","start":"2026-04-07T05:48:49.509757Z","end":"2026-04-07T05:48:49.637245Z","steps":["trace[1619934210] 'agreement among raft nodes before linearized reading' (duration: 127.316694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:48:49.63729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.468237ms","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":"warn","ts":"2026-04-07T05:48:49.63729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.422566ms","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-04-07T05:48:49.637331Z","caller":"traceutil/trace.go:171","msg":"trace[520029729] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1394; }","duration":"127.512017ms","start":"2026-04-07T05:48:49.509809Z","end":"2026-04-07T05:48:49.637321Z","steps":["trace[520029729] 'agreement among raft nodes before linearized reading' (duration: 127.379345ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:48:49.637334Z","caller":"traceutil/trace.go:171","msg":"trace[1861089554] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1394; }","duration":"128.542227ms","start":"2026-04-07T05:48:49.508774Z","end":"2026-04-07T05:48:49.637316Z","steps":["trace[1861089554] 'agreement among raft nodes before linearized reading' (duration: 128.462456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:48:49.637192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.599149ms","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-07T05:48:49.637412Z","caller":"traceutil/trace.go:171","msg":"trace[140241502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1394; }","duration":"129.855354ms","start":"2026-04-07T05:48:49.507548Z","end":"2026-04-07T05:48:49.637403Z","steps":["trace[140241502] 'agreement among raft nodes before linearized reading' (duration: 129.511277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:12.874053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.898859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" ","response":"range_response_count:1 size:10668"} {"level":"info","ts":"2026-04-07T05:49:12.874141Z","caller":"traceutil/trace.go:171","msg":"trace[1603604558] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-haproxy-0; range_end:; response_count:1; response_revision:1794; }","duration":"372.030201ms","start":"2026-04-07T05:49:12.502093Z","end":"2026-04-07T05:49:12.874123Z","steps":["trace[1603604558] 'range keys from in-memory index tree' (duration: 371.717616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:12.874181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:49:12.502072Z","time spent":"372.101073ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":10690,"request content":"key:\"/registry/pods/openstack/percona-xtradb-haproxy-0\" "} {"level":"warn","ts":"2026-04-07T05:49:12.874199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.866442ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:49:12.874287Z","caller":"traceutil/trace.go:171","msg":"trace[86063258] linearizableReadLoop","detail":"{readStateIndex:1860; appliedIndex:1859; }","duration":"217.86404ms","start":"2026-04-07T05:49:12.65641Z","end":"2026-04-07T05:49:12.874274Z","steps":["trace[86063258] 'read index received' (duration: 113.683611ms)","trace[86063258] 'applied index is now lower than readState.Index' (duration: 104.179239ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:49:12.87451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.202095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T05:49:12.874567Z","caller":"traceutil/trace.go:171","msg":"trace[1233477643] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1795; }","duration":"169.264547ms","start":"2026-04-07T05:49:12.70529Z","end":"2026-04-07T05:49:12.874554Z","steps":["trace[1233477643] 'agreement among raft nodes before linearized reading' (duration: 169.153345ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:12.874547Z","caller":"traceutil/trace.go:171","msg":"trace[1743646870] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"344.889101ms","start":"2026-04-07T05:49:12.529616Z","end":"2026-04-07T05:49:12.874505Z","steps":["trace[1743646870] 'process raft request' (duration: 240.619091ms)","trace[1743646870] 'compare' (duration: 103.76295ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:49:12.874585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.167306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0b66a071-cbc9-4410-bf3e-a3a65c045311\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-07T05:49:12.87466Z","caller":"traceutil/trace.go:171","msg":"trace[879152631] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0b66a071-cbc9-4410-bf3e-a3a65c045311; range_end:; response_count:1; response_revision:1795; }","duration":"218.307889ms","start":"2026-04-07T05:49:12.656334Z","end":"2026-04-07T05:49:12.874642Z","steps":["trace[879152631] 'agreement among raft nodes before linearized reading' (duration: 218.073214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:12.874735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:49:12.529587Z","time spent":"345.058045ms","remote":"127.0.0.1:60534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:49:13.098536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.544597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:49:13.098823Z","caller":"traceutil/trace.go:171","msg":"trace[1891775213] transaction","detail":"{read_only:false; response_revision:1796; number_of_response:1; }","duration":"214.449182ms","start":"2026-04-07T05:49:12.884343Z","end":"2026-04-07T05:49:13.098792Z","steps":["trace[1891775213] 'process raft request' (duration: 111.553889ms)","trace[1891775213] 'compare' (duration: 102.328432ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:49:13.456526Z","caller":"traceutil/trace.go:171","msg":"trace[822223931] linearizableReadLoop","detail":"{readStateIndex:1866; appliedIndex:1861; }","duration":"203.41485ms","start":"2026-04-07T05:49:13.253079Z","end":"2026-04-07T05:49:13.456493Z","steps":["trace[822223931] 'read index received' (duration: 192.403157ms)","trace[822223931] 'applied index is now lower than readState.Index' (duration: 11.010943ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:49:13.456651Z","caller":"traceutil/trace.go:171","msg":"trace[324790611] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"347.330565ms","start":"2026-04-07T05:49:13.109266Z","end":"2026-04-07T05:49:13.456597Z","steps":["trace[324790611] 'process raft request' (duration: 347.144881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:13.456816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:49:13.109261Z","time spent":"347.468128ms","remote":"127.0.0.1:60546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:49:13.456507Z","caller":"traceutil/trace.go:171","msg":"trace[1837850724] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"347.235693ms","start":"2026-04-07T05:49:13.109201Z","end":"2026-04-07T05:49:13.456436Z","steps":["trace[1837850724] 'process raft request' (duration: 336.291701ms)","trace[1837850724] 'compare' (duration: 10.760308ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:49:13.456986Z","caller":"traceutil/trace.go:171","msg":"trace[1439779363] transaction","detail":"{read_only:false; response_revision:1800; number_of_response:1; }","duration":"347.58108ms","start":"2026-04-07T05:49:13.109388Z","end":"2026-04-07T05:49:13.456969Z","steps":["trace[1439779363] 'process raft request' (duration: 347.05186ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:13.456986Z","caller":"traceutil/trace.go:171","msg":"trace[2072992274] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"347.514759ms","start":"2026-04-07T05:49:13.109436Z","end":"2026-04-07T05:49:13.456951Z","steps":["trace[2072992274] 'process raft request' (duration: 347.03549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:13.457011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:49:13.109179Z","time spent":"347.776684ms","remote":"127.0.0.1:60446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3729,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:49:13.457076Z","caller":"traceutil/trace.go:171","msg":"trace[993512389] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"347.857725ms","start":"2026-04-07T05:49:13.109205Z","end":"2026-04-07T05:49:13.457063Z","steps":["trace[993512389] 'process raft request' (duration: 347.160252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:13.457143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:49:13.109192Z","time spent":"347.917576ms","remote":"127.0.0.1:60546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:49:13.457137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:49:13.109423Z","time spent":"347.626381ms","remote":"127.0.0.1:60426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:49:13.457138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:49:13.109363Z","time spent":"347.685362ms","remote":"127.0.0.1:60426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:49:13.457263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.193075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-07T05:49:13.457307Z","caller":"traceutil/trace.go:171","msg":"trace[831148702] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1801; }","duration":"204.280658ms","start":"2026-04-07T05:49:13.253014Z","end":"2026-04-07T05:49:13.457294Z","steps":["trace[831148702] 'agreement among raft nodes before linearized reading' (duration: 204.130144ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:20.268396Z","caller":"traceutil/trace.go:171","msg":"trace[1068226707] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"138.292873ms","start":"2026-04-07T05:49:20.130065Z","end":"2026-04-07T05:49:20.268358Z","steps":["trace[1068226707] 'process raft request' (duration: 137.972346ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:40.988251Z","caller":"traceutil/trace.go:171","msg":"trace[185861364] transaction","detail":"{read_only:false; response_revision:2003; number_of_response:1; }","duration":"106.61195ms","start":"2026-04-07T05:49:40.881618Z","end":"2026-04-07T05:49:40.98823Z","steps":["trace[185861364] 'process raft request' (duration: 106.468646ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:47.216013Z","caller":"traceutil/trace.go:171","msg":"trace[98010399] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"196.552865ms","start":"2026-04-07T05:49:47.019432Z","end":"2026-04-07T05:49:47.215985Z","steps":["trace[98010399] 'process raft request' (duration: 196.302499ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:47.216599Z","caller":"traceutil/trace.go:171","msg":"trace[108651307] linearizableReadLoop","detail":"{readStateIndex:2109; appliedIndex:2108; }","duration":"152.177012ms","start":"2026-04-07T05:49:47.064406Z","end":"2026-04-07T05:49:47.216583Z","steps":["trace[108651307] 'read index received' (duration: 151.246413ms)","trace[108651307] 'applied index is now lower than readState.Index' (duration: 929.639µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:49:47.216691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.270454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:49:47.216729Z","caller":"traceutil/trace.go:171","msg":"trace[892407225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2036; }","duration":"152.359076ms","start":"2026-04-07T05:49:47.06436Z","end":"2026-04-07T05:49:47.216719Z","steps":["trace[892407225] 'agreement among raft nodes before linearized reading' (duration: 152.283684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:48.21801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.164212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-04-07T05:49:48.21804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.19173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T05:49:48.218086Z","caller":"traceutil/trace.go:171","msg":"trace[1158505677] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2037; }","duration":"116.291505ms","start":"2026-04-07T05:49:48.101777Z","end":"2026-04-07T05:49:48.218069Z","steps":["trace[1158505677] 'range keys from in-memory index tree' (duration: 115.960058ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:48.21812Z","caller":"traceutil/trace.go:171","msg":"trace[185112261] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2037; }","duration":"199.325883ms","start":"2026-04-07T05:49:48.018774Z","end":"2026-04-07T05:49:48.2181Z","steps":["trace[185112261] 'count revisions from in-memory index tree' (duration: 199.070548ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:48.21815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.346809ms","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-04-07T05:49:48.218206Z","caller":"traceutil/trace.go:171","msg":"trace[1884353875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2037; }","duration":"123.40086ms","start":"2026-04-07T05:49:48.094792Z","end":"2026-04-07T05:49:48.218193Z","steps":["trace[1884353875] 'range keys from in-memory index tree' (duration: 123.225507ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:48.218162Z","caller":"traceutil/trace.go:171","msg":"trace[2139290537] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"115.827844ms","start":"2026-04-07T05:49:48.102314Z","end":"2026-04-07T05:49:48.218142Z","steps":["trace[2139290537] 'process raft request' (duration: 17.393518ms)","trace[2139290537] 'compare' (duration: 98.193041ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:49:48.218046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.0604ms","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-04-07T05:49:48.218356Z","caller":"traceutil/trace.go:171","msg":"trace[14585130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2037; }","duration":"151.475868ms","start":"2026-04-07T05:49:48.066869Z","end":"2026-04-07T05:49:48.218345Z","steps":["trace[14585130] 'range keys from in-memory index tree' (duration: 150.805375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:49:48.218447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.309091ms","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-07T05:49:48.21856Z","caller":"traceutil/trace.go:171","msg":"trace[767924595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2037; }","duration":"161.451465ms","start":"2026-04-07T05:49:48.05709Z","end":"2026-04-07T05:49:48.218542Z","steps":["trace[767924595] 'range keys from in-memory index tree' (duration: 161.056056ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:48.412013Z","caller":"traceutil/trace.go:171","msg":"trace[2092868021] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"189.336418ms","start":"2026-04-07T05:49:48.222654Z","end":"2026-04-07T05:49:48.41199Z","steps":["trace[2092868021] 'process raft request' (duration: 189.065812ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:48.412083Z","caller":"traceutil/trace.go:171","msg":"trace[235843085] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"189.323758ms","start":"2026-04-07T05:49:48.222737Z","end":"2026-04-07T05:49:48.412061Z","steps":["trace[235843085] 'process raft request' (duration: 189.057993ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:49:48.412098Z","caller":"traceutil/trace.go:171","msg":"trace[1945213607] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"189.463731ms","start":"2026-04-07T05:49:48.222597Z","end":"2026-04-07T05:49:48.41206Z","steps":["trace[1945213607] 'process raft request' (duration: 188.829507ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:51:30.85885Z","caller":"traceutil/trace.go:171","msg":"trace[1511652958] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"126.591232ms","start":"2026-04-07T05:51:30.732237Z","end":"2026-04-07T05:51:30.858828Z","steps":["trace[1511652958] 'process raft request' (duration: 126.460919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:31.368492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.317464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:51:31.368973Z","caller":"traceutil/trace.go:171","msg":"trace[1833287793] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"352.29609ms","start":"2026-04-07T05:51:31.016629Z","end":"2026-04-07T05:51:31.368925Z","steps":["trace[1833287793] 'process raft request' (duration: 133.446525ms)","trace[1833287793] 'compare' (duration: 218.015728ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:51:31.369337Z","caller":"traceutil/trace.go:171","msg":"trace[967777713] transaction","detail":"{read_only:false; response_revision:2699; number_of_response:1; }","duration":"352.561367ms","start":"2026-04-07T05:51:31.01675Z","end":"2026-04-07T05:51:31.369311Z","steps":["trace[967777713] 'process raft request' (duration: 351.843031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:31.369489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:31.016742Z","time spent":"352.672359ms","remote":"127.0.0.1:60534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:51:31.369672Z","caller":"traceutil/trace.go:171","msg":"trace[1880147943] transaction","detail":"{read_only:false; response_revision:2700; number_of_response:1; }","duration":"352.752791ms","start":"2026-04-07T05:51:31.016896Z","end":"2026-04-07T05:51:31.369649Z","steps":["trace[1880147943] 'process raft request' (duration: 352.343811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:31.369802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:31.016852Z","time spent":"352.878153ms","remote":"127.0.0.1:60534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:51:31.370381Z","caller":"traceutil/trace.go:171","msg":"trace[1711817775] transaction","detail":"{read_only:false; response_revision:2701; number_of_response:1; }","duration":"352.109516ms","start":"2026-04-07T05:51:31.018258Z","end":"2026-04-07T05:51:31.370368Z","steps":["trace[1711817775] 'process raft request' (duration: 351.222768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:31.370501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:31.018244Z","time spent":"352.176388ms","remote":"127.0.0.1:60534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:51:31.369091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:31.016615Z","time spent":"352.407093ms","remote":"127.0.0.1:60534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:51:31.371048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.778867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:51:31.371132Z","caller":"traceutil/trace.go:171","msg":"trace[689596269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2701; }","duration":"306.90221ms","start":"2026-04-07T05:51:31.064215Z","end":"2026-04-07T05:51:31.371117Z","steps":["trace[689596269] 'agreement among raft nodes before linearized reading' (duration: 306.797647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:51:31.371205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:51:31.064193Z","time spent":"307.001942ms","remote":"127.0.0.1:60266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T05:51:31.369995Z","caller":"traceutil/trace.go:171","msg":"trace[2067510832] linearizableReadLoop","detail":"{readStateIndex:2798; appliedIndex:2794; }","duration":"305.702304ms","start":"2026-04-07T05:51:31.064273Z","end":"2026-04-07T05:51:31.369975Z","steps":["trace[2067510832] 'read index received' (duration: 85.796747ms)","trace[2067510832] 'applied index is now lower than readState.Index' (duration: 219.904627ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:51:31.372219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.136846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a3fd327381df74\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-04-07T05:51:31.372955Z","caller":"traceutil/trace.go:171","msg":"trace[788087402] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a3fd327381df74; range_end:; response_count:1; response_revision:2701; }","duration":"128.90171ms","start":"2026-04-07T05:51:31.244035Z","end":"2026-04-07T05:51:31.372936Z","steps":["trace[788087402] 'agreement among raft nodes before linearized reading' (duration: 128.039353ms)"],"step_count":1}