{"level":"warn","ts":"2026-05-19T11:53:10.392885Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T11:53:10.393626Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.196: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.19.213.196:2380","--initial-cluster=instance=https://199.19.213.196:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.196:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.196: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-05-19T11:53:10.393755Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T11:53:10.393769Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.196:2380"]} {"level":"info","ts":"2026-05-19T11:53:10.393787Z","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-05-19T11:53:10.394671Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"]} {"level":"info","ts":"2026-05-19T11:53:10.394784Z","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.19.213.196:2380"],"listen-peer-urls":["https://199.19.213.196:2380"],"advertise-client-urls":["https://199.19.213.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.196: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-05-19T11:53:10.39983Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.593335ms"} {"level":"info","ts":"2026-05-19T11:53:10.410688Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8f376d4d42da413a","cluster-id":"f5ef03c8da56d984"} {"level":"info","ts":"2026-05-19T11:53:10.410742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T11:53:10.410763Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became follower at term 0"} {"level":"info","ts":"2026-05-19T11:53:10.410772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8f376d4d42da413a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T11:53:10.410781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became follower at term 1"} {"level":"info","ts":"2026-05-19T11:53:10.410808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=(10319837249744290106)"} {"level":"warn","ts":"2026-05-19T11:53:10.415626Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T11:53:10.418319Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T11:53:10.419289Z","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-05-19T11:53:10.420959Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8f376d4d42da413a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T11:53:10.421131Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8f376d4d42da413a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T11:53:10.421333Z","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-05-19T11:53:10.421406Z","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-05-19T11:53:10.42153Z","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-05-19T11:53:10.422008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=(10319837249744290106)"} {"level":"info","ts":"2026-05-19T11:53:10.422123Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5ef03c8da56d984","local-member-id":"8f376d4d42da413a","added-peer-id":"8f376d4d42da413a","added-peer-peer-urls":["https://199.19.213.196:2380"]} {"level":"info","ts":"2026-05-19T11:53:10.43246Z","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-05-19T11:53:10.433148Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.196:2380"} {"level":"info","ts":"2026-05-19T11:53:10.433185Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.196:2380"} {"level":"info","ts":"2026-05-19T11:53:10.43352Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8f376d4d42da413a","initial-advertise-peer-urls":["https://199.19.213.196:2380"],"listen-peer-urls":["https://199.19.213.196:2380"],"advertise-client-urls":["https://199.19.213.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T11:53:10.433593Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T11:53:11.21183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T11:53:11.211903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T11:53:11.211947Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a received MsgPreVoteResp from 8f376d4d42da413a at term 1"} {"level":"info","ts":"2026-05-19T11:53:11.211966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became candidate at term 2"} {"level":"info","ts":"2026-05-19T11:53:11.211978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a received MsgVoteResp from 8f376d4d42da413a at term 2"} {"level":"info","ts":"2026-05-19T11:53:11.212024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became leader at term 2"} {"level":"info","ts":"2026-05-19T11:53:11.212048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8f376d4d42da413a elected leader 8f376d4d42da413a at term 2"} {"level":"info","ts":"2026-05-19T11:53:11.213061Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T11:53:11.214014Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T11:53:11.214036Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T11:53:11.214706Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5ef03c8da56d984","local-member-id":"8f376d4d42da413a","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T11:53:11.214921Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T11:53:11.214969Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T11:53:11.215544Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T11:53:11.215639Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T11:53:11.215741Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.196:2379"} {"level":"info","ts":"2026-05-19T11:53:11.217057Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T11:53:11.219126Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8f376d4d42da413a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.196:2379]}","request-path":"/0/members/8f376d4d42da413a/attributes","cluster-id":"f5ef03c8da56d984","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T11:53:12.645493Z","caller":"traceutil/trace.go:171","msg":"trace[1900746465] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"140.093133ms","start":"2026-05-19T11:53:12.505369Z","end":"2026-05-19T11:53:12.645462Z","steps":["trace[1900746465] 'read index received' (duration: 139.902881ms)","trace[1900746465] 'applied index is now lower than readState.Index' (duration: 189.182µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T11:53:12.645516Z","caller":"traceutil/trace.go:171","msg":"trace[682141780] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"141.569364ms","start":"2026-05-19T11:53:12.503913Z","end":"2026-05-19T11:53:12.645482Z","steps":["trace[682141780] 'process raft request' (duration: 141.335982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.64603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.636216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T11:53:12.64609Z","caller":"traceutil/trace.go:171","msg":"trace[1530687048] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:0; response_revision:2; }","duration":"140.737737ms","start":"2026-05-19T11:53:12.505342Z","end":"2026-05-19T11:53:12.646079Z","steps":["trace[1530687048] 'agreement among raft nodes before linearized reading' (duration: 140.267404ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:12.907579Z","caller":"traceutil/trace.go:171","msg":"trace[2139478606] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"402.095265ms","start":"2026-05-19T11:53:12.505456Z","end":"2026-05-19T11:53:12.907552Z","steps":["trace[2139478606] 'process raft request' (duration: 401.675002ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.907774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.643094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-05-19T11:53:12.90787Z","caller":"traceutil/trace.go:171","msg":"trace[1275039373] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"397.763155ms","start":"2026-05-19T11:53:12.510093Z","end":"2026-05-19T11:53:12.907856Z","steps":["trace[1275039373] 'agreement among raft nodes before linearized reading' (duration: 397.549663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.907943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.510087Z","time spent":"397.845485ms","remote":"127.0.0.1:56470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3195,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-05-19T11:53:12.908092Z","caller":"traceutil/trace.go:171","msg":"trace[782543563] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"308.173337ms","start":"2026-05-19T11:53:12.599842Z","end":"2026-05-19T11:53:12.908016Z","steps":["trace[782543563] 'process raft request' (duration: 307.642593ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:12.908143Z","caller":"traceutil/trace.go:171","msg":"trace[268411003] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"311.843314ms","start":"2026-05-19T11:53:12.596264Z","end":"2026-05-19T11:53:12.908107Z","steps":["trace[268411003] 'process raft request' (duration: 311.089358ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:12.908188Z","caller":"traceutil/trace.go:171","msg":"trace[546200294] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"312.265187ms","start":"2026-05-19T11:53:12.595872Z","end":"2026-05-19T11:53:12.908137Z","steps":["trace[546200294] 'process raft request' (duration: 311.39913ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.908211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.772934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T11:53:12.908368Z","caller":"traceutil/trace.go:171","msg":"trace[1035086554] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"311.898745ms","start":"2026-05-19T11:53:12.596409Z","end":"2026-05-19T11:53:12.908308Z","steps":["trace[1035086554] 'process raft request' (duration: 310.990057ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:12.908442Z","caller":"traceutil/trace.go:171","msg":"trace[251501546] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"312.402457ms","start":"2026-05-19T11:53:12.596028Z","end":"2026-05-19T11:53:12.90843Z","steps":["trace[251501546] 'process raft request' (duration: 311.286309ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:12.908378Z","caller":"traceutil/trace.go:171","msg":"trace[178708563] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"322.952625ms","start":"2026-05-19T11:53:12.585368Z","end":"2026-05-19T11:53:12.908321Z","steps":["trace[178708563] 'agreement among raft nodes before linearized reading' (duration: 322.689122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.9085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.452503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T11:53:12.908517Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.585358Z","time spent":"323.144766ms","remote":"127.0.0.1:56390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-19T11:53:12.908527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.932895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T11:53:12.908547Z","caller":"traceutil/trace.go:171","msg":"trace[947347134] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"267.539153ms","start":"2026-05-19T11:53:12.640994Z","end":"2026-05-19T11:53:12.908534Z","steps":["trace[947347134] 'agreement among raft nodes before linearized reading' (duration: 267.463093ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:12.908558Z","caller":"traceutil/trace.go:171","msg":"trace[1306476386] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"347.979645ms","start":"2026-05-19T11:53:12.560567Z","end":"2026-05-19T11:53:12.908546Z","steps":["trace[1306476386] 'agreement among raft nodes before linearized reading' (duration: 347.931105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.908622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.560556Z","time spent":"348.059926ms","remote":"127.0.0.1:56390","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":28,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-19T11:53:12.908679Z","caller":"traceutil/trace.go:171","msg":"trace[1843000458] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"308.597709ms","start":"2026-05-19T11:53:12.600071Z","end":"2026-05-19T11:53:12.908668Z","steps":["trace[1843000458] 'process raft request' (duration: 307.45202ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:12.908722Z","caller":"traceutil/trace.go:171","msg":"trace[1435475470] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"312.164236ms","start":"2026-05-19T11:53:12.596503Z","end":"2026-05-19T11:53:12.908667Z","steps":["trace[1435475470] 'process raft request' (duration: 310.953857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.908733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.988144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-19T11:53:12.908836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.761755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T11:53:12.908869Z","caller":"traceutil/trace.go:171","msg":"trace[627718629] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"393.790625ms","start":"2026-05-19T11:53:12.515069Z","end":"2026-05-19T11:53:12.90886Z","steps":["trace[627718629] 'agreement among raft nodes before linearized reading' (duration: 393.752755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.908901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.515033Z","time spent":"393.863047ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T11:53:12.908469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.879421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.196\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T11:53:12.90898Z","caller":"traceutil/trace.go:171","msg":"trace[755206304] range","detail":"{range_begin:/registry/masterleases/199.19.213.196; range_end:; response_count:0; response_revision:11; }","duration":"324.407354ms","start":"2026-05-19T11:53:12.584562Z","end":"2026-05-19T11:53:12.908969Z","steps":["trace[755206304] 'agreement among raft nodes before linearized reading' (duration: 323.875991ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.908803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.673535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-19T11:53:12.909118Z","caller":"traceutil/trace.go:171","msg":"trace[648083365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"393.995917ms","start":"2026-05-19T11:53:12.51511Z","end":"2026-05-19T11:53:12.909105Z","steps":["trace[648083365] 'agreement among raft nodes before linearized reading' (duration: 393.664185ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.909177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.515101Z","time spent":"394.064868ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T11:53:12.907578Z","caller":"traceutil/trace.go:171","msg":"trace[1664541568] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:5; }","duration":"261.974892ms","start":"2026-05-19T11:53:12.645581Z","end":"2026-05-19T11:53:12.907556Z","steps":["trace[1664541568] 'read index received' (duration: 261.489549ms)","trace[1664541568] 'applied index is now lower than readState.Index' (duration: 484.263µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T11:53:12.908569Z","caller":"traceutil/trace.go:171","msg":"trace[1560125741] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"312.060295ms","start":"2026-05-19T11:53:12.596459Z","end":"2026-05-19T11:53:12.908519Z","steps":["trace[1560125741] 'process raft request' (duration: 310.967557ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:12.908842Z","caller":"traceutil/trace.go:171","msg":"trace[185687010] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"323.150056ms","start":"2026-05-19T11:53:12.585677Z","end":"2026-05-19T11:53:12.908827Z","steps":["trace[185687010] 'agreement among raft nodes before linearized reading' (duration: 323.018865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:12.909444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.585653Z","time spent":"323.77965ms","remote":"127.0.0.1:56380","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-19T11:53:12.909617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.505445Z","time spent":"402.208586ms","remote":"127.0.0.1:56352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T11:53:12.909761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.596258Z","time spent":"311.946125ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T11:53:12.909074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.584551Z","time spent":"324.511435ms","remote":"127.0.0.1:56336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.19.213.196\" "} {"level":"warn","ts":"2026-05-19T11:53:12.910018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.599834Z","time spent":"308.335519ms","remote":"127.0.0.1:56470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T11:53:12.910569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.595862Z","time spent":"312.398308ms","remote":"127.0.0.1:56734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T11:53:12.91071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.596403Z","time spent":"312.038836ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T11:53:12.91085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.596008Z","time spent":"312.468369ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T11:53:12.911024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.600048Z","time spent":"308.65298ms","remote":"127.0.0.1:56536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T11:53:12.911961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.596497Z","time spent":"312.337857ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T11:53:12.912604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:12.596454Z","time spent":"312.889761ms","remote":"127.0.0.1:56802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T11:53:39.548753Z","caller":"traceutil/trace.go:171","msg":"trace[693990433] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"120.524144ms","start":"2026-05-19T11:53:39.428201Z","end":"2026-05-19T11:53:39.548726Z","steps":["trace[693990433] 'process raft request' (duration: 119.590547ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:39.548821Z","caller":"traceutil/trace.go:171","msg":"trace[642338312] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"104.882862ms","start":"2026-05-19T11:53:39.443912Z","end":"2026-05-19T11:53:39.548795Z","steps":["trace[642338312] 'process raft request' (duration: 104.082031ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:39.548985Z","caller":"traceutil/trace.go:171","msg":"trace[1999084062] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"105.098923ms","start":"2026-05-19T11:53:39.443873Z","end":"2026-05-19T11:53:39.548972Z","steps":["trace[1999084062] 'process raft request' (duration: 104.05493ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:46.185885Z","caller":"traceutil/trace.go:171","msg":"trace[933257645] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"334.841523ms","start":"2026-05-19T11:53:45.850921Z","end":"2026-05-19T11:53:46.185763Z","steps":["trace[933257645] 'process raft request' (duration: 334.679664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:46.186179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:45.850898Z","time spent":"335.110906ms","remote":"127.0.0.1:56474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T11:53:46.275196Z","caller":"traceutil/trace.go:171","msg":"trace[1287834441] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:642; }","duration":"282.538016ms","start":"2026-05-19T11:53:45.992638Z","end":"2026-05-19T11:53:46.275176Z","steps":["trace[1287834441] 'read index received' (duration: 192.91061ms)","trace[1287834441] 'applied index is now lower than readState.Index' (duration: 89.626676ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T11:53:46.275303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.646182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-19T11:53:46.275331Z","caller":"traceutil/trace.go:171","msg":"trace[1607220816] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"282.690594ms","start":"2026-05-19T11:53:45.992633Z","end":"2026-05-19T11:53:46.275323Z","steps":["trace[1607220816] 'agreement among raft nodes before linearized reading' (duration: 282.62091ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:46.275439Z","caller":"traceutil/trace.go:171","msg":"trace[593425406] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"261.324962ms","start":"2026-05-19T11:53:46.014106Z","end":"2026-05-19T11:53:46.275431Z","steps":["trace[593425406] 'process raft request' (duration: 261.027157ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:46.275567Z","caller":"traceutil/trace.go:171","msg":"trace[161153478] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"424.810055ms","start":"2026-05-19T11:53:45.850718Z","end":"2026-05-19T11:53:46.275528Z","steps":["trace[161153478] 'process raft request' (duration: 423.982895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:46.275773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:45.850687Z","time spent":"424.958943ms","remote":"127.0.0.1:56382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T11:53:46.762218Z","caller":"traceutil/trace.go:171","msg":"trace[1612544090] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"388.599961ms","start":"2026-05-19T11:53:46.37358Z","end":"2026-05-19T11:53:46.76218Z","steps":["trace[1612544090] 'read index received' (duration: 373.757101ms)","trace[1612544090] 'applied index is now lower than readState.Index' (duration: 14.836759ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T11:53:46.762544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.934646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T11:53:46.762678Z","caller":"traceutil/trace.go:171","msg":"trace[131044562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:627; }","duration":"389.108954ms","start":"2026-05-19T11:53:46.373538Z","end":"2026-05-19T11:53:46.762647Z","steps":["trace[131044562] 'agreement among raft nodes before linearized reading' (duration: 388.923016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:53:46.762747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:46.373518Z","time spent":"389.21779ms","remote":"127.0.0.1:56302","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-19T11:53:46.763241Z","caller":"traceutil/trace.go:171","msg":"trace[1372556007] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"271.819766ms","start":"2026-05-19T11:53:46.49015Z","end":"2026-05-19T11:53:46.761969Z","steps":["trace[1372556007] 'process raft request' (duration: 271.745822ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:46.762042Z","caller":"traceutil/trace.go:171","msg":"trace[2023567698] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"416.36866ms","start":"2026-05-19T11:53:46.345631Z","end":"2026-05-19T11:53:46.761999Z","steps":["trace[2023567698] 'process raft request' (duration: 401.610285ms)","trace[2023567698] 'compare' (duration: 14.460451ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T11:53:46.763822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T11:53:46.345618Z","time spent":"418.137233ms","remote":"127.0.0.1:56526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T11:53:48.07631Z","caller":"traceutil/trace.go:171","msg":"trace[1262280506] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"105.380889ms","start":"2026-05-19T11:53:47.970899Z","end":"2026-05-19T11:53:48.07628Z","steps":["trace[1262280506] 'process raft request' (duration: 105.242253ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:53:48.080474Z","caller":"traceutil/trace.go:171","msg":"trace[490382638] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"103.458178ms","start":"2026-05-19T11:53:47.976996Z","end":"2026-05-19T11:53:48.080454Z","steps":["trace[490382638] 'process raft request' (duration: 103.394655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T11:54:00.600855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.116074ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T11:54:00.600967Z","caller":"traceutil/trace.go:171","msg":"trace[1649578436] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"225.999205ms","start":"2026-05-19T11:54:00.374951Z","end":"2026-05-19T11:54:00.60095Z","steps":["trace[1649578436] 'read index received' (duration: 94.606671ms)","trace[1649578436] 'applied index is now lower than readState.Index' (duration: 131.391424ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T11:54:00.601023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.079138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T11:54:00.60106Z","caller":"traceutil/trace.go:171","msg":"trace[1286812346] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"226.149162ms","start":"2026-05-19T11:54:00.374901Z","end":"2026-05-19T11:54:00.60105Z","steps":["trace[1286812346] 'agreement among raft nodes before linearized reading' (duration: 226.09298ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:54:00.601559Z","caller":"traceutil/trace.go:171","msg":"trace[267453358] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"248.718567ms","start":"2026-05-19T11:54:00.35247Z","end":"2026-05-19T11:54:00.601188Z","steps":["trace[267453358] 'process raft request' (duration: 117.041271ms)","trace[267453358] 'compare' (duration: 130.951047ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T11:55:51.33673Z","caller":"traceutil/trace.go:171","msg":"trace[1089588563] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"144.607898ms","start":"2026-05-19T11:55:51.192095Z","end":"2026-05-19T11:55:51.336703Z","steps":["trace[1089588563] 'process raft request' (duration: 144.470526ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:55:51.652993Z","caller":"traceutil/trace.go:171","msg":"trace[1365998754] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"190.217666ms","start":"2026-05-19T11:55:51.462747Z","end":"2026-05-19T11:55:51.652965Z","steps":["trace[1365998754] 'process raft request' (duration: 190.125845ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:55:51.653249Z","caller":"traceutil/trace.go:171","msg":"trace[1494357427] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"183.195761ms","start":"2026-05-19T11:55:51.470001Z","end":"2026-05-19T11:55:51.653197Z","steps":["trace[1494357427] 'process raft request' (duration: 182.920766ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:55:51.653258Z","caller":"traceutil/trace.go:171","msg":"trace[721838509] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"195.741297ms","start":"2026-05-19T11:55:51.457477Z","end":"2026-05-19T11:55:51.653218Z","steps":["trace[721838509] 'process raft request' (duration: 127.49626ms)","trace[721838509] 'compare' (duration: 67.761879ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T11:55:51.655514Z","caller":"traceutil/trace.go:171","msg":"trace[293380648] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"174.205623ms","start":"2026-05-19T11:55:51.481283Z","end":"2026-05-19T11:55:51.655489Z","steps":["trace[293380648] 'process raft request' (duration: 174.076511ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:57:10.174563Z","caller":"traceutil/trace.go:171","msg":"trace[1690874866] transaction","detail":"{read_only:false; response_revision:2629; number_of_response:1; }","duration":"170.066222ms","start":"2026-05-19T11:57:10.004467Z","end":"2026-05-19T11:57:10.174533Z","steps":["trace[1690874866] 'process raft request' (duration: 169.91089ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T11:57:43.287741Z","caller":"traceutil/trace.go:171","msg":"trace[1169521385] transaction","detail":"{read_only:false; response_revision:2812; number_of_response:1; }","duration":"104.445259ms","start":"2026-05-19T11:57:43.183265Z","end":"2026-05-19T11:57:43.28771Z","steps":["trace[1169521385] 'process raft request' (duration: 104.270797ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T12:02:00.143811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.64024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T12:02:00.143975Z","caller":"traceutil/trace.go:171","msg":"trace[193192788] linearizableReadLoop","detail":"{readStateIndex:5203; appliedIndex:5201; }","duration":"271.500641ms","start":"2026-05-19T12:01:59.872457Z","end":"2026-05-19T12:02:00.143958Z","steps":["trace[193192788] 'read index received' (duration: 20.589656ms)","trace[193192788] 'applied index is now lower than readState.Index' (duration: 250.909765ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T12:02:00.144063Z","caller":"traceutil/trace.go:171","msg":"trace[160988333] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"442.825653ms","start":"2026-05-19T12:01:59.701225Z","end":"2026-05-19T12:02:00.144051Z","steps":["trace[160988333] 'process raft request' (duration: 191.793966ms)","trace[160988333] 'compare' (duration: 250.544747ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T12:02:00.144141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T12:01:59.70121Z","time spent":"442.885845ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T12:02:00.14448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.894888ms","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-05-19T12:02:00.145167Z","caller":"traceutil/trace.go:171","msg":"trace[782547062] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5019; }","duration":"162.601962ms","start":"2026-05-19T12:01:59.982549Z","end":"2026-05-19T12:02:00.145151Z","steps":["trace[782547062] 'agreement among raft nodes before linearized reading' (duration: 161.823666ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T12:02:00.144523Z","caller":"traceutil/trace.go:171","msg":"trace[998325057] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"440.438283ms","start":"2026-05-19T12:01:59.704071Z","end":"2026-05-19T12:02:00.144509Z","steps":["trace[998325057] 'process raft request' (duration: 439.83219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T12:02:00.145304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T12:01:59.704058Z","time spent":"441.179808ms","remote":"127.0.0.1:56544","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T12:02:00.144542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.026322ms","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-05-19T12:02:00.145476Z","caller":"traceutil/trace.go:171","msg":"trace[1769831686] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5019; }","duration":"273.045224ms","start":"2026-05-19T12:01:59.872408Z","end":"2026-05-19T12:02:00.145453Z","steps":["trace[1769831686] 'agreement among raft nodes before linearized reading' (duration: 271.972661ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T12:02:00.506432Z","caller":"traceutil/trace.go:171","msg":"trace[1227698318] linearizableReadLoop","detail":"{readStateIndex:5207; appliedIndex:5206; }","duration":"143.324883ms","start":"2026-05-19T12:02:00.363074Z","end":"2026-05-19T12:02:00.506399Z","steps":["trace[1227698318] 'read index received' (duration: 65.695711ms)","trace[1227698318] 'applied index is now lower than readState.Index' (duration: 77.627652ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T12:02:00.50675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.657731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T12:02:00.506551Z","caller":"traceutil/trace.go:171","msg":"trace[1272523518] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"165.724516ms","start":"2026-05-19T12:02:00.340789Z","end":"2026-05-19T12:02:00.506514Z","steps":["trace[1272523518] 'process raft request' (duration: 88.062364ms)","trace[1272523518] 'compare' (duration: 77.306225ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T12:02:00.506814Z","caller":"traceutil/trace.go:171","msg":"trace[123705577] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:5023; }","duration":"143.770403ms","start":"2026-05-19T12:02:00.363024Z","end":"2026-05-19T12:02:00.506795Z","steps":["trace[123705577] 'agreement among raft nodes before linearized reading' (duration: 143.539677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T12:02:00.507096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.077365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T12:02:00.50714Z","caller":"traceutil/trace.go:171","msg":"trace[1339975121] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5023; }","duration":"132.156107ms","start":"2026-05-19T12:02:00.374972Z","end":"2026-05-19T12:02:00.507128Z","steps":["trace[1339975121] 'agreement among raft nodes before linearized reading' (duration: 132.093276ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T12:02:00.68861Z","caller":"traceutil/trace.go:171","msg":"trace[1775019124] linearizableReadLoop","detail":"{readStateIndex:5209; appliedIndex:5208; }","duration":"122.212076ms","start":"2026-05-19T12:02:00.566376Z","end":"2026-05-19T12:02:00.688588Z","steps":["trace[1775019124] 'read index received' (duration: 74.463295ms)","trace[1775019124] 'applied index is now lower than readState.Index' (duration: 47.748091ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T12:02:00.688646Z","caller":"traceutil/trace.go:171","msg":"trace[1234324810] transaction","detail":"{read_only:false; response_revision:5025; number_of_response:1; }","duration":"170.1271ms","start":"2026-05-19T12:02:00.518477Z","end":"2026-05-19T12:02:00.688604Z","steps":["trace[1234324810] 'process raft request' (duration: 122.41212ms)","trace[1234324810] 'compare' (duration: 47.575877ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T12:02:00.688796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.41241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-da292344-8c4d-4eb2-b5d9-582e11ef25a0\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-19T12:02:00.688827Z","caller":"traceutil/trace.go:171","msg":"trace[981380417] range","detail":"{range_begin:/registry/persistentvolumes/pvc-da292344-8c4d-4eb2-b5d9-582e11ef25a0; range_end:; response_count:1; response_revision:5025; }","duration":"122.486672ms","start":"2026-05-19T12:02:00.56633Z","end":"2026-05-19T12:02:00.688817Z","steps":["trace[981380417] 'agreement among raft nodes before linearized reading' (duration: 122.367799ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T12:03:02.567805Z","caller":"traceutil/trace.go:171","msg":"trace[2071527044] transaction","detail":"{read_only:false; response_revision:5496; number_of_response:1; }","duration":"115.025047ms","start":"2026-05-19T12:03:02.452742Z","end":"2026-05-19T12:03:02.567767Z","steps":["trace[2071527044] 'process raft request' (duration: 110.050822ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T12:03:11.239761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2960} {"level":"info","ts":"2026-05-19T12:03:11.324677Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2960,"took":"83.38893ms","hash":2061888813,"current-db-size-bytes":53198848,"current-db-size":"53 MB","current-db-size-in-use-bytes":28553216,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-19T12:03:11.324824Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2061888813,"revision":2960,"compact-revision":-1} {"level":"info","ts":"2026-05-19T12:05:47.818572Z","caller":"traceutil/trace.go:171","msg":"trace[1251148834] transaction","detail":"{read_only:false; response_revision:6671; number_of_response:1; }","duration":"107.891272ms","start":"2026-05-19T12:05:47.710649Z","end":"2026-05-19T12:05:47.81854Z","steps":["trace[1251148834] 'process raft request' (duration: 107.77147ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T12:05:47.818563Z","caller":"traceutil/trace.go:171","msg":"trace[514704530] transaction","detail":"{read_only:false; response_revision:6670; number_of_response:1; }","duration":"122.356927ms","start":"2026-05-19T12:05:47.696171Z","end":"2026-05-19T12:05:47.818528Z","steps":["trace[514704530] 'process raft request' (duration: 111.473303ms)","trace[514704530] 'compare' (duration: 10.524038ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T12:08:11.245602Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5569} {"level":"info","ts":"2026-05-19T12:08:11.315118Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5569,"took":"68.335361ms","hash":156486716,"current-db-size-bytes":53198848,"current-db-size":"53 MB","current-db-size-in-use-bytes":18542592,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-19T12:08:11.315195Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":156486716,"revision":5569,"compact-revision":2960}