{"level":"warn","ts":"2026-05-06T04:58:19.547216Z","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-06T04:58:19.547329Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.156: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.156:2380","--initial-cluster=instance=https://199.19.213.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.156: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-06T04:58:19.547478Z","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-06T04:58:19.547497Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.156:2380"]} {"level":"info","ts":"2026-05-06T04:58:19.547588Z","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-06T04:58:19.548491Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"]} {"level":"info","ts":"2026-05-06T04:58:19.550159Z","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.156:2380"],"listen-peer-urls":["https://199.19.213.156:2380"],"advertise-client-urls":["https://199.19.213.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.156: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-06T04:58:19.554431Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.572812ms"} {"level":"info","ts":"2026-05-06T04:58:19.560001Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"163ef968c92247ab","cluster-id":"59d11c119c278888"} {"level":"info","ts":"2026-05-06T04:58:19.560075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T04:58:19.560095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became follower at term 0"} {"level":"info","ts":"2026-05-06T04:58:19.560141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 163ef968c92247ab [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T04:58:19.56015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became follower at term 1"} {"level":"info","ts":"2026-05-06T04:58:19.560205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=(1602992745836857259)"} {"level":"warn","ts":"2026-05-06T04:58:19.566074Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T04:58:19.567276Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T04:58:19.569051Z","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-06T04:58:19.571264Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"163ef968c92247ab","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T04:58:19.571911Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"163ef968c92247ab","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T04:58:19.571996Z","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-06T04:58:19.572042Z","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-06T04:58:19.572057Z","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-06T04:58:19.573205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab switched to configuration voters=(1602992745836857259)"} {"level":"info","ts":"2026-05-06T04:58:19.573355Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"59d11c119c278888","local-member-id":"163ef968c92247ab","added-peer-id":"163ef968c92247ab","added-peer-peer-urls":["https://199.19.213.156:2380"]} {"level":"info","ts":"2026-05-06T04:58:19.579995Z","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-06T04:58:19.580329Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"163ef968c92247ab","initial-advertise-peer-urls":["https://199.19.213.156:2380"],"listen-peer-urls":["https://199.19.213.156:2380"],"advertise-client-urls":["https://199.19.213.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T04:58:19.580414Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T04:58:19.580563Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.156:2380"} {"level":"info","ts":"2026-05-06T04:58:19.580711Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.156:2380"} {"level":"info","ts":"2026-05-06T04:58:20.061006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T04:58:20.061072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T04:58:20.061109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab received MsgPreVoteResp from 163ef968c92247ab at term 1"} {"level":"info","ts":"2026-05-06T04:58:20.061128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became candidate at term 2"} {"level":"info","ts":"2026-05-06T04:58:20.06131Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab received MsgVoteResp from 163ef968c92247ab at term 2"} {"level":"info","ts":"2026-05-06T04:58:20.06133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"163ef968c92247ab became leader at term 2"} {"level":"info","ts":"2026-05-06T04:58:20.061344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 163ef968c92247ab elected leader 163ef968c92247ab at term 2"} {"level":"info","ts":"2026-05-06T04:58:20.062396Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:58:20.063167Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"163ef968c92247ab","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.156:2379]}","request-path":"/0/members/163ef968c92247ab/attributes","cluster-id":"59d11c119c278888","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T04:58:20.063445Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T04:58:20.063499Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T04:58:20.063598Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T04:58:20.063871Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T04:58:20.065837Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"59d11c119c278888","local-member-id":"163ef968c92247ab","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:58:20.066019Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:58:20.06619Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T04:58:20.066507Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.156:2379"} {"level":"info","ts":"2026-05-06T04:58:20.068274Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T04:58:21.560804Z","caller":"traceutil/trace.go:171","msg":"trace[343932179] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"108.049582ms","start":"2026-05-06T04:58:21.452727Z","end":"2026-05-06T04:58:21.560777Z","steps":["trace[343932179] 'read index received' (duration: 107.906351ms)","trace[343932179] 'applied index is now lower than readState.Index' (duration: 142.051µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:58:21.560848Z","caller":"traceutil/trace.go:171","msg":"trace[1014642662] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"109.717691ms","start":"2026-05-06T04:58:21.4511Z","end":"2026-05-06T04:58:21.560818Z","steps":["trace[1014642662] 'process raft request' (duration: 109.450459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.561201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.437175ms","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-06T04:58:21.561336Z","caller":"traceutil/trace.go:171","msg":"trace[1972749758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:2; }","duration":"108.569296ms","start":"2026-05-06T04:58:21.452716Z","end":"2026-05-06T04:58:21.561285Z","steps":["trace[1972749758] 'agreement among raft nodes before linearized reading' (duration: 108.246619ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:21.770292Z","caller":"traceutil/trace.go:171","msg":"trace[503736375] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"253.120025ms","start":"2026-05-06T04:58:21.51711Z","end":"2026-05-06T04:58:21.77023Z","steps":["trace[503736375] 'process raft request' (duration: 252.988104ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:21.770512Z","caller":"traceutil/trace.go:171","msg":"trace[2108394886] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"209.580213ms","start":"2026-05-06T04:58:21.560889Z","end":"2026-05-06T04:58:21.770469Z","steps":["trace[2108394886] 'read index received' (duration: 209.038468ms)","trace[2108394886] 'applied index is now lower than readState.Index' (duration: 540.445µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:58:21.770507Z","caller":"traceutil/trace.go:171","msg":"trace[949471367] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"313.703961ms","start":"2026-05-06T04:58:21.456764Z","end":"2026-05-06T04:58:21.770468Z","steps":["trace[949471367] 'process raft request' (duration: 313.185578ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:21.770653Z","caller":"traceutil/trace.go:171","msg":"trace[1277080562] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"234.533793ms","start":"2026-05-06T04:58:21.536085Z","end":"2026-05-06T04:58:21.770619Z","steps":["trace[1277080562] 'process raft request' (duration: 234.331887ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:21.770819Z","caller":"traceutil/trace.go:171","msg":"trace[1119923297] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"244.13107ms","start":"2026-05-06T04:58:21.526673Z","end":"2026-05-06T04:58:21.770804Z","steps":["trace[1119923297] 'process raft request' (duration: 243.580004ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.771065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.008173ms","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":"info","ts":"2026-05-06T04:58:21.771128Z","caller":"traceutil/trace.go:171","msg":"trace[724094433] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"245.118972ms","start":"2026-05-06T04:58:21.525991Z","end":"2026-05-06T04:58:21.77111Z","steps":["trace[724094433] 'agreement among raft nodes before linearized reading' (duration: 244.97226ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:21.771148Z","caller":"traceutil/trace.go:171","msg":"trace[690696011] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"244.931687ms","start":"2026-05-06T04:58:21.526203Z","end":"2026-05-06T04:58:21.771135Z","steps":["trace[690696011] 'process raft request' (duration: 243.965456ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:21.771125Z","caller":"traceutil/trace.go:171","msg":"trace[1354097072] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"244.687027ms","start":"2026-05-06T04:58:21.526276Z","end":"2026-05-06T04:58:21.770964Z","steps":["trace[1354097072] 'process raft request' (duration: 244.000589ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.771401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.81368ms","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-06T04:58:21.771455Z","caller":"traceutil/trace.go:171","msg":"trace[1036304335] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"245.866314ms","start":"2026-05-06T04:58:21.525577Z","end":"2026-05-06T04:58:21.771443Z","steps":["trace[1036304335] 'agreement among raft nodes before linearized reading' (duration: 245.769056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.771401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:58:21.456733Z","time spent":"314.020327ms","remote":"127.0.0.1:58190","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T04:58:21.771612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.571295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.156\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T04:58:21.771646Z","caller":"traceutil/trace.go:171","msg":"trace[960905675] range","detail":"{range_begin:/registry/masterleases/199.19.213.156; range_end:; response_count:0; response_revision:10; }","duration":"257.643431ms","start":"2026-05-06T04:58:21.513994Z","end":"2026-05-06T04:58:21.771637Z","steps":["trace[960905675] 'agreement among raft nodes before linearized reading' (duration: 257.596127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.771854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.184566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T04:58:21.7719Z","caller":"traceutil/trace.go:171","msg":"trace[1111477059] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"306.263863ms","start":"2026-05-06T04:58:21.465626Z","end":"2026-05-06T04:58:21.77189Z","steps":["trace[1111477059] 'agreement among raft nodes before linearized reading' (duration: 306.199208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.77193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:58:21.46559Z","time spent":"306.332479ms","remote":"127.0.0.1:58296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":26,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-06T04:58:21.772016Z","caller":"traceutil/trace.go:171","msg":"trace[879554932] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"244.37486ms","start":"2026-05-06T04:58:21.525961Z","end":"2026-05-06T04:58:21.770336Z","steps":["trace[879554932] 'process raft request' (duration: 244.178754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.772084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.225889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-06T04:58:21.772124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.35663ms","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-06T04:58:21.776219Z","caller":"traceutil/trace.go:171","msg":"trace[1471231714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:10; }","duration":"323.410916ms","start":"2026-05-06T04:58:21.45275Z","end":"2026-05-06T04:58:21.776161Z","steps":["trace[1471231714] 'agreement among raft nodes before linearized reading' (duration: 319.35369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.776288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:58:21.452748Z","time spent":"323.519734ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-06T04:58:21.772164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.53245ms","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-06T04:58:21.776495Z","caller":"traceutil/trace.go:171","msg":"trace[1376044566] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"199.881529ms","start":"2026-05-06T04:58:21.576602Z","end":"2026-05-06T04:58:21.776484Z","steps":["trace[1376044566] 'agreement among raft nodes before linearized reading' (duration: 195.548721ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:21.776619Z","caller":"traceutil/trace.go:171","msg":"trace[1115821577] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:10; }","duration":"323.238501ms","start":"2026-05-06T04:58:21.452844Z","end":"2026-05-06T04:58:21.776083Z","steps":["trace[1115821577] 'agreement among raft nodes before linearized reading' (duration: 319.217378ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.77233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.255978ms","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-06T04:58:21.772396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.661553ms","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-06T04:58:21.772086Z","caller":"traceutil/trace.go:171","msg":"trace[1106134395] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"245.82416ms","start":"2026-05-06T04:58:21.526238Z","end":"2026-05-06T04:58:21.772062Z","steps":["trace[1106134395] 'process raft request' (duration: 243.988528ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:21.777465Z","caller":"traceutil/trace.go:171","msg":"trace[933127489] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"160.430347ms","start":"2026-05-06T04:58:21.617019Z","end":"2026-05-06T04:58:21.777449Z","steps":["trace[933127489] 'agreement among raft nodes before linearized reading' (duration: 155.28518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:21.777573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:58:21.452842Z","time spent":"324.688002ms","remote":"127.0.0.1:58030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":0,"response size":26,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-05-06T04:58:21.777626Z","caller":"traceutil/trace.go:171","msg":"trace[691296475] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"181.971693ms","start":"2026-05-06T04:58:21.59564Z","end":"2026-05-06T04:58:21.777612Z","steps":["trace[691296475] 'agreement among raft nodes before linearized reading' (duration: 176.707837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:49.824322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.056259ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-06T04:58:49.82446Z","caller":"traceutil/trace.go:171","msg":"trace[881818212] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"265.331792ms","start":"2026-05-06T04:58:49.559108Z","end":"2026-05-06T04:58:49.82444Z","steps":["trace[881818212] 'process raft request' (duration: 65.956889ms)","trace[881818212] 'compare' (duration: 198.941504ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:58:49.843848Z","caller":"traceutil/trace.go:171","msg":"trace[380131128] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"266.21015ms","start":"2026-05-06T04:58:49.577602Z","end":"2026-05-06T04:58:49.843812Z","steps":["trace[380131128] 'process raft request' (duration: 266.108035ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.844048Z","caller":"traceutil/trace.go:171","msg":"trace[870128910] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"259.843216ms","start":"2026-05-06T04:58:49.584187Z","end":"2026-05-06T04:58:49.84403Z","steps":["trace[870128910] 'process raft request' (duration: 259.640337ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.8439Z","caller":"traceutil/trace.go:171","msg":"trace[2015549352] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"261.645853ms","start":"2026-05-06T04:58:49.582235Z","end":"2026-05-06T04:58:49.843881Z","steps":["trace[2015549352] 'process raft request' (duration: 261.512998ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.844164Z","caller":"traceutil/trace.go:171","msg":"trace[286940913] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"241.245019ms","start":"2026-05-06T04:58:49.602905Z","end":"2026-05-06T04:58:49.84415Z","steps":["trace[286940913] 'process raft request' (duration: 241.075822ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.843941Z","caller":"traceutil/trace.go:171","msg":"trace[1089319473] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"261.103311ms","start":"2026-05-06T04:58:49.582808Z","end":"2026-05-06T04:58:49.843911Z","steps":["trace[1089319473] 'process raft request' (duration: 260.966415ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.84383Z","caller":"traceutil/trace.go:171","msg":"trace[1019960640] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"276.075112ms","start":"2026-05-06T04:58:49.567702Z","end":"2026-05-06T04:58:49.843777Z","steps":["trace[1019960640] 'process raft request' (duration: 275.914965ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.844718Z","caller":"traceutil/trace.go:171","msg":"trace[1106344349] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"236.907522ms","start":"2026-05-06T04:58:49.607172Z","end":"2026-05-06T04:58:49.84408Z","steps":["trace[1106344349] 'process raft request' (duration: 236.877971ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.867377Z","caller":"traceutil/trace.go:171","msg":"trace[189759099] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"242.367838ms","start":"2026-05-06T04:58:49.624983Z","end":"2026-05-06T04:58:49.867351Z","steps":["trace[189759099] 'process raft request' (duration: 242.146448ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.867557Z","caller":"traceutil/trace.go:171","msg":"trace[1479466604] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"234.955318ms","start":"2026-05-06T04:58:49.632576Z","end":"2026-05-06T04:58:49.867531Z","steps":["trace[1479466604] 'process raft request' (duration: 234.661196ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.867696Z","caller":"traceutil/trace.go:171","msg":"trace[1167478724] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"212.803559ms","start":"2026-05-06T04:58:49.654871Z","end":"2026-05-06T04:58:49.867675Z","steps":["trace[1167478724] 'process raft request' (duration: 212.426633ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:49.869652Z","caller":"traceutil/trace.go:171","msg":"trace[1914056287] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:486; }","duration":"128.783685ms","start":"2026-05-06T04:58:49.740701Z","end":"2026-05-06T04:58:49.869485Z","steps":["trace[1914056287] 'read index received' (duration: 103.009919ms)","trace[1914056287] 'applied index is now lower than readState.Index' (duration: 25.772336ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T04:58:49.870177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.462445ms","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-05-06T04:58:49.87029Z","caller":"traceutil/trace.go:171","msg":"trace[1301021670] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:482; }","duration":"129.576219ms","start":"2026-05-06T04:58:49.740658Z","end":"2026-05-06T04:58:49.870234Z","steps":["trace[1301021670] 'agreement among raft nodes before linearized reading' (duration: 129.265706ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:50.119123Z","caller":"traceutil/trace.go:171","msg":"trace[2035339242] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"186.162145ms","start":"2026-05-06T04:58:49.932889Z","end":"2026-05-06T04:58:50.119051Z","steps":["trace[2035339242] 'process raft request' (duration: 154.042456ms)","trace[2035339242] 'compare' (duration: 31.919561ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:58:50.119466Z","caller":"traceutil/trace.go:171","msg":"trace[882298095] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"170.776415ms","start":"2026-05-06T04:58:49.948658Z","end":"2026-05-06T04:58:50.119434Z","steps":["trace[882298095] 'process raft request' (duration: 170.333506ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:50.119895Z","caller":"traceutil/trace.go:171","msg":"trace[746278866] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"171.084928ms","start":"2026-05-06T04:58:49.94878Z","end":"2026-05-06T04:58:50.119865Z","steps":["trace[746278866] 'process raft request' (duration: 170.540476ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:50.120084Z","caller":"traceutil/trace.go:171","msg":"trace[413950594] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:512; }","duration":"175.382282ms","start":"2026-05-06T04:58:49.944678Z","end":"2026-05-06T04:58:50.12006Z","steps":["trace[413950594] 'read index received' (duration: 82.622815ms)","trace[413950594] 'applied index is now lower than readState.Index' (duration: 92.758227ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:58:50.12021Z","caller":"traceutil/trace.go:171","msg":"trace[1335713478] transaction","detail":"{read_only:false; number_of_response:1; response_revision:497; }","duration":"167.539946ms","start":"2026-05-06T04:58:49.952658Z","end":"2026-05-06T04:58:50.120198Z","steps":["trace[1335713478] 'process raft request' (duration: 167.131949ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:50.120687Z","caller":"traceutil/trace.go:171","msg":"trace[2144864247] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"116.601491ms","start":"2026-05-06T04:58:50.004067Z","end":"2026-05-06T04:58:50.120669Z","steps":["trace[2144864247] 'process raft request' (duration: 115.811708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:50.120695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.986088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:30408"} {"level":"info","ts":"2026-05-06T04:58:50.120778Z","caller":"traceutil/trace.go:171","msg":"trace[821287504] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:498; }","duration":"176.085143ms","start":"2026-05-06T04:58:49.944672Z","end":"2026-05-06T04:58:50.120757Z","steps":["trace[821287504] 'agreement among raft nodes before linearized reading' (duration: 175.841812ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:55.463927Z","caller":"traceutil/trace.go:171","msg":"trace[499577657] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"122.327574ms","start":"2026-05-06T04:58:55.34157Z","end":"2026-05-06T04:58:55.463898Z","steps":["trace[499577657] 'process raft request' (duration: 122.150957ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:55.621422Z","caller":"traceutil/trace.go:171","msg":"trace[159000719] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"141.786055ms","start":"2026-05-06T04:58:55.479591Z","end":"2026-05-06T04:58:55.621377Z","steps":["trace[159000719] 'process raft request' (duration: 137.827904ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:56.076692Z","caller":"traceutil/trace.go:171","msg":"trace[302454746] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"134.048828ms","start":"2026-05-06T04:58:55.942621Z","end":"2026-05-06T04:58:56.07667Z","steps":["trace[302454746] 'read index received' (duration: 133.845661ms)","trace[302454746] 'applied index is now lower than readState.Index' (duration: 202.337µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T04:58:56.077105Z","caller":"traceutil/trace.go:171","msg":"trace[206013893] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"169.679953ms","start":"2026-05-06T04:58:55.907416Z","end":"2026-05-06T04:58:56.077096Z","steps":["trace[206013893] 'process raft request' (duration: 169.121893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:56.07748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.848408ms","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-05-06T04:58:56.077514Z","caller":"traceutil/trace.go:171","msg":"trace[513758345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:576; }","duration":"134.935211ms","start":"2026-05-06T04:58:55.942571Z","end":"2026-05-06T04:58:56.077506Z","steps":["trace[513758345] 'agreement among raft nodes before linearized reading' (duration: 134.858409ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T04:58:56.238888Z","caller":"traceutil/trace.go:171","msg":"trace[560596511] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"108.391856ms","start":"2026-05-06T04:58:56.130451Z","end":"2026-05-06T04:58:56.238843Z","steps":["trace[560596511] 'process raft request' (duration: 107.157821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T04:58:56.759949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.580882ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-06T04:58:56.760151Z","caller":"traceutil/trace.go:171","msg":"trace[628126546] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"461.236427ms","start":"2026-05-06T04:58:56.298833Z","end":"2026-05-06T04:58:56.76007Z","steps":["trace[628126546] 'process raft request' (duration: 78.410897ms)","trace[628126546] 'compare' (duration: 382.412975ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T04:58:56.760266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T04:58:56.298795Z","time spent":"461.421503ms","remote":"127.0.0.1:58420","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T05:00:33.930509Z","caller":"traceutil/trace.go:171","msg":"trace[131044754] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"148.787069ms","start":"2026-05-06T05:00:33.78169Z","end":"2026-05-06T05:00:33.930477Z","steps":["trace[131044754] 'process raft request' (duration: 148.586664ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:33.937503Z","caller":"traceutil/trace.go:171","msg":"trace[1558206809] transaction","detail":"{read_only:false; response_revision:1829; number_of_response:1; }","duration":"130.977242ms","start":"2026-05-06T05:00:33.806501Z","end":"2026-05-06T05:00:33.937478Z","steps":["trace[1558206809] 'process raft request' (duration: 130.818088ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:34.357168Z","caller":"traceutil/trace.go:171","msg":"trace[1112412455] transaction","detail":"{read_only:false; response_revision:1830; number_of_response:1; }","duration":"135.393991ms","start":"2026-05-06T05:00:34.221749Z","end":"2026-05-06T05:00:34.357143Z","steps":["trace[1112412455] 'process raft request' (duration: 135.193676ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:34.367694Z","caller":"traceutil/trace.go:171","msg":"trace[1270481680] transaction","detail":"{read_only:false; response_revision:1831; number_of_response:1; }","duration":"145.511893ms","start":"2026-05-06T05:00:34.222153Z","end":"2026-05-06T05:00:34.367665Z","steps":["trace[1270481680] 'process raft request' (duration: 145.306167ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:48.516712Z","caller":"traceutil/trace.go:171","msg":"trace[590517468] transaction","detail":"{read_only:false; response_revision:1942; number_of_response:1; }","duration":"132.237228ms","start":"2026-05-06T05:00:48.384436Z","end":"2026-05-06T05:00:48.516674Z","steps":["trace[590517468] 'process raft request' (duration: 131.716235ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:00:48.77427Z","caller":"traceutil/trace.go:171","msg":"trace[572855138] transaction","detail":"{read_only:false; response_revision:1945; number_of_response:1; }","duration":"247.078761ms","start":"2026-05-06T05:00:48.527156Z","end":"2026-05-06T05:00:48.774235Z","steps":["trace[572855138] 'process raft request' (duration: 210.275058ms)","trace[572855138] 'compare' (duration: 36.663119ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:01:25.302299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.142483ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:01:25.302468Z","caller":"traceutil/trace.go:171","msg":"trace[1661529988] linearizableReadLoop","detail":"{readStateIndex:2233; appliedIndex:2232; }","duration":"221.617861ms","start":"2026-05-06T05:01:25.080824Z","end":"2026-05-06T05:01:25.302442Z","steps":["trace[1661529988] 'read index received' (duration: 114.002099ms)","trace[1661529988] 'applied index is now lower than readState.Index' (duration: 107.614052ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:01:25.302523Z","caller":"traceutil/trace.go:171","msg":"trace[586441256] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"277.199052ms","start":"2026-05-06T05:01:25.025294Z","end":"2026-05-06T05:01:25.302493Z","steps":["trace[586441256] 'process raft request' (duration: 169.552029ms)","trace[586441256] 'compare' (duration: 106.828415ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:01:25.302803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.376921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:01:25.302953Z","caller":"traceutil/trace.go:171","msg":"trace[1967717070] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:2152; }","duration":"104.596956ms","start":"2026-05-06T05:01:25.198339Z","end":"2026-05-06T05:01:25.302936Z","steps":["trace[1967717070] 'agreement among raft nodes before linearized reading' (duration: 104.379871ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:25.303447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.611623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-06T05:01:25.303535Z","caller":"traceutil/trace.go:171","msg":"trace[1073700539] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2152; }","duration":"222.758116ms","start":"2026-05-06T05:01:25.08076Z","end":"2026-05-06T05:01:25.303519Z","steps":["trace[1073700539] 'agreement among raft nodes before linearized reading' (duration: 221.792206ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:25.669976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.469571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:01:25.670213Z","caller":"traceutil/trace.go:171","msg":"trace[1183472629] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2233; }","duration":"282.626069ms","start":"2026-05-06T05:01:25.387571Z","end":"2026-05-06T05:01:25.670197Z","steps":["trace[1183472629] 'read index received' (duration: 53.677398ms)","trace[1183472629] 'applied index is now lower than readState.Index' (duration: 228.947671ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:01:25.670249Z","caller":"traceutil/trace.go:171","msg":"trace[1894534568] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"362.243351ms","start":"2026-05-06T05:01:25.30798Z","end":"2026-05-06T05:01:25.670223Z","steps":["trace[1894534568] 'process raft request' (duration: 133.427742ms)","trace[1894534568] 'compare' (duration: 227.91783ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:01:25.670304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.737421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T05:01:25.670334Z","caller":"traceutil/trace.go:171","msg":"trace[2021699861] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:2155; }","duration":"282.770222ms","start":"2026-05-06T05:01:25.387553Z","end":"2026-05-06T05:01:25.670324Z","steps":["trace[2021699861] 'agreement among raft nodes before linearized reading' (duration: 282.6958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:25.670371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:01:25.307956Z","time spent":"362.358893ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:01:25.67043Z","caller":"traceutil/trace.go:171","msg":"trace[815153937] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"338.088916ms","start":"2026-05-06T05:01:25.332311Z","end":"2026-05-06T05:01:25.6704Z","steps":["trace[815153937] 'process raft request' (duration: 337.779889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:25.670581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:01:25.332284Z","time spent":"338.211639ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:01:25.670601Z","caller":"traceutil/trace.go:171","msg":"trace[238368329] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"332.596166ms","start":"2026-05-06T05:01:25.337993Z","end":"2026-05-06T05:01:25.670589Z","steps":["trace[238368329] 'process raft request' (duration: 332.171177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:01:25.670731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T05:01:25.337962Z","time spent":"332.683958ms","remote":"127.0.0.1:58194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T05:02:46.236042Z","caller":"traceutil/trace.go:171","msg":"trace[466024955] linearizableReadLoop","detail":"{readStateIndex:2797; appliedIndex:2796; }","duration":"113.740525ms","start":"2026-05-06T05:02:46.122271Z","end":"2026-05-06T05:02:46.236012Z","steps":["trace[466024955] 'read index received' (duration: 98.339914ms)","trace[466024955] 'applied index is now lower than readState.Index' (duration: 15.399051ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:02:46.236158Z","caller":"traceutil/trace.go:171","msg":"trace[1427922735] transaction","detail":"{read_only:false; response_revision:2697; number_of_response:1; }","duration":"169.104304ms","start":"2026-05-06T05:02:46.067023Z","end":"2026-05-06T05:02:46.236127Z","steps":["trace[1427922735] 'process raft request' (duration: 153.671052ms)","trace[1427922735] 'compare' (duration: 14.991413ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:02:46.236314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.617341ms","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-05-06T05:02:46.236355Z","caller":"traceutil/trace.go:171","msg":"trace[2043994836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2697; }","duration":"142.713122ms","start":"2026-05-06T05:02:46.093632Z","end":"2026-05-06T05:02:46.236345Z","steps":["trace[2043994836] 'agreement among raft nodes before linearized reading' (duration: 142.537979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.16252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.81787ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:06:52.162758Z","caller":"traceutil/trace.go:171","msg":"trace[1808984863] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"148.454691ms","start":"2026-05-06T05:06:52.014249Z","end":"2026-05-06T05:06:52.162704Z","steps":["trace[1808984863] 'process raft request' (duration: 148.376399ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:52.16275Z","caller":"traceutil/trace.go:171","msg":"trace[1913250994] linearizableReadLoop","detail":"{readStateIndex:4926; appliedIndex:4925; }","duration":"167.94721ms","start":"2026-05-06T05:06:51.994781Z","end":"2026-05-06T05:06:52.162729Z","steps":["trace[1913250994] 'read index received' (duration: 44.989108ms)","trace[1913250994] 'applied index is now lower than readState.Index' (duration: 122.956102ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:52.162836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.88959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194901"} {"level":"info","ts":"2026-05-06T05:06:52.162916Z","caller":"traceutil/trace.go:171","msg":"trace[286280677] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4745; }","duration":"172.013312ms","start":"2026-05-06T05:06:51.990886Z","end":"2026-05-06T05:06:52.1629Z","steps":["trace[286280677] 'range keys from in-memory index tree' (duration: 170.905939ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:52.162733Z","caller":"traceutil/trace.go:171","msg":"trace[735392704] transaction","detail":"{read_only:false; response_revision:4746; number_of_response:1; }","duration":"171.606854ms","start":"2026-05-06T05:06:51.991086Z","end":"2026-05-06T05:06:52.162693Z","steps":["trace[735392704] 'process raft request' (duration: 48.548499ms)","trace[735392704] 'compare' (duration: 122.475483ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:52.163023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.593316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-05-06T05:06:52.163048Z","caller":"traceutil/trace.go:171","msg":"trace[509526098] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:4747; }","duration":"121.638127ms","start":"2026-05-06T05:06:52.041401Z","end":"2026-05-06T05:06:52.163039Z","steps":["trace[509526098] 'agreement among raft nodes before linearized reading' (duration: 121.592216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.162972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.174505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-05-06T05:06:52.163312Z","caller":"traceutil/trace.go:171","msg":"trace[1828804642] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4747; }","duration":"168.531252ms","start":"2026-05-06T05:06:51.994766Z","end":"2026-05-06T05:06:52.163298Z","steps":["trace[1828804642] 'agreement among raft nodes before linearized reading' (duration: 168.080813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.505871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.018024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T05:06:52.506106Z","caller":"traceutil/trace.go:171","msg":"trace[192179810] linearizableReadLoop","detail":"{readStateIndex:4932; appliedIndex:4931; }","duration":"138.875929ms","start":"2026-05-06T05:06:52.36711Z","end":"2026-05-06T05:06:52.505986Z","steps":["trace[192179810] 'read index received' (duration: 10.61926ms)","trace[192179810] 'applied index is now lower than readState.Index' (duration: 128.253519ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:52.506307Z","caller":"traceutil/trace.go:171","msg":"trace[1246192163] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"141.520042ms","start":"2026-05-06T05:06:52.364723Z","end":"2026-05-06T05:06:52.506243Z","steps":["trace[1246192163] 'process raft request' (duration: 12.998518ms)","trace[1246192163] 'compare' (duration: 127.829221ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:52.506592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.469472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-06T05:06:52.506657Z","caller":"traceutil/trace.go:171","msg":"trace[20467257] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4752; }","duration":"139.551294ms","start":"2026-05-06T05:06:52.367092Z","end":"2026-05-06T05:06:52.506644Z","steps":["trace[20467257] 'agreement among raft nodes before linearized reading' (duration: 139.340019ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:52.542167Z","caller":"traceutil/trace.go:171","msg":"trace[2045311130] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"174.783176ms","start":"2026-05-06T05:06:52.367356Z","end":"2026-05-06T05:06:52.542139Z","steps":["trace[2045311130] 'process raft request' (duration: 174.348068ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:52.695589Z","caller":"traceutil/trace.go:171","msg":"trace[274816567] linearizableReadLoop","detail":"{readStateIndex:4934; appliedIndex:4933; }","duration":"142.923781ms","start":"2026-05-06T05:06:52.552639Z","end":"2026-05-06T05:06:52.695563Z","steps":["trace[274816567] 'read index received' (duration: 62.584198ms)","trace[274816567] 'applied index is now lower than readState.Index' (duration: 80.338203ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T05:06:52.695717Z","caller":"traceutil/trace.go:171","msg":"trace[1963558465] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"143.086314ms","start":"2026-05-06T05:06:52.552619Z","end":"2026-05-06T05:06:52.695705Z","steps":["trace[1963558465] 'process raft request' (duration: 62.586689ms)","trace[1963558465] 'compare' (duration: 80.132488ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T05:06:52.695854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.198296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"info","ts":"2026-05-06T05:06:52.695916Z","caller":"traceutil/trace.go:171","msg":"trace[1244664298] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4754; }","duration":"143.298138ms","start":"2026-05-06T05:06:52.552602Z","end":"2026-05-06T05:06:52.6959Z","steps":["trace[1244664298] 'agreement among raft nodes before linearized reading' (duration: 143.133665ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:52.697161Z","caller":"traceutil/trace.go:171","msg":"trace[1454995599] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"144.418891ms","start":"2026-05-06T05:06:52.552689Z","end":"2026-05-06T05:06:52.697108Z","steps":["trace[1454995599] 'process raft request' (duration: 143.613184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.697399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.406581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194901"} {"level":"info","ts":"2026-05-06T05:06:52.697464Z","caller":"traceutil/trace.go:171","msg":"trace[118024476] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4758; }","duration":"138.523964ms","start":"2026-05-06T05:06:52.558925Z","end":"2026-05-06T05:06:52.697449Z","steps":["trace[118024476] 'agreement among raft nodes before linearized reading' (duration: 137.535483ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:52.697889Z","caller":"traceutil/trace.go:171","msg":"trace[224163982] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"145.226667ms","start":"2026-05-06T05:06:52.552647Z","end":"2026-05-06T05:06:52.697874Z","steps":["trace[224163982] 'process raft request' (duration: 143.528803ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:52.698062Z","caller":"traceutil/trace.go:171","msg":"trace[1743674675] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"145.362089ms","start":"2026-05-06T05:06:52.552673Z","end":"2026-05-06T05:06:52.698035Z","steps":["trace[1743674675] 'process raft request' (duration: 143.677215ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:06:52.698143Z","caller":"traceutil/trace.go:171","msg":"trace[1600059720] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"145.274288ms","start":"2026-05-06T05:06:52.55286Z","end":"2026-05-06T05:06:52.698134Z","steps":["trace[1600059720] 'process raft request' (duration: 143.559953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T05:06:52.698334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.175636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-05-06T05:06:52.698359Z","caller":"traceutil/trace.go:171","msg":"trace[2133054269] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4758; }","duration":"129.225597ms","start":"2026-05-06T05:06:52.569128Z","end":"2026-05-06T05:06:52.698353Z","steps":["trace[2133054269] 'agreement among raft nodes before linearized reading' (duration: 129.146306ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:07:04.532808Z","caller":"traceutil/trace.go:171","msg":"trace[618719474] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"154.161495ms","start":"2026-05-06T05:07:04.378623Z","end":"2026-05-06T05:07:04.532785Z","steps":["trace[618719474] 'process raft request' (duration: 153.982681ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T05:08:20.093833Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2877} {"level":"info","ts":"2026-05-06T05:08:20.186906Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2877,"took":"91.603877ms","hash":3129746202,"current-db-size-bytes":53473280,"current-db-size":"54 MB","current-db-size-in-use-bytes":29016064,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-06T05:08:20.186966Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3129746202,"revision":2877,"compact-revision":-1} {"level":"info","ts":"2026-05-06T05:13:20.103074Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5549} {"level":"info","ts":"2026-05-06T05:13:20.175811Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5549,"took":"71.257899ms","hash":1428128477,"current-db-size-bytes":53473280,"current-db-size":"54 MB","current-db-size-in-use-bytes":18333696,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-06T05:13:20.17586Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1428128477,"revision":5549,"compact-revision":2877}