{"level":"warn","ts":"2026-05-10T03:56:52.171064Z","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-10T03:56:52.171141Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.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.204.45.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.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-10T03:56:52.171205Z","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-10T03:56:52.171214Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-10T03:56:52.171242Z","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-10T03:56:52.172105Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-05-10T03:56:52.172207Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.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-10T03:56:52.178452Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.016973ms"} {"level":"info","ts":"2026-05-10T03:56:52.19099Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-05-10T03:56:52.191092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-05-10T03:56:52.19112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-05-10T03:56:52.191134Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-10T03:56:52.191148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-05-10T03:56:52.191206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-05-10T03:56:52.203468Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-10T03:56:52.204963Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-10T03:56:52.206218Z","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-10T03:56:52.209569Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-10T03:56:52.20976Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-10T03:56:52.209878Z","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-10T03:56:52.209993Z","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-10T03:56:52.210007Z","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-10T03:56:52.212304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-05-10T03:56:52.212494Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-05-10T03:56:52.217087Z","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-10T03:56:52.217259Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-10T03:56:52.219744Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-05-10T03:56:52.219929Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-10T03:56:52.219992Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-10T03:56:52.793039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-05-10T03:56:52.793122Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-10T03:56:52.793168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-05-10T03:56:52.793191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-05-10T03:56:52.79321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-10T03:56:52.793229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-05-10T03:56:52.793249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-05-10T03:56:52.794401Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T03:56:52.795496Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T03:56:52.795624Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-10T03:56:52.798856Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-10T03:56:52.79897Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-05-10T03:56:52.799681Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T03:56:52.799837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T03:56:52.79988Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-10T03:56:52.799997Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-10T03:56:52.800018Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-10T03:56:52.795451Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-10T03:56:54.331853Z","caller":"traceutil/trace.go:171","msg":"trace[874140327] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"251.836218ms","start":"2026-05-10T03:56:54.079987Z","end":"2026-05-10T03:56:54.331823Z","steps":["trace[874140327] 'process raft request' (duration: 250.552277ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.784189Z","caller":"traceutil/trace.go:171","msg":"trace[1893408344] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"704.029322ms","start":"2026-05-10T03:56:54.080103Z","end":"2026-05-10T03:56:54.784133Z","steps":["trace[1893408344] 'process raft request' (duration: 703.684459ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.784572Z","caller":"traceutil/trace.go:171","msg":"trace[210876893] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"703.245055ms","start":"2026-05-10T03:56:54.081303Z","end":"2026-05-10T03:56:54.784548Z","steps":["trace[210876893] 'process raft request' (duration: 702.6153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.784768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.080087Z","time spent":"704.202843ms","remote":"127.0.0.1:41676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:56:54.785199Z","caller":"traceutil/trace.go:171","msg":"trace[1229146570] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"702.072966ms","start":"2026-05-10T03:56:54.083102Z","end":"2026-05-10T03:56:54.785175Z","steps":["trace[1229146570] 'process raft request' (duration: 701.133717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.785287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.083092Z","time spent":"702.157346ms","remote":"127.0.0.1:41576","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T03:56:54.78577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.08129Z","time spent":"703.421577ms","remote":"127.0.0.1:41458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":36,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:56:54.785917Z","caller":"traceutil/trace.go:171","msg":"trace[210640115] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"702.449808ms","start":"2026-05-10T03:56:54.083448Z","end":"2026-05-10T03:56:54.785898Z","steps":["trace[210640115] 'process raft request' (duration: 700.879675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.785996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.083437Z","time spent":"702.519759ms","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:56:54.786511Z","caller":"traceutil/trace.go:171","msg":"trace[840772944] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"702.61248ms","start":"2026-05-10T03:56:54.083885Z","end":"2026-05-10T03:56:54.786498Z","steps":["trace[840772944] 'process raft request' (duration: 701.893834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.786583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.083878Z","time spent":"702.671971ms","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:56:54.78678Z","caller":"traceutil/trace.go:171","msg":"trace[1414767761] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"702.49109ms","start":"2026-05-10T03:56:54.084269Z","end":"2026-05-10T03:56:54.78676Z","steps":["trace[1414767761] 'process raft request' (duration: 701.993165ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.786799Z","caller":"traceutil/trace.go:171","msg":"trace[2006916395] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"702.612511ms","start":"2026-05-10T03:56:54.084153Z","end":"2026-05-10T03:56:54.786765Z","steps":["trace[2006916395] 'process raft request' (duration: 702.067336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.786845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.084263Z","time spent":"702.55271ms","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T03:56:54.786947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.084147Z","time spent":"702.729492ms","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:56:54.787061Z","caller":"traceutil/trace.go:171","msg":"trace[503468359] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"701.438709ms","start":"2026-05-10T03:56:54.085613Z","end":"2026-05-10T03:56:54.787052Z","steps":["trace[503468359] 'process raft request' (duration: 700.728623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.787176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.085606Z","time spent":"701.541371ms","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:56:54.787284Z","caller":"traceutil/trace.go:171","msg":"trace[929069586] linearizableReadLoop","detail":"{readStateIndex:8; appliedIndex:5; }","duration":"703.895281ms","start":"2026-05-10T03:56:54.083358Z","end":"2026-05-10T03:56:54.787253Z","steps":["trace[929069586] 'read index received' (duration: 251.283064ms)","trace[929069586] 'applied index is now lower than readState.Index' (duration: 452.611257ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:56:54.787535Z","caller":"traceutil/trace.go:171","msg":"trace[972300604] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"629.205158ms","start":"2026-05-10T03:56:54.158309Z","end":"2026-05-10T03:56:54.787514Z","steps":["trace[972300604] 'process raft request' (duration: 628.111479ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.788767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.158285Z","time spent":"630.411879ms","remote":"127.0.0.1:41894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T03:56:54.788949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.365154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-05-10T03:56:54.788988Z","caller":"traceutil/trace.go:171","msg":"trace[334461270] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"705.410504ms","start":"2026-05-10T03:56:54.083566Z","end":"2026-05-10T03:56:54.788976Z","steps":["trace[334461270] 'agreement among raft nodes before linearized reading' (duration: 705.349993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.789018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.083561Z","time spent":"705.450344ms","remote":"127.0.0.1:41576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-10T03:56:54.787741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.339695ms","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-10T03:56:54.789142Z","caller":"traceutil/trace.go:171","msg":"trace[437769001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:11; }","duration":"705.792467ms","start":"2026-05-10T03:56:54.083341Z","end":"2026-05-10T03:56:54.789133Z","steps":["trace[437769001] 'agreement among raft nodes before linearized reading' (duration: 704.243994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.789171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.083333Z","time spent":"705.831047ms","remote":"127.0.0.1:41692","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-10T03:56:54.789321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.688972ms","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-10T03:56:54.789347Z","caller":"traceutil/trace.go:171","msg":"trace[763712802] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"579.733622ms","start":"2026-05-10T03:56:54.209605Z","end":"2026-05-10T03:56:54.789339Z","steps":["trace[763712802] 'agreement among raft nodes before linearized reading' (duration: 579.688062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.789373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.209593Z","time spent":"579.773772ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-10T03:56:54.789707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.169917ms","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-10T03:56:54.789771Z","caller":"traceutil/trace.go:171","msg":"trace[325656965] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"629.244147ms","start":"2026-05-10T03:56:54.160515Z","end":"2026-05-10T03:56:54.789759Z","steps":["trace[325656965] 'agreement among raft nodes before linearized reading' (duration: 629.159647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.790217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.495138ms","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-10T03:56:54.790262Z","caller":"traceutil/trace.go:171","msg":"trace[1304985158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:11; }","duration":"703.570349ms","start":"2026-05-10T03:56:54.08668Z","end":"2026-05-10T03:56:54.79025Z","steps":["trace[1304985158] 'agreement among raft nodes before linearized reading' (duration: 703.490618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.790428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.086674Z","time spent":"703.740901ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":26,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T03:56:54.790683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.264843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-10T03:56:54.790706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.048285ms","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-10T03:56:54.790772Z","caller":"traceutil/trace.go:171","msg":"trace[1908242439] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"659.145637ms","start":"2026-05-10T03:56:54.131613Z","end":"2026-05-10T03:56:54.790759Z","steps":["trace[1908242439] 'agreement among raft nodes before linearized reading' (duration: 659.046376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.790797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.131593Z","time spent":"659.197927ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-10T03:56:54.790855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.504476ms","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-10T03:56:54.79091Z","caller":"traceutil/trace.go:171","msg":"trace[1393524040] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"633.553476ms","start":"2026-05-10T03:56:54.15733Z","end":"2026-05-10T03:56:54.790883Z","steps":["trace[1393524040] 'agreement among raft nodes before linearized reading' (duration: 633.502445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.790931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.157321Z","time spent":"633.605126ms","remote":"127.0.0.1:41510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":26,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-10T03:56:54.790722Z","caller":"traceutil/trace.go:171","msg":"trace[720983167] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:0; response_revision:11; }","duration":"633.303423ms","start":"2026-05-10T03:56:54.157409Z","end":"2026-05-10T03:56:54.790712Z","steps":["trace[720983167] 'agreement among raft nodes before linearized reading' (duration: 633.248713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.791023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.157388Z","time spent":"633.630726ms","remote":"127.0.0.1:41424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":26,"request content":"key:\"/registry/masterleases/199.204.45.156\" "} {"level":"warn","ts":"2026-05-10T03:56:54.79155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:56:54.16051Z","time spent":"631.027273ms","remote":"127.0.0.1:41478","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":26,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-05-10T03:56:54.944361Z","caller":"traceutil/trace.go:171","msg":"trace[2021329603] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"153.697743ms","start":"2026-05-10T03:56:54.790647Z","end":"2026-05-10T03:56:54.944345Z","steps":["trace[2021329603] 'process raft request' (duration: 152.692895ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.945495Z","caller":"traceutil/trace.go:171","msg":"trace[1826861686] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"154.076457ms","start":"2026-05-10T03:56:54.791385Z","end":"2026-05-10T03:56:54.945462Z","steps":["trace[1826861686] 'process raft request' (duration: 153.844425ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.945487Z","caller":"traceutil/trace.go:171","msg":"trace[904875327] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"154.046277ms","start":"2026-05-10T03:56:54.791399Z","end":"2026-05-10T03:56:54.945446Z","steps":["trace[904875327] 'process raft request' (duration: 153.921906ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.94569Z","caller":"traceutil/trace.go:171","msg":"trace[1818768803] linearizableReadLoop","detail":"{readStateIndex:19; appliedIndex:14; }","duration":"152.14603ms","start":"2026-05-10T03:56:54.793492Z","end":"2026-05-10T03:56:54.945638Z","steps":["trace[1818768803] 'read index received' (duration: 149.80571ms)","trace[1818768803] 'applied index is now lower than readState.Index' (duration: 2.33928ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:56:54.945736Z","caller":"traceutil/trace.go:171","msg":"trace[2065445844] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"152.020499ms","start":"2026-05-10T03:56:54.793705Z","end":"2026-05-10T03:56:54.945726Z","steps":["trace[2065445844] 'process raft request' (duration: 151.749197ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.945805Z","caller":"traceutil/trace.go:171","msg":"trace[732442626] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"152.305142ms","start":"2026-05-10T03:56:54.79349Z","end":"2026-05-10T03:56:54.945796Z","steps":["trace[732442626] 'process raft request' (duration: 151.935339ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.945791Z","caller":"traceutil/trace.go:171","msg":"trace[823061942] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"152.030209ms","start":"2026-05-10T03:56:54.793751Z","end":"2026-05-10T03:56:54.945781Z","steps":["trace[823061942] 'process raft request' (duration: 151.756976ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.945711Z","caller":"traceutil/trace.go:171","msg":"trace[191494653] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"152.345352ms","start":"2026-05-10T03:56:54.793356Z","end":"2026-05-10T03:56:54.945702Z","steps":["trace[191494653] 'process raft request' (duration: 152.035989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:56:54.94605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.545804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-10T03:56:54.946087Z","caller":"traceutil/trace.go:171","msg":"trace[1079593057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20; }","duration":"152.603054ms","start":"2026-05-10T03:56:54.793473Z","end":"2026-05-10T03:56:54.946076Z","steps":["trace[1079593057] 'agreement among raft nodes before linearized reading' (duration: 152.483543ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.946149Z","caller":"traceutil/trace.go:171","msg":"trace[746099677] transaction","detail":"{read_only:false; number_of_response:0; response_revision:19; }","duration":"151.026211ms","start":"2026-05-10T03:56:54.795114Z","end":"2026-05-10T03:56:54.94614Z","steps":["trace[746099677] 'process raft request' (duration: 150.417546ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.946229Z","caller":"traceutil/trace.go:171","msg":"trace[1481244344] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"150.342475ms","start":"2026-05-10T03:56:54.795878Z","end":"2026-05-10T03:56:54.94622Z","steps":["trace[1481244344] 'process raft request' (duration: 149.6879ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:54.94561Z","caller":"traceutil/trace.go:171","msg":"trace[593799459] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"154.124107ms","start":"2026-05-10T03:56:54.791472Z","end":"2026-05-10T03:56:54.945596Z","steps":["trace[593799459] 'process raft request' (duration: 153.879905ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:58.112267Z","caller":"traceutil/trace.go:171","msg":"trace[1245669638] transaction","detail":"{read_only:false; number_of_response:0; response_revision:236; }","duration":"184.486539ms","start":"2026-05-10T03:56:57.927756Z","end":"2026-05-10T03:56:58.112243Z","steps":["trace[1245669638] 'process raft request' (duration: 184.348468ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:58.112321Z","caller":"traceutil/trace.go:171","msg":"trace[1502763708] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"196.394007ms","start":"2026-05-10T03:56:57.915852Z","end":"2026-05-10T03:56:58.112246Z","steps":["trace[1502763708] 'process raft request' (duration: 168.263007ms)","trace[1502763708] 'compare' (duration: 27.838128ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:56:58.112399Z","caller":"traceutil/trace.go:171","msg":"trace[219134414] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"144.725528ms","start":"2026-05-10T03:56:57.967645Z","end":"2026-05-10T03:56:58.11237Z","steps":["trace[219134414] 'process raft request' (duration: 144.688278ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:58.112596Z","caller":"traceutil/trace.go:171","msg":"trace[653716114] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"182.552033ms","start":"2026-05-10T03:56:57.930027Z","end":"2026-05-10T03:56:58.112579Z","steps":["trace[653716114] 'process raft request' (duration: 182.24972ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:58.112736Z","caller":"traceutil/trace.go:171","msg":"trace[1494959021] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"182.518983ms","start":"2026-05-10T03:56:57.930203Z","end":"2026-05-10T03:56:58.112722Z","steps":["trace[1494959021] 'process raft request' (duration: 182.101089ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:58.112802Z","caller":"traceutil/trace.go:171","msg":"trace[1973304415] transaction","detail":"{read_only:false; number_of_response:0; response_revision:236; }","duration":"184.58803ms","start":"2026-05-10T03:56:57.928129Z","end":"2026-05-10T03:56:58.112717Z","steps":["trace[1973304415] 'process raft request' (duration: 184.016264ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:58.112831Z","caller":"traceutil/trace.go:171","msg":"trace[1188829033] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"183.242649ms","start":"2026-05-10T03:56:57.92956Z","end":"2026-05-10T03:56:58.112803Z","steps":["trace[1188829033] 'process raft request' (duration: 182.657753ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:56:58.112973Z","caller":"traceutil/trace.go:171","msg":"trace[1497306696] linearizableReadLoop","detail":"{readStateIndex:248; appliedIndex:242; }","duration":"145.509676ms","start":"2026-05-10T03:56:57.967452Z","end":"2026-05-10T03:56:58.112961Z","steps":["trace[1497306696] 'read index received' (duration: 116.676709ms)","trace[1497306696] 'applied index is now lower than readState.Index' (duration: 28.831757ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:56:58.113085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.616067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-05-10T03:56:58.113118Z","caller":"traceutil/trace.go:171","msg":"trace[1747471807] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:240; }","duration":"145.687287ms","start":"2026-05-10T03:56:57.967419Z","end":"2026-05-10T03:56:58.113106Z","steps":["trace[1747471807] 'agreement among raft nodes before linearized reading' (duration: 145.581806ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:20.593458Z","caller":"traceutil/trace.go:171","msg":"trace[732602295] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"158.12989ms","start":"2026-05-10T03:57:20.435302Z","end":"2026-05-10T03:57:20.593432Z","steps":["trace[732602295] 'process raft request' (duration: 157.938568ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:20.593752Z","caller":"traceutil/trace.go:171","msg":"trace[969471835] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:479; }","duration":"156.175127ms","start":"2026-05-10T03:57:20.437548Z","end":"2026-05-10T03:57:20.593723Z","steps":["trace[969471835] 'read index received' (duration: 156.165707ms)","trace[969471835] 'applied index is now lower than readState.Index' (duration: 7.31µs)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:57:20.593929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.367798ms","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-10T03:57:20.593963Z","caller":"traceutil/trace.go:171","msg":"trace[483744679] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:461; }","duration":"156.442159ms","start":"2026-05-10T03:57:20.437509Z","end":"2026-05-10T03:57:20.593951Z","steps":["trace[483744679] 'agreement among raft nodes before linearized reading' (duration: 156.336848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:20.594012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.976492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium-operator\" ","response":"range_response_count:1 size:538"} {"level":"info","ts":"2026-05-10T03:57:20.594063Z","caller":"traceutil/trace.go:171","msg":"trace[726915493] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium-operator; range_end:; response_count:1; response_revision:461; }","duration":"151.057352ms","start":"2026-05-10T03:57:20.44299Z","end":"2026-05-10T03:57:20.594047Z","steps":["trace[726915493] 'agreement among raft nodes before linearized reading' (duration: 150.900621ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:20.594227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.024392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:520"} {"level":"info","ts":"2026-05-10T03:57:20.594255Z","caller":"traceutil/trace.go:171","msg":"trace[909036562] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:461; }","duration":"151.067872ms","start":"2026-05-10T03:57:20.443178Z","end":"2026-05-10T03:57:20.594246Z","steps":["trace[909036562] 'agreement among raft nodes before linearized reading' (duration: 151.019472ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:22.228764Z","caller":"traceutil/trace.go:171","msg":"trace[2103321497] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"270.628832ms","start":"2026-05-10T03:57:21.958121Z","end":"2026-05-10T03:57:22.22875Z","steps":["trace[2103321497] 'process raft request' (duration: 270.590662ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:22.228798Z","caller":"traceutil/trace.go:171","msg":"trace[1429264473] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"276.695472ms","start":"2026-05-10T03:57:21.952088Z","end":"2026-05-10T03:57:22.228783Z","steps":["trace[1429264473] 'process raft request' (duration: 276.596261ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:22.228791Z","caller":"traceutil/trace.go:171","msg":"trace[1091950189] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"276.751403ms","start":"2026-05-10T03:57:21.952004Z","end":"2026-05-10T03:57:22.228755Z","steps":["trace[1091950189] 'process raft request' (duration: 253.455551ms)","trace[1091950189] 'compare' (duration: 23.120791ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:57:22.520953Z","caller":"traceutil/trace.go:171","msg":"trace[716214235] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"556.778625ms","start":"2026-05-10T03:57:21.964157Z","end":"2026-05-10T03:57:22.520936Z","steps":["trace[716214235] 'process raft request' (duration: 556.562433ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:22.521153Z","caller":"traceutil/trace.go:171","msg":"trace[1031637868] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"551.359589ms","start":"2026-05-10T03:57:21.969772Z","end":"2026-05-10T03:57:22.521131Z","steps":["trace[1031637868] 'process raft request' (duration: 551.164238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:22.521227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.969747Z","time spent":"551.451799ms","remote":"127.0.0.1:41976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:57:22.521281Z","caller":"traceutil/trace.go:171","msg":"trace[19484312] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"557.039377ms","start":"2026-05-10T03:57:21.964218Z","end":"2026-05-10T03:57:22.521257Z","steps":["trace[19484312] 'process raft request' (duration: 556.628834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:22.521411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.964214Z","time spent":"557.133187ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:57:22.521505Z","caller":"traceutil/trace.go:171","msg":"trace[130737783] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"548.956423ms","start":"2026-05-10T03:57:21.972541Z","end":"2026-05-10T03:57:22.521497Z","steps":["trace[130737783] 'process raft request' (duration: 548.585791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:22.521552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.972514Z","time spent":"549.017113ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:57:22.521617Z","caller":"traceutil/trace.go:171","msg":"trace[85559754] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"551.53354ms","start":"2026-05-10T03:57:21.970078Z","end":"2026-05-10T03:57:22.521611Z","steps":["trace[85559754] 'process raft request' (duration: 550.884496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:22.521659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.970073Z","time spent":"551.55924ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:57:22.521667Z","caller":"traceutil/trace.go:171","msg":"trace[954393412] transaction","detail":"{read_only:false; number_of_response:1; response_revision:474; }","duration":"551.53104ms","start":"2026-05-10T03:57:21.970123Z","end":"2026-05-10T03:57:22.521654Z","steps":["trace[954393412] 'process raft request' (duration: 550.903496ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:22.521758Z","caller":"traceutil/trace.go:171","msg":"trace[1195223804] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"543.747129ms","start":"2026-05-10T03:57:21.977997Z","end":"2026-05-10T03:57:22.521744Z","steps":["trace[1195223804] 'process raft request' (duration: 543.306486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:22.52174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.970119Z","time spent":"551.57663ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6936,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:57:22.521756Z","caller":"traceutil/trace.go:171","msg":"trace[1724406650] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"545.235199ms","start":"2026-05-10T03:57:21.976494Z","end":"2026-05-10T03:57:22.521729Z","steps":["trace[1724406650] 'process raft request' (duration: 544.741756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:22.521789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.97798Z","time spent":"543.792509ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:57:22.521856Z","caller":"traceutil/trace.go:171","msg":"trace[1118552823] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"539.923493ms","start":"2026-05-10T03:57:21.981924Z","end":"2026-05-10T03:57:22.521847Z","steps":["trace[1118552823] 'process raft request' (duration: 539.43195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:22.521905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.964143Z","time spent":"556.873105ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T03:57:22.521909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.981905Z","time spent":"539.982794ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T03:57:22.521856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.976487Z","time spent":"545.318499ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:57:22.521987Z","caller":"traceutil/trace.go:171","msg":"trace[540533994] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"525.656529ms","start":"2026-05-10T03:57:21.996323Z","end":"2026-05-10T03:57:22.52198Z","steps":["trace[540533994] 'process raft request' (duration: 525.400738ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:22.521987Z","caller":"traceutil/trace.go:171","msg":"trace[517966102] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"386.427908ms","start":"2026-05-10T03:57:22.135549Z","end":"2026-05-10T03:57:22.521977Z","steps":["trace[517966102] 'process raft request' (duration: 386.346308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:22.522017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:21.996305Z","time spent":"525.69709ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T03:57:22.522037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:22.135518Z","time spent":"386.494458ms","remote":"127.0.0.1:41444","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:57:22.530831Z","caller":"traceutil/trace.go:171","msg":"trace[837986976] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"291.120715ms","start":"2026-05-10T03:57:22.2397Z","end":"2026-05-10T03:57:22.530821Z","steps":["trace[837986976] 'process raft request' (duration: 291.076655ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:22.53099Z","caller":"traceutil/trace.go:171","msg":"trace[1744195572] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"294.379086ms","start":"2026-05-10T03:57:22.236601Z","end":"2026-05-10T03:57:22.53098Z","steps":["trace[1744195572] 'process raft request' (duration: 294.066484ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:22.531069Z","caller":"traceutil/trace.go:171","msg":"trace[2027100504] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"294.347395ms","start":"2026-05-10T03:57:22.236716Z","end":"2026-05-10T03:57:22.531063Z","steps":["trace[2027100504] 'process raft request' (duration: 294.022803ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:25.902037Z","caller":"traceutil/trace.go:171","msg":"trace[996231747] linearizableReadLoop","detail":"{readStateIndex:574; appliedIndex:573; }","duration":"148.963276ms","start":"2026-05-10T03:57:25.753048Z","end":"2026-05-10T03:57:25.902011Z","steps":["trace[996231747] 'read index received' (duration: 147.562777ms)","trace[996231747] 'applied index is now lower than readState.Index' (duration: 1.399709ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:57:25.902189Z","caller":"traceutil/trace.go:171","msg":"trace[132954340] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"242.860307ms","start":"2026-05-10T03:57:25.659268Z","end":"2026-05-10T03:57:25.902128Z","steps":["trace[132954340] 'process raft request' (duration: 241.620438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:25.902463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.370149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-10T03:57:25.902516Z","caller":"traceutil/trace.go:171","msg":"trace[194862475] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:554; }","duration":"149.506379ms","start":"2026-05-10T03:57:25.752995Z","end":"2026-05-10T03:57:25.902502Z","steps":["trace[194862475] 'agreement among raft nodes before linearized reading' (duration: 149.130077ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:26.806826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.653343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-10T03:57:26.806855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.186242ms","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-10T03:57:26.806907Z","caller":"traceutil/trace.go:171","msg":"trace[663744801] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:557; }","duration":"141.777834ms","start":"2026-05-10T03:57:26.665111Z","end":"2026-05-10T03:57:26.806889Z","steps":["trace[663744801] 'range keys from in-memory index tree' (duration: 141.47989ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:26.806951Z","caller":"traceutil/trace.go:171","msg":"trace[250299190] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:557; }","duration":"135.353393ms","start":"2026-05-10T03:57:26.671576Z","end":"2026-05-10T03:57:26.806929Z","steps":["trace[250299190] 'range keys from in-memory index tree' (duration: 134.909849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:28.113207Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398340593263600813,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-10T03:57:28.184807Z","caller":"traceutil/trace.go:171","msg":"trace[1557512891] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:584; }","duration":"572.328066ms","start":"2026-05-10T03:57:27.612452Z","end":"2026-05-10T03:57:28.18478Z","steps":["trace[1557512891] 'read index received' (duration: 570.617936ms)","trace[1557512891] 'applied index is now lower than readState.Index' (duration: 1.70913ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:57:28.184971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.500577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:57:28.184995Z","caller":"traceutil/trace.go:171","msg":"trace[289100715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"572.628209ms","start":"2026-05-10T03:57:27.612359Z","end":"2026-05-10T03:57:28.184987Z","steps":["trace[289100715] 'agreement among raft nodes before linearized reading' (duration: 572.529767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:28.185025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:27.612331Z","time spent":"572.68769ms","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-10T03:57:28.199015Z","caller":"traceutil/trace.go:171","msg":"trace[1993328657] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"714.871859ms","start":"2026-05-10T03:57:27.484104Z","end":"2026-05-10T03:57:28.198976Z","steps":["trace[1993328657] 'process raft request' (duration: 699.596773ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:28.199187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:27.484062Z","time spent":"715.03543ms","remote":"127.0.0.1:41488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036197,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:57:28.570066Z","caller":"traceutil/trace.go:171","msg":"trace[1168141254] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"313.278702ms","start":"2026-05-10T03:57:28.256767Z","end":"2026-05-10T03:57:28.570045Z","steps":["trace[1168141254] 'process raft request' (duration: 311.142909ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:28.570205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:28.256743Z","time spent":"313.398473ms","remote":"127.0.0.1:41752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-10T03:57:28.570062Z","caller":"traceutil/trace.go:171","msg":"trace[1199428846] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"238.768162ms","start":"2026-05-10T03:57:28.331271Z","end":"2026-05-10T03:57:28.570039Z","steps":["trace[1199428846] 'process raft request' (duration: 238.677892ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:29.02799Z","caller":"traceutil/trace.go:171","msg":"trace[1229590600] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"174.843479ms","start":"2026-05-10T03:57:28.853099Z","end":"2026-05-10T03:57:29.027942Z","steps":["trace[1229590600] 'process raft request' (duration: 138.31429ms)","trace[1229590600] 'compare' (duration: 36.408668ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:57:30.679427Z","caller":"traceutil/trace.go:171","msg":"trace[1094420613] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"483.75723ms","start":"2026-05-10T03:57:30.195632Z","end":"2026-05-10T03:57:30.679389Z","steps":["trace[1094420613] 'process raft request' (duration: 464.047707ms)","trace[1094420613] 'compare' (duration: 19.541432ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:57:30.679571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:30.195599Z","time spent":"483.90721ms","remote":"127.0.0.1:41958","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-10T03:57:31.1915Z","caller":"traceutil/trace.go:171","msg":"trace[1729286472] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"260.537525ms","start":"2026-05-10T03:57:30.93094Z","end":"2026-05-10T03:57:31.191477Z","steps":["trace[1729286472] 'read index received' (duration: 260.447564ms)","trace[1729286472] 'applied index is now lower than readState.Index' (duration: 89.021µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:57:31.191552Z","caller":"traceutil/trace.go:171","msg":"trace[1813521954] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"330.870542ms","start":"2026-05-10T03:57:30.860663Z","end":"2026-05-10T03:57:31.191534Z","steps":["trace[1813521954] 'process raft request' (duration: 330.680001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:31.191689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:30.860645Z","time spent":"330.953552ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T03:57:31.191686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.742756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-gpwt9\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-10T03:57:31.191868Z","caller":"traceutil/trace.go:171","msg":"trace[68968084] range","detail":"{range_begin:/registry/pods/kube-system/cilium-gpwt9; range_end:; response_count:1; response_revision:580; }","duration":"260.914727ms","start":"2026-05-10T03:57:30.930885Z","end":"2026-05-10T03:57:31.1918Z","steps":["trace[68968084] 'agreement among raft nodes before linearized reading' (duration: 260.703745ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:31.31831Z","caller":"traceutil/trace.go:171","msg":"trace[400587340] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"126.715353ms","start":"2026-05-10T03:57:31.191568Z","end":"2026-05-10T03:57:31.318283Z","steps":["trace[400587340] 'read index received' (duration: 125.868578ms)","trace[400587340] 'applied index is now lower than readState.Index' (duration: 845.925µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:57:31.318633Z","caller":"traceutil/trace.go:171","msg":"trace[949373089] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"215.555933ms","start":"2026-05-10T03:57:31.103046Z","end":"2026-05-10T03:57:31.318602Z","steps":["trace[949373089] 'process raft request' (duration: 214.495267ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:31.318811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.988839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-10T03:57:31.318858Z","caller":"traceutil/trace.go:171","msg":"trace[1175542774] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"139.08483ms","start":"2026-05-10T03:57:31.179761Z","end":"2026-05-10T03:57:31.318846Z","steps":["trace[1175542774] 'agreement among raft nodes before linearized reading' (duration: 138.635507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:31.318968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.657313ms","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-10T03:57:31.31903Z","caller":"traceutil/trace.go:171","msg":"trace[887928453] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:581; }","duration":"286.768184ms","start":"2026-05-10T03:57:31.032244Z","end":"2026-05-10T03:57:31.319012Z","steps":["trace[887928453] 'agreement among raft nodes before linearized reading' (duration: 286.579863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:31.353409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.857711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-10T03:57:31.353483Z","caller":"traceutil/trace.go:171","msg":"trace[861862165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:582; }","duration":"135.979761ms","start":"2026-05-10T03:57:31.217487Z","end":"2026-05-10T03:57:31.353467Z","steps":["trace[861862165] 'agreement among raft nodes before linearized reading' (duration: 135.78784ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:31.353837Z","caller":"traceutil/trace.go:171","msg":"trace[82710278] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"144.910566ms","start":"2026-05-10T03:57:31.208842Z","end":"2026-05-10T03:57:31.353752Z","steps":["trace[82710278] 'process raft request' (duration: 144.262951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:32.633043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.891963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:57:32.633302Z","caller":"traceutil/trace.go:171","msg":"trace[847851292] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:604; }","duration":"1.019014741s","start":"2026-05-10T03:57:31.614268Z","end":"2026-05-10T03:57:32.633283Z","steps":["trace[847851292] 'read index received' (duration: 309.665025ms)","trace[847851292] 'applied index is now lower than readState.Index' (duration: 709.348226ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:57:32.63337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.019103571s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:57:32.633395Z","caller":"traceutil/trace.go:171","msg":"trace[2093997999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:586; }","duration":"1.019178522s","start":"2026-05-10T03:57:31.614208Z","end":"2026-05-10T03:57:32.633386Z","steps":["trace[2093997999] 'agreement among raft nodes before linearized reading' (duration: 1.019131741s)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:32.633341Z","caller":"traceutil/trace.go:171","msg":"trace[532552388] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"1.309146795s","start":"2026-05-10T03:57:31.324151Z","end":"2026-05-10T03:57:32.633297Z","steps":["trace[532552388] 'process raft request' (duration: 599.735039ms)","trace[532552388] 'compare' (duration: 708.752252ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:57:32.63343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:31.614188Z","time spent":"1.019236522s","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-10T03:57:32.633439Z","caller":"traceutil/trace.go:171","msg":"trace[1412568559] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.309247246s","start":"2026-05-10T03:57:31.324173Z","end":"2026-05-10T03:57:32.63342Z","steps":["trace[1412568559] 'process raft request' (duration: 1.308981224s)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:32.633381Z","caller":"traceutil/trace.go:171","msg":"trace[1029136676] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.27438215s","start":"2026-05-10T03:57:31.358932Z","end":"2026-05-10T03:57:32.633314Z","steps":["trace[1029136676] 'process raft request' (duration: 1.27428984s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:32.633578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:31.324151Z","time spent":"1.309360267s","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T03:57:32.633567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:31.324129Z","time spent":"1.309315166s","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:57:32.633637Z","caller":"traceutil/trace.go:171","msg":"trace[1155532239] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"1.246795801s","start":"2026-05-10T03:57:31.386831Z","end":"2026-05-10T03:57:32.633627Z","steps":["trace[1155532239] 'process raft request' (duration: 1.246416998s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:32.633688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:31.386817Z","time spent":"1.246849891s","remote":"127.0.0.1:41660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T03:57:32.633736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:31.358908Z","time spent":"1.274665273s","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:57:34.378354Z","caller":"traceutil/trace.go:171","msg":"trace[1774559621] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"113.816662ms","start":"2026-05-10T03:57:34.264511Z","end":"2026-05-10T03:57:34.378327Z","steps":["trace[1774559621] 'process raft request' (duration: 113.674251ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:44.844443Z","caller":"traceutil/trace.go:171","msg":"trace[1547250754] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"153.02685ms","start":"2026-05-10T03:57:44.691394Z","end":"2026-05-10T03:57:44.844421Z","steps":["trace[1547250754] 'process raft request' (duration: 152.90025ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:44.844889Z","caller":"traceutil/trace.go:171","msg":"trace[1450127139] linearizableReadLoop","detail":"{readStateIndex:752; appliedIndex:750; }","duration":"152.743799ms","start":"2026-05-10T03:57:44.692127Z","end":"2026-05-10T03:57:44.844871Z","steps":["trace[1450127139] 'read index received' (duration: 152.182975ms)","trace[1450127139] 'applied index is now lower than readState.Index' (duration: 559.834µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:57:44.845037Z","caller":"traceutil/trace.go:171","msg":"trace[816968366] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"153.626065ms","start":"2026-05-10T03:57:44.691393Z","end":"2026-05-10T03:57:44.845019Z","steps":["trace[816968366] 'process raft request' (duration: 153.400063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:44.845072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.931031ms","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-10T03:57:44.845117Z","caller":"traceutil/trace.go:171","msg":"trace[2002904804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:727; }","duration":"152.997681ms","start":"2026-05-10T03:57:44.692099Z","end":"2026-05-10T03:57:44.845096Z","steps":["trace[2002904804] 'agreement among raft nodes before linearized reading' (duration: 152.84357ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:47.437997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.817213ms","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-10T03:57:47.438137Z","caller":"traceutil/trace.go:171","msg":"trace[1676570268] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:740; }","duration":"582.938917ms","start":"2026-05-10T03:57:46.855122Z","end":"2026-05-10T03:57:47.438061Z","steps":["trace[1676570268] 'range keys from in-memory index tree' (duration: 582.644407ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:47.438189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:46.855107Z","time spent":"583.072212ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-10T03:57:47.438186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.22963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-pbssv\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-05-10T03:57:47.438142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.885135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-10T03:57:47.438313Z","caller":"traceutil/trace.go:171","msg":"trace[81120806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:740; }","duration":"590.203947ms","start":"2026-05-10T03:57:46.848088Z","end":"2026-05-10T03:57:47.438292Z","steps":["trace[81120806] 'range keys from in-memory index tree' (duration: 589.695579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:47.438327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.687524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T03:57:47.438384Z","caller":"traceutil/trace.go:171","msg":"trace[891938838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:740; }","duration":"151.80137ms","start":"2026-05-10T03:57:47.286574Z","end":"2026-05-10T03:57:47.438375Z","steps":["trace[891938838] 'range keys from in-memory index tree' (duration: 151.555849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:47.438447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:46.848066Z","time spent":"590.365983ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T03:57:47.438513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.496136ms","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-10T03:57:47.438242Z","caller":"traceutil/trace.go:171","msg":"trace[940799900] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-pbssv; range_end:; response_count:1; response_revision:740; }","duration":"404.324303ms","start":"2026-05-10T03:57:47.033901Z","end":"2026-05-10T03:57:47.438225Z","steps":["trace[940799900] 'range keys from in-memory index tree' (duration: 404.040851ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:47.438558Z","caller":"traceutil/trace.go:171","msg":"trace[376079898] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:740; }","duration":"588.579489ms","start":"2026-05-10T03:57:46.849967Z","end":"2026-05-10T03:57:47.438546Z","steps":["trace[376079898] 'range keys from in-memory index tree' (duration: 588.377073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:57:47.438607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:46.849946Z","time spent":"588.650471ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-10T03:57:47.43867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:57:47.033876Z","time spent":"404.723871ms","remote":"127.0.0.1:41578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-pbssv\" "} {"level":"info","ts":"2026-05-10T03:57:47.60103Z","caller":"traceutil/trace.go:171","msg":"trace[2133663070] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"142.696942ms","start":"2026-05-10T03:57:47.45831Z","end":"2026-05-10T03:57:47.601007Z","steps":["trace[2133663070] 'process raft request' (duration: 142.553285ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:47.609548Z","caller":"traceutil/trace.go:171","msg":"trace[1515209872] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"147.992807ms","start":"2026-05-10T03:57:47.461542Z","end":"2026-05-10T03:57:47.609534Z","steps":["trace[1515209872] 'process raft request' (duration: 147.948665ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:47.609711Z","caller":"traceutil/trace.go:171","msg":"trace[132602811] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"151.201213ms","start":"2026-05-10T03:57:47.458471Z","end":"2026-05-10T03:57:47.609673Z","steps":["trace[132602811] 'process raft request' (duration: 150.930522ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:47.609992Z","caller":"traceutil/trace.go:171","msg":"trace[1123271642] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"151.520567ms","start":"2026-05-10T03:57:47.458464Z","end":"2026-05-10T03:57:47.609985Z","steps":["trace[1123271642] 'process raft request' (duration: 150.833897ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:57:47.609762Z","caller":"traceutil/trace.go:171","msg":"trace[1943254798] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"151.232665ms","start":"2026-05-10T03:57:47.45852Z","end":"2026-05-10T03:57:47.609753Z","steps":["trace[1943254798] 'process raft request' (duration: 150.917782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:58:18.850487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.182611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:58:18.850646Z","caller":"traceutil/trace.go:171","msg":"trace[1142061896] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1152; }","duration":"237.45643ms","start":"2026-05-10T03:58:18.613168Z","end":"2026-05-10T03:58:18.850624Z","steps":["trace[1142061896] 'range keys from in-memory index tree' (duration: 237.073379ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:58:36.819957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.923437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:58:36.820038Z","caller":"traceutil/trace.go:171","msg":"trace[1303361375] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1393; }","duration":"133.086531ms","start":"2026-05-10T03:58:36.686937Z","end":"2026-05-10T03:58:36.820023Z","steps":["trace[1303361375] 'count revisions from in-memory index tree' (duration: 132.827045ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:58:40.038989Z","caller":"traceutil/trace.go:171","msg":"trace[1894292315] linearizableReadLoop","detail":"{readStateIndex:1450; appliedIndex:1449; }","duration":"190.533843ms","start":"2026-05-10T03:58:39.848434Z","end":"2026-05-10T03:58:40.038968Z","steps":["trace[1894292315] 'read index received' (duration: 190.305188ms)","trace[1894292315] 'applied index is now lower than readState.Index' (duration: 227.625µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:58:40.039084Z","caller":"traceutil/trace.go:171","msg":"trace[1933376537] transaction","detail":"{read_only:false; response_revision:1406; number_of_response:1; }","duration":"236.862073ms","start":"2026-05-10T03:58:39.802203Z","end":"2026-05-10T03:58:40.039065Z","steps":["trace[1933376537] 'process raft request' (duration: 236.622677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:58:40.039127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.683996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-10T03:58:40.039159Z","caller":"traceutil/trace.go:171","msg":"trace[2146322951] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1406; }","duration":"190.773879ms","start":"2026-05-10T03:58:39.848377Z","end":"2026-05-10T03:58:40.039151Z","steps":["trace[2146322951] 'agreement among raft nodes before linearized reading' (duration: 190.696937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:58:40.039279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.993148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-10T03:58:40.039309Z","caller":"traceutil/trace.go:171","msg":"trace[277763076] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1406; }","duration":"172.04471ms","start":"2026-05-10T03:58:39.867256Z","end":"2026-05-10T03:58:40.039301Z","steps":["trace[277763076] 'agreement among raft nodes before linearized reading' (duration: 171.946048ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:58:40.039399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.001685ms","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-10T03:58:40.039421Z","caller":"traceutil/trace.go:171","msg":"trace[1521765038] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1406; }","duration":"171.041386ms","start":"2026-05-10T03:58:39.868375Z","end":"2026-05-10T03:58:40.039416Z","steps":["trace[1521765038] 'agreement among raft nodes before linearized reading' (duration: 170.980164ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:58:40.039424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.043969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-10T03:58:40.039502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.113258ms","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-10T03:58:40.039543Z","caller":"traceutil/trace.go:171","msg":"trace[377213014] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1406; }","duration":"169.180152ms","start":"2026-05-10T03:58:39.87035Z","end":"2026-05-10T03:58:40.03953Z","steps":["trace[377213014] 'agreement among raft nodes before linearized reading' (duration: 168.960326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:58:40.039537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.341556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T03:58:40.039574Z","caller":"traceutil/trace.go:171","msg":"trace[1915980591] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1406; }","duration":"171.22418ms","start":"2026-05-10T03:58:39.86833Z","end":"2026-05-10T03:58:40.039554Z","steps":["trace[1915980591] 'agreement among raft nodes before linearized reading' (duration: 171.052026ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:58:40.039627Z","caller":"traceutil/trace.go:171","msg":"trace[861390417] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1406; }","duration":"164.515649ms","start":"2026-05-10T03:58:39.875096Z","end":"2026-05-10T03:58:40.039611Z","steps":["trace[861390417] 'agreement among raft nodes before linearized reading' (duration: 164.263704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.021615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.984018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:05.021952Z","caller":"traceutil/trace.go:171","msg":"trace[1018285642] transaction","detail":"{read_only:false; response_revision:1808; number_of_response:1; }","duration":"746.459081ms","start":"2026-05-10T03:59:04.275468Z","end":"2026-05-10T03:59:05.021927Z","steps":["trace[1018285642] 'process raft request' (duration: 746.328258ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.022046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.275449Z","time spent":"746.556843ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:05.022303Z","caller":"traceutil/trace.go:171","msg":"trace[935444343] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1877; }","duration":"787.105051ms","start":"2026-05-10T03:59:04.235184Z","end":"2026-05-10T03:59:05.022289Z","steps":["trace[935444343] 'read index received' (duration: 262.251116ms)","trace[935444343] 'applied index is now lower than readState.Index' (duration: 524.852215ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:05.021819Z","caller":"traceutil/trace.go:171","msg":"trace[20363758] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"826.259071ms","start":"2026-05-10T03:59:04.195528Z","end":"2026-05-10T03:59:05.021787Z","steps":["trace[20363758] 'process raft request' (duration: 301.959807ms)","trace[20363758] 'compare' (duration: 523.280815ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:05.022665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.195494Z","time spent":"827.067966ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T03:59:05.022812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.63438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-10T03:59:05.022853Z","caller":"traceutil/trace.go:171","msg":"trace[1421257404] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1808; }","duration":"787.737562ms","start":"2026-05-10T03:59:04.235104Z","end":"2026-05-10T03:59:05.022842Z","steps":["trace[1421257404] 'agreement among raft nodes before linearized reading' (duration: 787.558979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.022887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.235071Z","time spent":"787.808934ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-10T03:59:05.286639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.50687ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:05.286963Z","caller":"traceutil/trace.go:171","msg":"trace[241265563] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"701.183943ms","start":"2026-05-10T03:59:04.585743Z","end":"2026-05-10T03:59:05.286927Z","steps":["trace[241265563] 'process raft request' (duration: 589.216965ms)","trace[241265563] 'compare' (duration: 111.354917ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:05.287096Z","caller":"traceutil/trace.go:171","msg":"trace[1472393280] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"305.157043ms","start":"2026-05-10T03:59:04.981892Z","end":"2026-05-10T03:59:05.287049Z","steps":["trace[1472393280] 'process raft request' (duration: 304.854778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.287147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.585705Z","time spent":"701.343416ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T03:59:05.28729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.981861Z","time spent":"305.340277ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T03:59:05.287437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"868.739614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-98290cf9-6219-4b1e-9a3c-f9ab9e8cc1b9\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-05-10T03:59:05.287467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.924793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-10T03:59:05.287482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.290857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T03:59:05.287479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016180049s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-10T03:59:05.28755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.12663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-05-10T03:59:05.287564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.325682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-98290cf9-6219-4b1e-9a3c-f9ab9e8cc1b9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-10T03:59:05.287759Z","caller":"traceutil/trace.go:171","msg":"trace[490312703] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-98290cf9-6219-4b1e-9a3c-f9ab9e8cc1b9; range_end:; response_count:1; response_revision:1811; }","duration":"514.537746ms","start":"2026-05-10T03:59:04.773127Z","end":"2026-05-10T03:59:05.287664Z","steps":["trace[490312703] 'agreement among raft nodes before linearized reading' (duration: 514.171859ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:05.287826Z","caller":"traceutil/trace.go:171","msg":"trace[502386442] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"259.667685ms","start":"2026-05-10T03:59:05.027539Z","end":"2026-05-10T03:59:05.287207Z","steps":["trace[502386442] 'process raft request' (duration: 259.472402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.287847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021379079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-10T03:59:05.287735Z","caller":"traceutil/trace.go:171","msg":"trace[1947784565] linearizableReadLoop","detail":"{readStateIndex:1881; appliedIndex:1879; }","duration":"264.761683ms","start":"2026-05-10T03:59:05.022326Z","end":"2026-05-10T03:59:05.287088Z","steps":["trace[1947784565] 'read index received' (duration: 152.714084ms)","trace[1947784565] 'applied index is now lower than readState.Index' (duration: 112.046409ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:05.287903Z","caller":"traceutil/trace.go:171","msg":"trace[393880066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1811; }","duration":"1.021507351s","start":"2026-05-10T03:59:04.266377Z","end":"2026-05-10T03:59:05.287884Z","steps":["trace[393880066] 'agreement among raft nodes before linearized reading' (duration: 1.021318918s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.287867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.773091Z","time spent":"514.75795ms","remote":"127.0.0.1:41578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-98290cf9-6219-4b1e-9a3c-f9ab9e8cc1b9\" "} {"level":"warn","ts":"2026-05-10T03:59:05.28795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.266345Z","time spent":"1.021593993s","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-10T03:59:05.288001Z","caller":"traceutil/trace.go:171","msg":"trace[1601866614] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-98290cf9-6219-4b1e-9a3c-f9ab9e8cc1b9; range_end:; response_count:1; response_revision:1811; }","duration":"868.837565ms","start":"2026-05-10T03:59:04.418633Z","end":"2026-05-10T03:59:05.28747Z","steps":["trace[1601866614] 'agreement among raft nodes before linearized reading' (duration: 868.661312ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.288106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.418608Z","time spent":"869.479007ms","remote":"127.0.0.1:41578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-98290cf9-6219-4b1e-9a3c-f9ab9e8cc1b9\" "} {"level":"warn","ts":"2026-05-10T03:59:05.28814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.733805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-10T03:59:05.288186Z","caller":"traceutil/trace.go:171","msg":"trace[676081644] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1811; }","duration":"161.828116ms","start":"2026-05-10T03:59:05.12634Z","end":"2026-05-10T03:59:05.288168Z","steps":["trace[676081644] 'agreement among raft nodes before linearized reading' (duration: 161.661983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.288233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.006403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-10T03:59:05.288289Z","caller":"traceutil/trace.go:171","msg":"trace[1015486514] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1811; }","duration":"292.374198ms","start":"2026-05-10T03:59:04.995136Z","end":"2026-05-10T03:59:05.28751Z","steps":["trace[1015486514] 'agreement among raft nodes before linearized reading' (duration: 292.288966ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:05.288304Z","caller":"traceutil/trace.go:171","msg":"trace[308607912] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1811; }","duration":"128.071935ms","start":"2026-05-10T03:59:05.16021Z","end":"2026-05-10T03:59:05.288282Z","steps":["trace[308607912] 'agreement among raft nodes before linearized reading' (duration: 127.871371ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:05.288371Z","caller":"traceutil/trace.go:171","msg":"trace[1213380682] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1811; }","duration":"1.016348322s","start":"2026-05-10T03:59:04.271213Z","end":"2026-05-10T03:59:05.287561Z","steps":["trace[1213380682] 'agreement among raft nodes before linearized reading' (duration: 1.016048716s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.287865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.021166405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-10T03:59:05.28849Z","caller":"traceutil/trace.go:171","msg":"trace[1048493245] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1811; }","duration":"955.19001ms","start":"2026-05-10T03:59:04.332381Z","end":"2026-05-10T03:59:05.287571Z","steps":["trace[1048493245] 'agreement among raft nodes before linearized reading' (duration: 955.105659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.288558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.332359Z","time spent":"956.184929ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":577,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-10T03:59:05.288257Z","caller":"traceutil/trace.go:171","msg":"trace[636076779] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1811; }","duration":"886.002184ms","start":"2026-05-10T03:59:04.4015Z","end":"2026-05-10T03:59:05.287502Z","steps":["trace[636076779] 'agreement among raft nodes before linearized reading' (duration: 885.693628ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.288638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.401488Z","time spent":"887.137885ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-10T03:59:05.288447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.271194Z","time spent":"1.017234979s","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-10T03:59:05.28957Z","caller":"traceutil/trace.go:171","msg":"trace[329289101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1811; }","duration":"1.02199428s","start":"2026-05-10T03:59:04.266497Z","end":"2026-05-10T03:59:05.288492Z","steps":["trace[329289101] 'agreement among raft nodes before linearized reading' (duration: 1.020836129s)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:05.289863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:04.266485Z","time spent":"1.023356217s","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":453,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-10T03:59:05.488957Z","caller":"traceutil/trace.go:171","msg":"trace[1459914330] transaction","detail":"{read_only:false; response_revision:1813; number_of_response:1; }","duration":"193.010589ms","start":"2026-05-10T03:59:05.295902Z","end":"2026-05-10T03:59:05.488912Z","steps":["trace[1459914330] 'process raft request' (duration: 192.716583ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:05.489206Z","caller":"traceutil/trace.go:171","msg":"trace[1988456661] transaction","detail":"{read_only:false; response_revision:1814; number_of_response:1; }","duration":"193.212062ms","start":"2026-05-10T03:59:05.295956Z","end":"2026-05-10T03:59:05.489168Z","steps":["trace[1988456661] 'process raft request' (duration: 192.789234ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:05.489402Z","caller":"traceutil/trace.go:171","msg":"trace[870619926] transaction","detail":"{read_only:false; response_revision:1816; number_of_response:1; }","duration":"193.095371ms","start":"2026-05-10T03:59:05.2963Z","end":"2026-05-10T03:59:05.489395Z","steps":["trace[870619926] 'process raft request' (duration: 192.990819ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:05.489445Z","caller":"traceutil/trace.go:171","msg":"trace[2110088922] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"193.474637ms","start":"2026-05-10T03:59:05.295955Z","end":"2026-05-10T03:59:05.489429Z","steps":["trace[2110088922] 'process raft request' (duration: 192.868606ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:05.489777Z","caller":"traceutil/trace.go:171","msg":"trace[1700805671] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"191.884826ms","start":"2026-05-10T03:59:05.297879Z","end":"2026-05-10T03:59:05.489763Z","steps":["trace[1700805671] 'process raft request' (duration: 191.460038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:06.175988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.618489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T03:59:06.176031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.518781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-10T03:59:06.176072Z","caller":"traceutil/trace.go:171","msg":"trace[1199607531] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1817; }","duration":"561.761692ms","start":"2026-05-10T03:59:05.614291Z","end":"2026-05-10T03:59:06.176053Z","steps":["trace[1199607531] 'range keys from in-memory index tree' (duration: 561.503747ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:06.176117Z","caller":"traceutil/trace.go:171","msg":"trace[1885113731] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:1817; }","duration":"416.662614ms","start":"2026-05-10T03:59:05.759431Z","end":"2026-05-10T03:59:06.176093Z","steps":["trace[1885113731] 'range keys from in-memory index tree' (duration: 416.332478ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:06.176213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:05.759419Z","time spent":"416.779176ms","remote":"127.0.0.1:41424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.156\" "} {"level":"warn","ts":"2026-05-10T03:59:06.17612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:05.614268Z","time spent":"561.838903ms","remote":"127.0.0.1:41398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-10T03:59:20.173262Z","caller":"traceutil/trace.go:171","msg":"trace[560471173] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"122.093641ms","start":"2026-05-10T03:59:20.051143Z","end":"2026-05-10T03:59:20.173236Z","steps":["trace[560471173] 'process raft request' (duration: 121.908128ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:38.292169Z","caller":"traceutil/trace.go:171","msg":"trace[1083635600] transaction","detail":"{read_only:false; response_revision:2048; number_of_response:1; }","duration":"107.952835ms","start":"2026-05-10T03:59:38.184196Z","end":"2026-05-10T03:59:38.292149Z","steps":["trace[1083635600] 'process raft request' (duration: 107.822093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:38.875145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.157613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:59:38.875233Z","caller":"traceutil/trace.go:171","msg":"trace[540583757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2048; }","duration":"259.281194ms","start":"2026-05-10T03:59:38.61593Z","end":"2026-05-10T03:59:38.875211Z","steps":["trace[540583757] 'range keys from in-memory index tree' (duration: 259.101682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:38.875618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.465788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-10T03:59:38.875663Z","caller":"traceutil/trace.go:171","msg":"trace[137720999] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2048; }","duration":"346.529619ms","start":"2026-05-10T03:59:38.529121Z","end":"2026-05-10T03:59:38.875651Z","steps":["trace[137720999] 'range keys from in-memory index tree' (duration: 346.260605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:38.875694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:38.529111Z","time spent":"346.574529ms","remote":"127.0.0.1:51172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5466,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-10T03:59:38.875866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.51885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:59:38.875957Z","caller":"traceutil/trace.go:171","msg":"trace[1690403013] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2048; }","duration":"374.644602ms","start":"2026-05-10T03:59:38.501296Z","end":"2026-05-10T03:59:38.875941Z","steps":["trace[1690403013] 'count revisions from in-memory index tree' (duration: 374.298817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:38.876015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:38.501263Z","time spent":"374.740503ms","remote":"127.0.0.1:38012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-05-10T03:59:39.334967Z","caller":"traceutil/trace.go:171","msg":"trace[59838165] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"109.567199ms","start":"2026-05-10T03:59:39.225366Z","end":"2026-05-10T03:59:39.334933Z","steps":["trace[59838165] 'process raft request' (duration: 108.745947ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:39.341224Z","caller":"traceutil/trace.go:171","msg":"trace[1604868555] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"115.195714ms","start":"2026-05-10T03:59:39.226007Z","end":"2026-05-10T03:59:39.341203Z","steps":["trace[1604868555] 'process raft request' (duration: 115.042992ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:39.648542Z","caller":"traceutil/trace.go:171","msg":"trace[1931142774] linearizableReadLoop","detail":"{readStateIndex:2132; appliedIndex:2131; }","duration":"200.497882ms","start":"2026-05-10T03:59:39.448013Z","end":"2026-05-10T03:59:39.648511Z","steps":["trace[1931142774] 'read index received' (duration: 146.008576ms)","trace[1931142774] 'applied index is now lower than readState.Index' (duration: 54.487926ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:39.648737Z","caller":"traceutil/trace.go:171","msg":"trace[1779918440] transaction","detail":"{read_only:false; response_revision:2053; number_of_response:1; }","duration":"237.686018ms","start":"2026-05-10T03:59:39.411023Z","end":"2026-05-10T03:59:39.648709Z","steps":["trace[1779918440] 'process raft request' (duration: 182.948488ms)","trace[1779918440] 'compare' (duration: 54.287383ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:39.64904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.004159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T03:59:39.649125Z","caller":"traceutil/trace.go:171","msg":"trace[1301850227] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2053; }","duration":"201.100481ms","start":"2026-05-10T03:59:39.448009Z","end":"2026-05-10T03:59:39.64911Z","steps":["trace[1301850227] 'agreement among raft nodes before linearized reading' (duration: 200.795256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:39.649353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.267705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-10T03:59:39.649418Z","caller":"traceutil/trace.go:171","msg":"trace[719642204] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2053; }","duration":"133.383837ms","start":"2026-05-10T03:59:39.516018Z","end":"2026-05-10T03:59:39.649402Z","steps":["trace[719642204] 'agreement among raft nodes before linearized reading' (duration: 133.213334ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:39.817168Z","caller":"traceutil/trace.go:171","msg":"trace[376161588] linearizableReadLoop","detail":"{readStateIndex:2134; appliedIndex:2132; }","duration":"160.937778ms","start":"2026-05-10T03:59:39.656201Z","end":"2026-05-10T03:59:39.817139Z","steps":["trace[376161588] 'read index received' (duration: 21.016793ms)","trace[376161588] 'applied index is now lower than readState.Index' (duration: 139.919575ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:39.817407Z","caller":"traceutil/trace.go:171","msg":"trace[1715758904] transaction","detail":"{read_only:false; response_revision:2055; number_of_response:1; }","duration":"163.833562ms","start":"2026-05-10T03:59:39.653532Z","end":"2026-05-10T03:59:39.817365Z","steps":["trace[1715758904] 'process raft request' (duration: 130.96226ms)","trace[1715758904] 'compare' (duration: 32.382845ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:39.817453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.235163ms","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-10T03:59:39.817633Z","caller":"traceutil/trace.go:171","msg":"trace[236222297] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2055; }","duration":"161.441906ms","start":"2026-05-10T03:59:39.656173Z","end":"2026-05-10T03:59:39.817615Z","steps":["trace[236222297] 'agreement among raft nodes before linearized reading' (duration: 161.114821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:39.817862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.773427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-10T03:59:39.817906Z","caller":"traceutil/trace.go:171","msg":"trace[1385050731] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2055; }","duration":"150.828898ms","start":"2026-05-10T03:59:39.667065Z","end":"2026-05-10T03:59:39.817894Z","steps":["trace[1385050731] 'agreement among raft nodes before linearized reading' (duration: 150.712066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:39.817947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.446491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"warn","ts":"2026-05-10T03:59:39.817935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.246014ms","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-10T03:59:39.818008Z","caller":"traceutil/trace.go:171","msg":"trace[143903440] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2055; }","duration":"150.521312ms","start":"2026-05-10T03:59:39.66747Z","end":"2026-05-10T03:59:39.817992Z","steps":["trace[143903440] 'agreement among raft nodes before linearized reading' (duration: 150.35417ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:39.818059Z","caller":"traceutil/trace.go:171","msg":"trace[2133537545] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2055; }","duration":"151.367245ms","start":"2026-05-10T03:59:39.666635Z","end":"2026-05-10T03:59:39.818002Z","steps":["trace[2133537545] 'agreement among raft nodes before linearized reading' (duration: 151.081881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:40.889368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.600192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-10T03:59:40.889482Z","caller":"traceutil/trace.go:171","msg":"trace[1226729402] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2059; }","duration":"466.774615ms","start":"2026-05-10T03:59:40.422691Z","end":"2026-05-10T03:59:40.889465Z","steps":["trace[1226729402] 'count revisions from in-memory index tree' (duration: 466.474571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:40.889525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:40.422665Z","time spent":"466.849247ms","remote":"127.0.0.1:41696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":29,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-10T03:59:40.889809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.706097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T03:59:40.889848Z","caller":"traceutil/trace.go:171","msg":"trace[1892240199] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2059; }","duration":"276.778338ms","start":"2026-05-10T03:59:40.61306Z","end":"2026-05-10T03:59:40.889839Z","steps":["trace[1892240199] 'range keys from in-memory index tree' (duration: 276.599856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:40.897163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.653434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-10T03:59:40.897268Z","caller":"traceutil/trace.go:171","msg":"trace[1477887865] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2059; }","duration":"741.820318ms","start":"2026-05-10T03:59:40.155418Z","end":"2026-05-10T03:59:40.897239Z","steps":["trace[1477887865] 'range keys from in-memory index tree' (duration: 741.422101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:40.897343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:40.155401Z","time spent":"741.926679ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":580,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-05-10T03:59:41.183986Z","caller":"traceutil/trace.go:171","msg":"trace[2090671492] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"278.937885ms","start":"2026-05-10T03:59:40.905011Z","end":"2026-05-10T03:59:41.183949Z","steps":["trace[2090671492] 'process raft request' (duration: 278.665661ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:41.616248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.393965ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-10T03:59:41.617043Z","caller":"traceutil/trace.go:171","msg":"trace[1289967715] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"648.653137ms","start":"2026-05-10T03:59:40.96837Z","end":"2026-05-10T03:59:41.617023Z","steps":["trace[1289967715] 'process raft request' (duration: 648.511545ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:41.617146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T03:59:40.968341Z","time spent":"648.74578ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T03:59:41.626069Z","caller":"traceutil/trace.go:171","msg":"trace[337216790] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"284.715911ms","start":"2026-05-10T03:59:41.341329Z","end":"2026-05-10T03:59:41.626045Z","steps":["trace[337216790] 'process raft request' (duration: 284.598679ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T03:59:41.627057Z","caller":"traceutil/trace.go:171","msg":"trace[401244785] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"281.155048ms","start":"2026-05-10T03:59:41.34588Z","end":"2026-05-10T03:59:41.627035Z","steps":["trace[401244785] 'process raft request' (duration: 281.022836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T03:59:41.83408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.806538ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T03:59:41.834311Z","caller":"traceutil/trace.go:171","msg":"trace[880077522] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"171.269933ms","start":"2026-05-10T03:59:41.662915Z","end":"2026-05-10T03:59:41.834185Z","steps":["trace[880077522] 'process raft request' (duration: 54.249062ms)","trace[880077522] 'compare' (duration: 116.627766ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T03:59:41.834269Z","caller":"traceutil/trace.go:171","msg":"trace[525900763] linearizableReadLoop","detail":"{readStateIndex:2145; appliedIndex:2144; }","duration":"152.438174ms","start":"2026-05-10T03:59:41.681736Z","end":"2026-05-10T03:59:41.834174Z","steps":["trace[525900763] 'read index received' (duration: 35.316141ms)","trace[525900763] 'applied index is now lower than readState.Index' (duration: 117.120903ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T03:59:41.834611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.796309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-10T03:59:41.834729Z","caller":"traceutil/trace.go:171","msg":"trace[1754375291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2065; }","duration":"152.996883ms","start":"2026-05-10T03:59:41.681705Z","end":"2026-05-10T03:59:41.834702Z","steps":["trace[1754375291] 'agreement among raft nodes before linearized reading' (duration: 152.587417ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:45.054989Z","caller":"traceutil/trace.go:171","msg":"trace[590882002] transaction","detail":"{read_only:false; response_revision:2489; number_of_response:1; }","duration":"135.810534ms","start":"2026-05-10T04:00:44.919143Z","end":"2026-05-10T04:00:45.054954Z","steps":["trace[590882002] 'process raft request' (duration: 135.634022ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:00:46.224673Z","caller":"traceutil/trace.go:171","msg":"trace[403111859] transaction","detail":"{read_only:false; response_revision:2499; number_of_response:1; }","duration":"158.027298ms","start":"2026-05-10T04:00:46.066611Z","end":"2026-05-10T04:00:46.224639Z","steps":["trace[403111859] 'process raft request' (duration: 157.815425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:01:21.62277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.068247ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-10T04:01:22.501015Z","caller":"traceutil/trace.go:171","msg":"trace[1916208792] transaction","detail":"{read_only:false; response_revision:2709; number_of_response:1; }","duration":"456.724816ms","start":"2026-05-10T04:01:22.044264Z","end":"2026-05-10T04:01:22.500989Z","steps":["trace[1916208792] 'process raft request' (duration: 456.563894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:01:22.501167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:01:22.044238Z","time spent":"456.854197ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:01:22.655165Z","caller":"traceutil/trace.go:171","msg":"trace[1652101895] linearizableReadLoop","detail":"{readStateIndex:2814; appliedIndex:2811; }","duration":"254.602165ms","start":"2026-05-10T04:01:22.400539Z","end":"2026-05-10T04:01:22.655142Z","steps":["trace[1652101895] 'read index received' (duration: 100.289912ms)","trace[1652101895] 'applied index is now lower than readState.Index' (duration: 154.308413ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:01:22.655294Z","caller":"traceutil/trace.go:171","msg":"trace[1833741119] transaction","detail":"{read_only:false; response_revision:2711; number_of_response:1; }","duration":"285.848209ms","start":"2026-05-10T04:01:22.369433Z","end":"2026-05-10T04:01:22.655282Z","steps":["trace[1833741119] 'process raft request' (duration: 285.652487ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:22.655299Z","caller":"traceutil/trace.go:171","msg":"trace[1580982314] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"547.634679ms","start":"2026-05-10T04:01:22.107619Z","end":"2026-05-10T04:01:22.655254Z","steps":["trace[1580982314] 'process raft request' (duration: 532.378271ms)","trace[1580982314] 'compare' (duration: 14.784943ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:01:22.655454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:01:22.107594Z","time spent":"547.77321ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:01:22.655892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.550584ms","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-10T04:01:22.65593Z","caller":"traceutil/trace.go:171","msg":"trace[1603084461] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2711; }","duration":"176.629406ms","start":"2026-05-10T04:01:22.479292Z","end":"2026-05-10T04:01:22.655921Z","steps":["trace[1603084461] 'agreement among raft nodes before linearized reading' (duration: 176.490343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:01:22.655942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.381983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-10T04:01:22.656245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.279073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-05-10T04:01:22.656286Z","caller":"traceutil/trace.go:171","msg":"trace[1484041553] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2711; }","duration":"179.367583ms","start":"2026-05-10T04:01:22.476906Z","end":"2026-05-10T04:01:22.656274Z","steps":["trace[1484041553] 'agreement among raft nodes before linearized reading' (duration: 179.270822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:01:22.656449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.507501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-05-10T04:01:22.656244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.704508ms","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-10T04:01:22.656512Z","caller":"traceutil/trace.go:171","msg":"trace[1767482483] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2711; }","duration":"192.602572ms","start":"2026-05-10T04:01:22.463891Z","end":"2026-05-10T04:01:22.656494Z","steps":["trace[1767482483] 'agreement among raft nodes before linearized reading' (duration: 192.41827ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:22.656675Z","caller":"traceutil/trace.go:171","msg":"trace[891351061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2711; }","duration":"255.490185ms","start":"2026-05-10T04:01:22.400497Z","end":"2026-05-10T04:01:22.655987Z","steps":["trace[891351061] 'agreement among raft nodes before linearized reading' (duration: 255.324373ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:22.656749Z","caller":"traceutil/trace.go:171","msg":"trace[170632578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2711; }","duration":"234.150933ms","start":"2026-05-10T04:01:22.422382Z","end":"2026-05-10T04:01:22.656533Z","steps":["trace[170632578] 'agreement among raft nodes before linearized reading' (duration: 233.067891ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:01:22.659352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.67373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-10T04:01:22.659414Z","caller":"traceutil/trace.go:171","msg":"trace[1382822627] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2711; }","duration":"186.7479ms","start":"2026-05-10T04:01:22.472633Z","end":"2026-05-10T04:01:22.659381Z","steps":["trace[1382822627] 'agreement among raft nodes before linearized reading' (duration: 183.289795ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:22.848729Z","caller":"traceutil/trace.go:171","msg":"trace[741507569] linearizableReadLoop","detail":"{readStateIndex:2820; appliedIndex:2815; }","duration":"176.317182ms","start":"2026-05-10T04:01:22.672382Z","end":"2026-05-10T04:01:22.8487Z","steps":["trace[741507569] 'read index received' (duration: 175.892497ms)","trace[741507569] 'applied index is now lower than readState.Index' (duration: 423.915µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:01:22.849078Z","caller":"traceutil/trace.go:171","msg":"trace[638859935] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"186.483396ms","start":"2026-05-10T04:01:22.662585Z","end":"2026-05-10T04:01:22.849068Z","steps":["trace[638859935] 'process raft request' (duration: 185.807219ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:22.849252Z","caller":"traceutil/trace.go:171","msg":"trace[155300089] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"186.628879ms","start":"2026-05-10T04:01:22.662615Z","end":"2026-05-10T04:01:22.849244Z","steps":["trace[155300089] 'process raft request' (duration: 185.953651ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:22.849338Z","caller":"traceutil/trace.go:171","msg":"trace[2032852731] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"186.67065ms","start":"2026-05-10T04:01:22.662659Z","end":"2026-05-10T04:01:22.84933Z","steps":["trace[2032852731] 'process raft request' (duration: 185.945462ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:22.849432Z","caller":"traceutil/trace.go:171","msg":"trace[1830708058] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"186.70573ms","start":"2026-05-10T04:01:22.662718Z","end":"2026-05-10T04:01:22.849423Z","steps":["trace[1830708058] 'process raft request' (duration: 185.922201ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:01:22.849596Z","caller":"traceutil/trace.go:171","msg":"trace[649242301] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"186.095044ms","start":"2026-05-10T04:01:22.66346Z","end":"2026-05-10T04:01:22.849555Z","steps":["trace[649242301] 'process raft request' (duration: 185.210584ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:01:22.850793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.386953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak\" ","response":"range_response_count:1 size:1319"} {"level":"info","ts":"2026-05-10T04:01:22.855811Z","caller":"traceutil/trace.go:171","msg":"trace[1177817495] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak; range_end:; response_count:1; response_revision:2717; }","duration":"183.439257ms","start":"2026-05-10T04:01:22.672342Z","end":"2026-05-10T04:01:22.855782Z","steps":["trace[1177817495] 'agreement among raft nodes before linearized reading' (duration: 177.288073ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:02:38.953317Z","caller":"traceutil/trace.go:171","msg":"trace[514659125] transaction","detail":"{read_only:false; response_revision:3111; number_of_response:1; }","duration":"165.180347ms","start":"2026-05-10T04:02:38.78811Z","end":"2026-05-10T04:02:38.95329Z","steps":["trace[514659125] 'process raft request' (duration: 165.014312ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:03:17.411041Z","caller":"traceutil/trace.go:171","msg":"trace[317925748] transaction","detail":"{read_only:false; response_revision:3397; number_of_response:1; }","duration":"105.695332ms","start":"2026-05-10T04:03:17.305319Z","end":"2026-05-10T04:03:17.411014Z","steps":["trace[317925748] 'process raft request' (duration: 105.333112ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:03.562528Z","caller":"traceutil/trace.go:171","msg":"trace[353906759] linearizableReadLoop","detail":"{readStateIndex:4529; appliedIndex:4528; }","duration":"164.596564ms","start":"2026-05-10T04:05:03.397909Z","end":"2026-05-10T04:05:03.562506Z","steps":["trace[353906759] 'read index received' (duration: 152.612152ms)","trace[353906759] 'applied index is now lower than readState.Index' (duration: 11.982892ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:03.562721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.792718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-tls\" ","response":"range_response_count:1 size:3226"} {"level":"info","ts":"2026-05-10T04:05:03.562747Z","caller":"traceutil/trace.go:171","msg":"trace[135805183] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-tls; range_end:; response_count:1; response_revision:4355; }","duration":"164.860999ms","start":"2026-05-10T04:05:03.397877Z","end":"2026-05-10T04:05:03.562738Z","steps":["trace[135805183] 'agreement among raft nodes before linearized reading' (duration: 164.714477ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:03.562992Z","caller":"traceutil/trace.go:171","msg":"trace[356003907] transaction","detail":"{read_only:false; response_revision:4355; number_of_response:1; }","duration":"168.453229ms","start":"2026-05-10T04:05:03.394525Z","end":"2026-05-10T04:05:03.562978Z","steps":["trace[356003907] 'process raft request' (duration: 155.933437ms)","trace[356003907] 'compare' (duration: 11.773908ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:03.613116Z","caller":"traceutil/trace.go:171","msg":"trace[1542869041] transaction","detail":"{read_only:false; response_revision:4357; number_of_response:1; }","duration":"164.457301ms","start":"2026-05-10T04:05:03.448628Z","end":"2026-05-10T04:05:03.613086Z","steps":["trace[1542869041] 'process raft request' (duration: 164.353259ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:03.613125Z","caller":"traceutil/trace.go:171","msg":"trace[142348804] transaction","detail":"{read_only:false; response_revision:4356; number_of_response:1; }","duration":"176.202779ms","start":"2026-05-10T04:05:03.436895Z","end":"2026-05-10T04:05:03.613098Z","steps":["trace[142348804] 'process raft request' (duration: 175.625038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:03.720312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.093129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:05:03.720401Z","caller":"traceutil/trace.go:171","msg":"trace[440091214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4361; }","duration":"105.206821ms","start":"2026-05-10T04:05:03.615175Z","end":"2026-05-10T04:05:03.720382Z","steps":["trace[440091214] 'agreement among raft nodes before linearized reading' (duration: 105.062948ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:04.235078Z","caller":"traceutil/trace.go:171","msg":"trace[2138733508] transaction","detail":"{read_only:false; response_revision:4385; number_of_response:1; }","duration":"152.299457ms","start":"2026-05-10T04:05:04.08275Z","end":"2026-05-10T04:05:04.235049Z","steps":["trace[2138733508] 'process raft request' (duration: 101.27512ms)","trace[2138733508] 'compare' (duration: 50.902465ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:04.235534Z","caller":"traceutil/trace.go:171","msg":"trace[1879155766] linearizableReadLoop","detail":"{readStateIndex:4560; appliedIndex:4558; }","duration":"142.951546ms","start":"2026-05-10T04:05:04.092559Z","end":"2026-05-10T04:05:04.23551Z","steps":["trace[1879155766] 'read index received' (duration: 91.48055ms)","trace[1879155766] 'applied index is now lower than readState.Index' (duration: 51.470046ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:04.235649Z","caller":"traceutil/trace.go:171","msg":"trace[1741415202] transaction","detail":"{read_only:false; response_revision:4386; number_of_response:1; }","duration":"144.718421ms","start":"2026-05-10T04:05:04.09092Z","end":"2026-05-10T04:05:04.235638Z","steps":["trace[1741415202] 'process raft request' (duration: 144.491156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:04.235899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.322154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-tls\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:05:04.235948Z","caller":"traceutil/trace.go:171","msg":"trace[474313518] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-tls; range_end:; response_count:0; response_revision:4386; }","duration":"143.415725ms","start":"2026-05-10T04:05:04.092519Z","end":"2026-05-10T04:05:04.235935Z","steps":["trace[474313518] 'agreement among raft nodes before linearized reading' (duration: 143.314713ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:04.237651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.304434ms","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-10T04:05:04.237726Z","caller":"traceutil/trace.go:171","msg":"trace[172559529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4386; }","duration":"143.111299ms","start":"2026-05-10T04:05:04.094603Z","end":"2026-05-10T04:05:04.237714Z","steps":["trace[172559529] 'agreement among raft nodes before linearized reading' (duration: 141.215552ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:05.353996Z","caller":"traceutil/trace.go:171","msg":"trace[1899688358] transaction","detail":"{read_only:false; response_revision:4408; number_of_response:1; }","duration":"110.779637ms","start":"2026-05-10T04:05:05.243202Z","end":"2026-05-10T04:05:05.353982Z","steps":["trace[1899688358] 'process raft request' (duration: 110.673895ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:10.650178Z","caller":"traceutil/trace.go:171","msg":"trace[1703970183] linearizableReadLoop","detail":"{readStateIndex:4678; appliedIndex:4677; }","duration":"119.266872ms","start":"2026-05-10T04:05:10.530882Z","end":"2026-05-10T04:05:10.650149Z","steps":["trace[1703970183] 'read index received' (duration: 118.888825ms)","trace[1703970183] 'applied index is now lower than readState.Index' (duration: 377.287µs)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:10.650399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.484236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:5 size:42296"} {"level":"info","ts":"2026-05-10T04:05:10.650422Z","caller":"traceutil/trace.go:171","msg":"trace[1228687548] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:5; response_revision:4502; }","duration":"119.546327ms","start":"2026-05-10T04:05:10.53087Z","end":"2026-05-10T04:05:10.650416Z","steps":["trace[1228687548] 'agreement among raft nodes before linearized reading' (duration: 119.358824ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:10.650473Z","caller":"traceutil/trace.go:171","msg":"trace[850437597] transaction","detail":"{read_only:false; response_revision:4502; number_of_response:1; }","duration":"120.102368ms","start":"2026-05-10T04:05:10.530333Z","end":"2026-05-10T04:05:10.650435Z","steps":["trace[850437597] 'process raft request' (duration: 119.601168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.474912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.418903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-05-10T04:05:12.47498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.449079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be34b05d-079e-4220-99b8-b10c4df7fb80\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-05-10T04:05:12.475006Z","caller":"traceutil/trace.go:171","msg":"trace[213642368] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4537; }","duration":"157.561915ms","start":"2026-05-10T04:05:12.317423Z","end":"2026-05-10T04:05:12.474985Z","steps":["trace[213642368] 'range keys from in-memory index tree' (duration: 157.2457ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:12.47503Z","caller":"traceutil/trace.go:171","msg":"trace[1257245432] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-be34b05d-079e-4220-99b8-b10c4df7fb80; range_end:; response_count:1; response_revision:4537; }","duration":"255.535441ms","start":"2026-05-10T04:05:12.219481Z","end":"2026-05-10T04:05:12.475016Z","steps":["trace[1257245432] 'range keys from in-memory index tree' (duration: 255.319477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.475064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.573526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7465"} {"level":"warn","ts":"2026-05-10T04:05:12.475094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.082119ms","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-10T04:05:12.475143Z","caller":"traceutil/trace.go:171","msg":"trace[583451506] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4537; }","duration":"528.677589ms","start":"2026-05-10T04:05:11.946444Z","end":"2026-05-10T04:05:12.475121Z","steps":["trace[583451506] 'range keys from in-memory index tree' (duration: 528.432684ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:12.475171Z","caller":"traceutil/trace.go:171","msg":"trace[712922864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4537; }","duration":"154.196262ms","start":"2026-05-10T04:05:12.320954Z","end":"2026-05-10T04:05:12.475151Z","steps":["trace[712922864] 'range keys from in-memory index tree' (duration: 153.906726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.475186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:11.946432Z","time spent":"528.74431ms","remote":"127.0.0.1:38912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":1,"response size":7487,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-05-10T04:05:12.474912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.806921ms","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-10T04:05:12.475243Z","caller":"traceutil/trace.go:171","msg":"trace[261155168] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4537; }","duration":"204.199918ms","start":"2026-05-10T04:05:12.27103Z","end":"2026-05-10T04:05:12.47523Z","steps":["trace[261155168] 'range keys from in-memory index tree' (duration: 203.615657ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.475249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.07628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-be34b05d-079e-4220-99b8-b10c4df7fb80\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-05-10T04:05:12.475278Z","caller":"traceutil/trace.go:171","msg":"trace[775531069] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-be34b05d-079e-4220-99b8-b10c4df7fb80; range_end:; response_count:1; response_revision:4537; }","duration":"114.142333ms","start":"2026-05-10T04:05:12.361128Z","end":"2026-05-10T04:05:12.475271Z","steps":["trace[775531069] 'range keys from in-memory index tree' (duration: 113.977188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.47547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.56785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-10T04:05:12.475503Z","caller":"traceutil/trace.go:171","msg":"trace[307043985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4537; }","duration":"475.628272ms","start":"2026-05-10T04:05:11.999864Z","end":"2026-05-10T04:05:12.475492Z","steps":["trace[307043985] 'range keys from in-memory index tree' (duration: 475.472618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.475532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:11.999849Z","time spent":"475.675992ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-10T04:05:12.475645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.9911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b986768c-1dfd-42cd-ad5d-aac2b2d3018b\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-05-10T04:05:12.475682Z","caller":"traceutil/trace.go:171","msg":"trace[772091829] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b986768c-1dfd-42cd-ad5d-aac2b2d3018b; range_end:; response_count:1; response_revision:4537; }","duration":"475.040951ms","start":"2026-05-10T04:05:12.000629Z","end":"2026-05-10T04:05:12.47567Z","steps":["trace[772091829] 'range keys from in-memory index tree' (duration: 474.893568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.475712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.000623Z","time spent":"475.080262ms","remote":"127.0.0.1:41578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3782,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b986768c-1dfd-42cd-ad5d-aac2b2d3018b\" "} {"level":"warn","ts":"2026-05-10T04:05:12.475718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.212201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-10T04:05:12.475792Z","caller":"traceutil/trace.go:171","msg":"trace[1463781821] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4537; }","duration":"355.330542ms","start":"2026-05-10T04:05:12.120449Z","end":"2026-05-10T04:05:12.47578Z","steps":["trace[1463781821] 'range keys from in-memory index tree' (duration: 355.062238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.475824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.120428Z","time spent":"355.387594ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-10T04:05:12.476023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.009831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T04:05:12.476053Z","caller":"traceutil/trace.go:171","msg":"trace[1585831692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4537; }","duration":"475.051451ms","start":"2026-05-10T04:05:12.000992Z","end":"2026-05-10T04:05:12.476044Z","steps":["trace[1585831692] 'range keys from in-memory index tree' (duration: 474.942079ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.476078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.000986Z","time spent":"475.086112ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-10T04:05:12.476081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.278118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:05:12.476111Z","caller":"traceutil/trace.go:171","msg":"trace[1980581332] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:4537; }","duration":"388.323998ms","start":"2026-05-10T04:05:12.087778Z","end":"2026-05-10T04:05:12.476102Z","steps":["trace[1980581332] 'count revisions from in-memory index tree' (duration: 388.244636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.476139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.087771Z","time spent":"388.360719ms","remote":"127.0.0.1:41664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-05-10T04:05:12.476481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.283279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2195929"} {"level":"info","ts":"2026-05-10T04:05:12.476534Z","caller":"traceutil/trace.go:171","msg":"trace[737426665] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4537; }","duration":"291.371441ms","start":"2026-05-10T04:05:12.185147Z","end":"2026-05-10T04:05:12.476519Z","steps":["trace[737426665] 'range keys from in-memory index tree' (duration: 290.317581ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:12.718333Z","caller":"traceutil/trace.go:171","msg":"trace[1612760617] transaction","detail":"{read_only:false; response_revision:4538; number_of_response:1; }","duration":"236.796345ms","start":"2026-05-10T04:05:12.48151Z","end":"2026-05-10T04:05:12.718307Z","steps":["trace[1612760617] 'process raft request' (duration: 236.613332ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:12.956519Z","caller":"traceutil/trace.go:171","msg":"trace[2107612295] transaction","detail":"{read_only:false; response_revision:4539; number_of_response:1; }","duration":"473.409139ms","start":"2026-05-10T04:05:12.483068Z","end":"2026-05-10T04:05:12.956477Z","steps":["trace[2107612295] 'process raft request' (duration: 411.524497ms)","trace[2107612295] 'compare' (duration: 61.377583ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:12.95672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.483039Z","time spent":"473.578433ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:05:12.956794Z","caller":"traceutil/trace.go:171","msg":"trace[1547002814] transaction","detail":"{read_only:false; response_revision:4541; number_of_response:1; }","duration":"473.540702ms","start":"2026-05-10T04:05:12.483213Z","end":"2026-05-10T04:05:12.956754Z","steps":["trace[1547002814] 'process raft request' (duration: 473.178915ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:12.956972Z","caller":"traceutil/trace.go:171","msg":"trace[1687944279] transaction","detail":"{read_only:false; response_revision:4540; number_of_response:1; }","duration":"473.756516ms","start":"2026-05-10T04:05:12.483187Z","end":"2026-05-10T04:05:12.956944Z","steps":["trace[1687944279] 'process raft request' (duration: 473.083443ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.957036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.483203Z","time spent":"473.726165ms","remote":"127.0.0.1:41578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3876,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:05:12.957148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.483179Z","time spent":"473.868318ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:05:12.957669Z","caller":"traceutil/trace.go:171","msg":"trace[529812359] transaction","detail":"{read_only:false; response_revision:4542; number_of_response:1; }","duration":"474.408849ms","start":"2026-05-10T04:05:12.483243Z","end":"2026-05-10T04:05:12.957652Z","steps":["trace[529812359] 'process raft request' (duration: 473.366328ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.95779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.483236Z","time spent":"474.49642ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:05:12.957827Z","caller":"traceutil/trace.go:171","msg":"trace[597017302] linearizableReadLoop","detail":"{readStateIndex:4721; appliedIndex:4714; }","duration":"455.777206ms","start":"2026-05-10T04:05:12.502034Z","end":"2026-05-10T04:05:12.957811Z","steps":["trace[597017302] 'read index received' (duration: 216.155885ms)","trace[597017302] 'applied index is now lower than readState.Index' (duration: 239.620221ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:12.957932Z","caller":"traceutil/trace.go:171","msg":"trace[1932429113] transaction","detail":"{read_only:false; response_revision:4543; number_of_response:1; }","duration":"474.414829ms","start":"2026-05-10T04:05:12.483507Z","end":"2026-05-10T04:05:12.957922Z","steps":["trace[1932429113] 'process raft request' (duration: 474.051572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.958011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.4835Z","time spent":"474.46672ms","remote":"127.0.0.1:41692","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-10T04:05:12.958157Z","caller":"traceutil/trace.go:171","msg":"trace[244325273] transaction","detail":"{read_only:false; response_revision:4544; number_of_response:1; }","duration":"472.92051ms","start":"2026-05-10T04:05:12.485219Z","end":"2026-05-10T04:05:12.95814Z","steps":["trace[244325273] 'process raft request' (duration: 472.506752ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.958214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.627997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-10T04:05:12.958254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.213434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-05-10T04:05:12.958262Z","caller":"traceutil/trace.go:171","msg":"trace[2090064862] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:4544; }","duration":"290.713508ms","start":"2026-05-10T04:05:12.667533Z","end":"2026-05-10T04:05:12.958247Z","steps":["trace[2090064862] 'agreement among raft nodes before linearized reading' (duration: 290.655937ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:12.95834Z","caller":"traceutil/trace.go:171","msg":"trace[87171921] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4544; }","duration":"456.302385ms","start":"2026-05-10T04:05:12.50199Z","end":"2026-05-10T04:05:12.958293Z","steps":["trace[87171921] 'agreement among raft nodes before linearized reading' (duration: 456.086751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.958246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.485188Z","time spent":"473.013392ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:05:12.958382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.501968Z","time spent":"456.404347ms","remote":"127.0.0.1:41488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1843,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"warn","ts":"2026-05-10T04:05:12.958155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.59214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:05:12.958565Z","caller":"traceutil/trace.go:171","msg":"trace[509568913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4544; }","duration":"344.057948ms","start":"2026-05-10T04:05:12.614492Z","end":"2026-05-10T04:05:12.95855Z","steps":["trace[509568913] 'agreement among raft nodes before linearized reading' (duration: 343.62116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:12.958616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:12.614466Z","time spent":"344.13602ms","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-10T04:05:13.123658Z","caller":"traceutil/trace.go:171","msg":"trace[1915175002] linearizableReadLoop","detail":"{readStateIndex:4722; appliedIndex:4721; }","duration":"140.574498ms","start":"2026-05-10T04:05:12.983054Z","end":"2026-05-10T04:05:13.123628Z","steps":["trace[1915175002] 'read index received' (duration: 116.866159ms)","trace[1915175002] 'applied index is now lower than readState.Index' (duration: 23.707039ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:13.123684Z","caller":"traceutil/trace.go:171","msg":"trace[618656] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"152.148467ms","start":"2026-05-10T04:05:12.971506Z","end":"2026-05-10T04:05:13.123654Z","steps":["trace[618656] 'process raft request' (duration: 128.47474ms)","trace[618656] 'compare' (duration: 23.487694ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:13.124044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.973145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-05-10T04:05:13.124107Z","caller":"traceutil/trace.go:171","msg":"trace[232381923] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4545; }","duration":"141.073966ms","start":"2026-05-10T04:05:12.983018Z","end":"2026-05-10T04:05:13.124092Z","steps":["trace[232381923] 'agreement among raft nodes before linearized reading' (duration: 140.72313ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:13.35725Z","caller":"traceutil/trace.go:171","msg":"trace[1999921577] linearizableReadLoop","detail":"{readStateIndex:4727; appliedIndex:4726; }","duration":"130.17494ms","start":"2026-05-10T04:05:13.227054Z","end":"2026-05-10T04:05:13.357229Z","steps":["trace[1999921577] 'read index received' (duration: 129.933465ms)","trace[1999921577] 'applied index is now lower than readState.Index' (duration: 240.685µs)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:13.357371Z","caller":"traceutil/trace.go:171","msg":"trace[708675160] transaction","detail":"{read_only:false; response_revision:4550; number_of_response:1; }","duration":"138.69312ms","start":"2026-05-10T04:05:13.218667Z","end":"2026-05-10T04:05:13.35736Z","steps":["trace[708675160] 'process raft request' (duration: 138.444886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:13.357714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.474325ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"warn","ts":"2026-05-10T04:05:13.357759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.94328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:05:13.357829Z","caller":"traceutil/trace.go:171","msg":"trace[455948232] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:4550; }","duration":"117.065293ms","start":"2026-05-10T04:05:13.240745Z","end":"2026-05-10T04:05:13.357811Z","steps":["trace[455948232] 'agreement among raft nodes before linearized reading' (duration: 116.95128ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:13.357781Z","caller":"traceutil/trace.go:171","msg":"trace[528905089] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4550; }","duration":"130.728951ms","start":"2026-05-10T04:05:13.227037Z","end":"2026-05-10T04:05:13.357766Z","steps":["trace[528905089] 'agreement among raft nodes before linearized reading' (duration: 130.426964ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:16.250283Z","caller":"traceutil/trace.go:171","msg":"trace[796805663] transaction","detail":"{read_only:false; response_revision:4579; number_of_response:1; }","duration":"139.118689ms","start":"2026-05-10T04:05:16.111144Z","end":"2026-05-10T04:05:16.250263Z","steps":["trace[796805663] 'process raft request' (duration: 138.999217ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:18.881508Z","caller":"traceutil/trace.go:171","msg":"trace[1027784560] linearizableReadLoop","detail":"{readStateIndex:4832; appliedIndex:4831; }","duration":"134.823896ms","start":"2026-05-10T04:05:18.746666Z","end":"2026-05-10T04:05:18.88149Z","steps":["trace[1027784560] 'read index received' (duration: 134.683123ms)","trace[1027784560] 'applied index is now lower than readState.Index' (duration: 139.973µs)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:18.881679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.004009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-05-10T04:05:18.881733Z","caller":"traceutil/trace.go:171","msg":"trace[1134053670] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4650; }","duration":"135.121051ms","start":"2026-05-10T04:05:18.746605Z","end":"2026-05-10T04:05:18.881726Z","steps":["trace[1134053670] 'agreement among raft nodes before linearized reading' (duration: 134.953428ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:18.881809Z","caller":"traceutil/trace.go:171","msg":"trace[1748077166] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"139.422301ms","start":"2026-05-10T04:05:18.742353Z","end":"2026-05-10T04:05:18.881775Z","steps":["trace[1748077166] 'process raft request' (duration: 139.015024ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.223224Z","caller":"traceutil/trace.go:171","msg":"trace[1932788734] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"199.35191ms","start":"2026-05-10T04:05:19.023843Z","end":"2026-05-10T04:05:19.223195Z","steps":["trace[1932788734] 'process raft request' (duration: 198.442923ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.243779Z","caller":"traceutil/trace.go:171","msg":"trace[753763026] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"219.838122ms","start":"2026-05-10T04:05:19.023862Z","end":"2026-05-10T04:05:19.2437Z","steps":["trace[753763026] 'process raft request' (duration: 219.403583ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.244207Z","caller":"traceutil/trace.go:171","msg":"trace[1893869119] transaction","detail":"{read_only:false; response_revision:4654; number_of_response:1; }","duration":"219.520696ms","start":"2026-05-10T04:05:19.023998Z","end":"2026-05-10T04:05:19.243519Z","steps":["trace[1893869119] 'process raft request' (duration: 219.419704ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.244557Z","caller":"traceutil/trace.go:171","msg":"trace[798163984] transaction","detail":"{read_only:false; response_revision:4655; number_of_response:1; }","duration":"219.110447ms","start":"2026-05-10T04:05:19.025426Z","end":"2026-05-10T04:05:19.244537Z","steps":["trace[798163984] 'process raft request' (duration: 218.051448ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.244973Z","caller":"traceutil/trace.go:171","msg":"trace[223729563] linearizableReadLoop","detail":"{readStateIndex:4838; appliedIndex:4833; }","duration":"125.945924ms","start":"2026-05-10T04:05:19.119008Z","end":"2026-05-10T04:05:19.244954Z","steps":["trace[223729563] 'read index received' (duration: 103.279892ms)","trace[223729563] 'applied index is now lower than readState.Index' (duration: 22.664692ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:19.245171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.069016ms","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-10T04:05:19.245095Z","caller":"traceutil/trace.go:171","msg":"trace[111607448] transaction","detail":"{read_only:false; response_revision:4656; number_of_response:1; }","duration":"219.475014ms","start":"2026-05-10T04:05:19.025559Z","end":"2026-05-10T04:05:19.245034Z","steps":["trace[111607448] 'process raft request' (duration: 219.22408ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.245227Z","caller":"traceutil/trace.go:171","msg":"trace[1187701223] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4656; }","duration":"126.25174ms","start":"2026-05-10T04:05:19.118957Z","end":"2026-05-10T04:05:19.245209Z","steps":["trace[1187701223] 'agreement among raft nodes before linearized reading' (duration: 126.066076ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.882226Z","caller":"traceutil/trace.go:171","msg":"trace[980057043] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"194.713165ms","start":"2026-05-10T04:05:19.687489Z","end":"2026-05-10T04:05:19.882202Z","steps":["trace[980057043] 'process raft request' (duration: 194.589943ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.882696Z","caller":"traceutil/trace.go:171","msg":"trace[2085044787] linearizableReadLoop","detail":"{readStateIndex:4861; appliedIndex:4861; }","duration":"157.188816ms","start":"2026-05-10T04:05:19.725495Z","end":"2026-05-10T04:05:19.882684Z","steps":["trace[2085044787] 'read index received' (duration: 157.183296ms)","trace[2085044787] 'applied index is now lower than readState.Index' (duration: 4.63µs)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:19.883077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.343417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-05-10T04:05:19.883116Z","caller":"traceutil/trace.go:171","msg":"trace[1300408787] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4679; }","duration":"209.416487ms","start":"2026-05-10T04:05:19.67369Z","end":"2026-05-10T04:05:19.883107Z","steps":["trace[1300408787] 'agreement among raft nodes before linearized reading' (duration: 209.139792ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:19.884205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.82896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4849"} {"level":"info","ts":"2026-05-10T04:05:19.884234Z","caller":"traceutil/trace.go:171","msg":"trace[965370160] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"103.053978ms","start":"2026-05-10T04:05:19.781143Z","end":"2026-05-10T04:05:19.884197Z","steps":["trace[965370160] 'process raft request' (duration: 102.722432ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:19.884267Z","caller":"traceutil/trace.go:171","msg":"trace[1637606500] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4680; }","duration":"134.959432ms","start":"2026-05-10T04:05:19.749293Z","end":"2026-05-10T04:05:19.884253Z","steps":["trace[1637606500] 'agreement among raft nodes before linearized reading' (duration: 134.764829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:19.884684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.070425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:72 size:60099"} {"level":"info","ts":"2026-05-10T04:05:19.884723Z","caller":"traceutil/trace.go:171","msg":"trace[508602982] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:72; response_revision:4680; }","duration":"134.129346ms","start":"2026-05-10T04:05:19.750586Z","end":"2026-05-10T04:05:19.884716Z","steps":["trace[508602982] 'agreement among raft nodes before linearized reading' (duration: 133.698138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:20.422524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.807458ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:05:20.42263Z","caller":"traceutil/trace.go:171","msg":"trace[1478863888] linearizableReadLoop","detail":"{readStateIndex:4865; appliedIndex:4864; }","duration":"498.645991ms","start":"2026-05-10T04:05:19.923968Z","end":"2026-05-10T04:05:20.422614Z","steps":["trace[1478863888] 'read index received' (duration: 144.754811ms)","trace[1478863888] 'applied index is now lower than readState.Index' (duration: 353.88992ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:20.422698Z","caller":"traceutil/trace.go:171","msg":"trace[1010898072] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"499.060559ms","start":"2026-05-10T04:05:19.923627Z","end":"2026-05-10T04:05:20.422687Z","steps":["trace[1010898072] 'process raft request' (duration: 145.002396ms)","trace[1010898072] 'compare' (duration: 353.529683ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:20.422753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:19.92361Z","time spent":"499.119001ms","remote":"127.0.0.1:41468","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":737,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-10T04:05:20.423188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.194802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:72 size:60099"} {"level":"info","ts":"2026-05-10T04:05:20.423259Z","caller":"traceutil/trace.go:171","msg":"trace[1809426870] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:72; response_revision:4683; }","duration":"499.287844ms","start":"2026-05-10T04:05:19.923953Z","end":"2026-05-10T04:05:20.423241Z","steps":["trace[1809426870] 'agreement among raft nodes before linearized reading' (duration: 498.732443ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:20.423305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:19.923946Z","time spent":"499.348015ms","remote":"127.0.0.1:41778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":72,"response size":60121,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" "} {"level":"info","ts":"2026-05-10T04:05:20.60022Z","caller":"traceutil/trace.go:171","msg":"trace[858024719] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"669.116666ms","start":"2026-05-10T04:05:19.931059Z","end":"2026-05-10T04:05:20.600176Z","steps":["trace[858024719] 'process raft request' (duration: 625.708419ms)","trace[858024719] 'compare' (duration: 42.819776ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:20.600352Z","caller":"traceutil/trace.go:171","msg":"trace[536321505] linearizableReadLoop","detail":"{readStateIndex:4867; appliedIndex:4865; }","duration":"177.664109ms","start":"2026-05-10T04:05:20.422658Z","end":"2026-05-10T04:05:20.600322Z","steps":["trace[536321505] 'read index received' (duration: 134.10941ms)","trace[536321505] 'applied index is now lower than readState.Index' (duration: 43.552799ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:20.600457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:19.931047Z","time spent":"669.295769ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:05:20.600562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.578763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-gxtx5\" ","response":"range_response_count:1 size:9871"} {"level":"info","ts":"2026-05-10T04:05:20.600669Z","caller":"traceutil/trace.go:171","msg":"trace[482405654] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-gxtx5; range_end:; response_count:1; response_revision:4685; }","duration":"291.728676ms","start":"2026-05-10T04:05:20.308922Z","end":"2026-05-10T04:05:20.60065Z","steps":["trace[482405654] 'agreement among raft nodes before linearized reading' (duration: 291.443741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:20.600812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.886531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-05-10T04:05:20.600888Z","caller":"traceutil/trace.go:171","msg":"trace[1701752429] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:4685; }","duration":"493.016623ms","start":"2026-05-10T04:05:20.107855Z","end":"2026-05-10T04:05:20.600872Z","steps":["trace[1701752429] 'agreement among raft nodes before linearized reading' (duration: 492.555945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:20.600936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:20.107837Z","time spent":"493.090244ms","remote":"127.0.0.1:41468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":441,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-10T04:05:20.601248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.510598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/rabbitmq-cluster-operator-openstack\" ","response":"range_response_count:1 size:1874"} {"level":"info","ts":"2026-05-10T04:05:20.601545Z","caller":"traceutil/trace.go:171","msg":"trace[1131333188] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"663.403868ms","start":"2026-05-10T04:05:19.938129Z","end":"2026-05-10T04:05:20.601532Z","steps":["trace[1131333188] 'process raft request' (duration: 661.892411ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:20.601585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.671993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-gxtx5.18ae1892415ef031\" ","response":"range_response_count:1 size:962"} {"level":"warn","ts":"2026-05-10T04:05:20.60162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:19.938113Z","time spent":"663.470709ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:05:20.601629Z","caller":"traceutil/trace.go:171","msg":"trace[1685860852] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-gxtx5.18ae1892415ef031; range_end:; response_count:1; response_revision:4685; }","duration":"292.743455ms","start":"2026-05-10T04:05:20.308875Z","end":"2026-05-10T04:05:20.601618Z","steps":["trace[1685860852] 'agreement among raft nodes before linearized reading' (duration: 291.976931ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:20.601704Z","caller":"traceutil/trace.go:171","msg":"trace[1221720692] range","detail":"{range_begin:/registry/clusterroles/rabbitmq-cluster-operator-openstack; range_end:; response_count:1; response_revision:4685; }","duration":"175.884795ms","start":"2026-05-10T04:05:20.425677Z","end":"2026-05-10T04:05:20.601562Z","steps":["trace[1221720692] 'agreement among raft nodes before linearized reading' (duration: 175.391196ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:20.601483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"677.167335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-05-10T04:05:20.601963Z","caller":"traceutil/trace.go:171","msg":"trace[2102247509] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4685; }","duration":"677.694785ms","start":"2026-05-10T04:05:19.924253Z","end":"2026-05-10T04:05:20.601948Z","steps":["trace[2102247509] 'agreement among raft nodes before linearized reading' (duration: 677.068193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:20.60234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:19.924206Z","time spent":"677.783396ms","remote":"127.0.0.1:41488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":1,"response size":672,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" "} {"level":"warn","ts":"2026-05-10T04:05:20.603121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.817904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-05-10T04:05:20.603876Z","caller":"traceutil/trace.go:171","msg":"trace[1596656905] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4685; }","duration":"674.078727ms","start":"2026-05-10T04:05:19.929773Z","end":"2026-05-10T04:05:20.603852Z","steps":["trace[1596656905] 'agreement among raft nodes before linearized reading' (duration: 670.915259ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:20.603943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:19.929764Z","time spent":"674.163029ms","remote":"127.0.0.1:41488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1843,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "} {"level":"info","ts":"2026-05-10T04:05:22.085759Z","caller":"traceutil/trace.go:171","msg":"trace[578038027] transaction","detail":"{read_only:false; response_revision:4731; number_of_response:1; }","duration":"193.317046ms","start":"2026-05-10T04:05:21.89241Z","end":"2026-05-10T04:05:22.085727Z","steps":["trace[578038027] 'process raft request' (duration: 193.126382ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:26.568726Z","caller":"traceutil/trace.go:171","msg":"trace[1115683468] transaction","detail":"{read_only:false; response_revision:4775; number_of_response:1; }","duration":"348.943964ms","start":"2026-05-10T04:05:26.219736Z","end":"2026-05-10T04:05:26.56868Z","steps":["trace[1115683468] 'process raft request' (duration: 332.381322ms)","trace[1115683468] 'compare' (duration: 16.285107ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:26.568933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.219681Z","time spent":"349.138227ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:05:26.575901Z","caller":"traceutil/trace.go:171","msg":"trace[2109059798] linearizableReadLoop","detail":"{readStateIndex:4960; appliedIndex:4958; }","duration":"209.643376ms","start":"2026-05-10T04:05:26.366221Z","end":"2026-05-10T04:05:26.575865Z","steps":["trace[2109059798] 'read index received' (duration: 185.798029ms)","trace[2109059798] 'applied index is now lower than readState.Index' (duration: 23.844017ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:26.575923Z","caller":"traceutil/trace.go:171","msg":"trace[1043115721] transaction","detail":"{read_only:false; response_revision:4776; number_of_response:1; }","duration":"209.758068ms","start":"2026-05-10T04:05:26.366127Z","end":"2026-05-10T04:05:26.575885Z","steps":["trace[1043115721] 'process raft request' (duration: 209.522664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:26.576241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.599925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-76c67cfc6f-24hcm.18ae1893a9eeb040\" ","response":"range_response_count:1 size:898"} {"level":"info","ts":"2026-05-10T04:05:26.57631Z","caller":"traceutil/trace.go:171","msg":"trace[413966276] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-76c67cfc6f-24hcm.18ae1893a9eeb040; range_end:; response_count:1; response_revision:4776; }","duration":"209.705656ms","start":"2026-05-10T04:05:26.36659Z","end":"2026-05-10T04:05:26.576295Z","steps":["trace[413966276] 'agreement among raft nodes before linearized reading' (duration: 209.459202ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:26.576407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.029932ms","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-10T04:05:26.576471Z","caller":"traceutil/trace.go:171","msg":"trace[1351621101] 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:4776; }","duration":"134.090733ms","start":"2026-05-10T04:05:26.442359Z","end":"2026-05-10T04:05:26.57645Z","steps":["trace[1351621101] 'agreement among raft nodes before linearized reading' (duration: 133.960681ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:26.576259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.021982ms","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-10T04:05:26.576574Z","caller":"traceutil/trace.go:171","msg":"trace[584451340] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4776; }","duration":"210.369939ms","start":"2026-05-10T04:05:26.366183Z","end":"2026-05-10T04:05:26.576553Z","steps":["trace[584451340] 'agreement among raft nodes before linearized reading' (duration: 209.798969ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:26.732629Z","caller":"traceutil/trace.go:171","msg":"trace[241494795] linearizableReadLoop","detail":"{readStateIndex:4963; appliedIndex:4961; }","duration":"126.539375ms","start":"2026-05-10T04:05:26.606066Z","end":"2026-05-10T04:05:26.732605Z","steps":["trace[241494795] 'read index received' (duration: 74.190307ms)","trace[241494795] 'applied index is now lower than readState.Index' (duration: 52.348108ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:26.732736Z","caller":"traceutil/trace.go:171","msg":"trace[1842585652] transaction","detail":"{read_only:false; response_revision:4778; number_of_response:1; }","duration":"153.111232ms","start":"2026-05-10T04:05:26.579614Z","end":"2026-05-10T04:05:26.732726Z","steps":["trace[1842585652] 'process raft request' (duration: 100.704152ms)","trace[1842585652] 'compare' (duration: 51.969142ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:26.733113Z","caller":"traceutil/trace.go:171","msg":"trace[147969066] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"140.653303ms","start":"2026-05-10T04:05:26.592415Z","end":"2026-05-10T04:05:26.733068Z","steps":["trace[147969066] 'process raft request' (duration: 140.041432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:26.733273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.202924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-10T04:05:26.733383Z","caller":"traceutil/trace.go:171","msg":"trace[174548799] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4779; }","duration":"152.469759ms","start":"2026-05-10T04:05:26.580888Z","end":"2026-05-10T04:05:26.733358Z","steps":["trace[174548799] 'agreement among raft nodes before linearized reading' (duration: 152.175244ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:27.044531Z","caller":"traceutil/trace.go:171","msg":"trace[1752228862] linearizableReadLoop","detail":"{readStateIndex:4966; appliedIndex:4963; }","duration":"311.805873ms","start":"2026-05-10T04:05:26.732694Z","end":"2026-05-10T04:05:27.0445Z","steps":["trace[1752228862] 'read index received' (duration: 228.586522ms)","trace[1752228862] 'applied index is now lower than readState.Index' (duration: 83.217971ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:27.044651Z","caller":"traceutil/trace.go:171","msg":"trace[1919264659] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"302.177917ms","start":"2026-05-10T04:05:26.742462Z","end":"2026-05-10T04:05:27.04464Z","steps":["trace[1919264659] 'process raft request' (duration: 301.864801ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:27.044667Z","caller":"traceutil/trace.go:171","msg":"trace[1101929488] transaction","detail":"{read_only:false; response_revision:4781; number_of_response:1; }","duration":"341.736011ms","start":"2026-05-10T04:05:26.702899Z","end":"2026-05-10T04:05:27.044635Z","steps":["trace[1101929488] 'process raft request' (duration: 341.288713ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:27.044766Z","caller":"traceutil/trace.go:171","msg":"trace[1954588834] transaction","detail":"{read_only:false; response_revision:4786; number_of_response:1; }","duration":"301.106987ms","start":"2026-05-10T04:05:26.74363Z","end":"2026-05-10T04:05:27.044737Z","steps":["trace[1954588834] 'process raft request' (duration: 300.834012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:27.044762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.742443Z","time spent":"302.241748ms","remote":"127.0.0.1:41694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1852,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:05:27.044834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.702868Z","time spent":"341.872893ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:05:27.044976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.679997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:05:27.044968Z","caller":"traceutil/trace.go:171","msg":"trace[1629059792] transaction","detail":"{read_only:false; response_revision:4782; number_of_response:1; }","duration":"336.491055ms","start":"2026-05-10T04:05:26.708459Z","end":"2026-05-10T04:05:27.04495Z","steps":["trace[1629059792] 'process raft request' (duration: 335.819983ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:27.045016Z","caller":"traceutil/trace.go:171","msg":"trace[373475342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4786; }","duration":"430.766559ms","start":"2026-05-10T04:05:26.614239Z","end":"2026-05-10T04:05:27.045005Z","steps":["trace[373475342] 'agreement among raft nodes before linearized reading' (duration: 430.704828ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:27.045061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.614217Z","time spent":"430.8378ms","remote":"127.0.0.1:41386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-10T04:05:27.045092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.708445Z","time spent":"336.570886ms","remote":"127.0.0.1:41578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:05:27.04512Z","caller":"traceutil/trace.go:171","msg":"trace[208978812] transaction","detail":"{read_only:false; response_revision:4780; number_of_response:1; }","duration":"344.717925ms","start":"2026-05-10T04:05:26.700393Z","end":"2026-05-10T04:05:27.045111Z","steps":["trace[208978812] 'process raft request' (duration: 260.876353ms)","trace[208978812] 'compare' (duration: 82.407456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:27.045156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.700362Z","time spent":"344.776137ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:05:27.045342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.988621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9425"} {"level":"info","ts":"2026-05-10T04:05:27.045392Z","caller":"traceutil/trace.go:171","msg":"trace[220094966] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4786; }","duration":"310.071471ms","start":"2026-05-10T04:05:26.735311Z","end":"2026-05-10T04:05:27.045382Z","steps":["trace[220094966] 'agreement among raft nodes before linearized reading' (duration: 309.930699ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:27.045425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.735294Z","time spent":"310.125492ms","remote":"127.0.0.1:41576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":9447,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-10T04:05:27.045487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.435358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-10T04:05:27.045532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.251047ms","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-10T04:05:27.045532Z","caller":"traceutil/trace.go:171","msg":"trace[1987623147] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4786; }","duration":"112.52427ms","start":"2026-05-10T04:05:26.932997Z","end":"2026-05-10T04:05:27.045521Z","steps":["trace[1987623147] 'agreement among raft nodes before linearized reading' (duration: 112.394178ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:27.045566Z","caller":"traceutil/trace.go:171","msg":"trace[1913659044] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4786; }","duration":"303.3995ms","start":"2026-05-10T04:05:26.742159Z","end":"2026-05-10T04:05:27.045558Z","steps":["trace[1913659044] 'agreement among raft nodes before linearized reading' (duration: 303.331228ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:27.04559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.742131Z","time spent":"303.454641ms","remote":"127.0.0.1:51170","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":29,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-05-10T04:05:27.045747Z","caller":"traceutil/trace.go:171","msg":"trace[1041622790] transaction","detail":"{read_only:false; response_revision:4785; number_of_response:1; }","duration":"302.523583ms","start":"2026-05-10T04:05:26.743214Z","end":"2026-05-10T04:05:27.045738Z","steps":["trace[1041622790] 'process raft request' (duration: 301.215458ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:27.045747Z","caller":"traceutil/trace.go:171","msg":"trace[327299972] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"302.768758ms","start":"2026-05-10T04:05:26.742967Z","end":"2026-05-10T04:05:27.045736Z","steps":["trace[327299972] 'process raft request' (duration: 301.407812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:27.045787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.743192Z","time spent":"302.574844ms","remote":"127.0.0.1:41694","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1392,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:05:27.045837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.742961Z","time spent":"302.839629ms","remote":"127.0.0.1:41568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-10T04:05:27.046229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:26.743623Z","time spent":"301.223159ms","remote":"127.0.0.1:41568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1272,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:05:27.240822Z","caller":"traceutil/trace.go:171","msg":"trace[747708561] linearizableReadLoop","detail":"{readStateIndex:4973; appliedIndex:4972; }","duration":"124.605273ms","start":"2026-05-10T04:05:27.116199Z","end":"2026-05-10T04:05:27.240804Z","steps":["trace[747708561] 'read index received' (duration: 73.613813ms)","trace[747708561] 'applied index is now lower than readState.Index' (duration: 50.99078ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:27.240937Z","caller":"traceutil/trace.go:171","msg":"trace[536405008] transaction","detail":"{read_only:false; response_revision:4789; number_of_response:1; }","duration":"163.546895ms","start":"2026-05-10T04:05:27.077348Z","end":"2026-05-10T04:05:27.240895Z","steps":["trace[536405008] 'process raft request' (duration: 113.4208ms)","trace[536405008] 'compare' (duration: 49.964532ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:27.241198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.977241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:05:27.241807Z","caller":"traceutil/trace.go:171","msg":"trace[1341883687] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4789; }","duration":"125.640273ms","start":"2026-05-10T04:05:27.11615Z","end":"2026-05-10T04:05:27.24179Z","steps":["trace[1341883687] 'agreement among raft nodes before linearized reading' (duration: 124.96979ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:27.241268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.587267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-10T04:05:27.242046Z","caller":"traceutil/trace.go:171","msg":"trace[1220329202] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4789; }","duration":"107.387961ms","start":"2026-05-10T04:05:27.134645Z","end":"2026-05-10T04:05:27.242033Z","steps":["trace[1220329202] 'agreement among raft nodes before linearized reading' (duration: 106.419363ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:28.445703Z","caller":"traceutil/trace.go:171","msg":"trace[1751039554] transaction","detail":"{read_only:false; response_revision:4802; number_of_response:1; }","duration":"299.475872ms","start":"2026-05-10T04:05:28.146207Z","end":"2026-05-10T04:05:28.445683Z","steps":["trace[1751039554] 'process raft request' (duration: 299.34283ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:28.449873Z","caller":"traceutil/trace.go:171","msg":"trace[127007651] transaction","detail":"{read_only:false; response_revision:4803; number_of_response:1; }","duration":"217.580912ms","start":"2026-05-10T04:05:28.232257Z","end":"2026-05-10T04:05:28.449838Z","steps":["trace[127007651] 'process raft request' (duration: 217.326578ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:36.074588Z","caller":"traceutil/trace.go:171","msg":"trace[1066264463] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"112.672435ms","start":"2026-05-10T04:05:35.961873Z","end":"2026-05-10T04:05:36.074545Z","steps":["trace[1066264463] 'process raft request' (duration: 112.42928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:39.994917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.900865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-10T04:05:39.995036Z","caller":"traceutil/trace.go:171","msg":"trace[46469388] transaction","detail":"{read_only:false; response_revision:4937; number_of_response:1; }","duration":"430.808188ms","start":"2026-05-10T04:05:39.564207Z","end":"2026-05-10T04:05:39.995015Z","steps":["trace[46469388] 'process raft request' (duration: 291.72176ms)","trace[46469388] 'compare' (duration: 138.756032ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:39.995106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-10T04:05:39.564164Z","time spent":"430.905989ms","remote":"127.0.0.1:41692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-10T04:05:40.677808Z","caller":"traceutil/trace.go:171","msg":"trace[1810551544] linearizableReadLoop","detail":"{readStateIndex:5127; appliedIndex:5126; }","duration":"169.361361ms","start":"2026-05-10T04:05:40.508427Z","end":"2026-05-10T04:05:40.677788Z","steps":["trace[1810551544] 'read index received' (duration: 128.605258ms)","trace[1810551544] 'applied index is now lower than readState.Index' (duration: 40.755223ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:40.677909Z","caller":"traceutil/trace.go:171","msg":"trace[125371744] transaction","detail":"{read_only:false; response_revision:4938; number_of_response:1; }","duration":"180.865984ms","start":"2026-05-10T04:05:40.497034Z","end":"2026-05-10T04:05:40.6779Z","steps":["trace[125371744] 'process raft request' (duration: 140.0403ms)","trace[125371744] 'compare' (duration: 40.62409ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:40.678247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.819088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-05-10T04:05:40.678283Z","caller":"traceutil/trace.go:171","msg":"trace[1896833290] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4938; }","duration":"169.89577ms","start":"2026-05-10T04:05:40.508378Z","end":"2026-05-10T04:05:40.678274Z","steps":["trace[1896833290] 'agreement among raft nodes before linearized reading' (duration: 169.782578ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:41.303192Z","caller":"traceutil/trace.go:171","msg":"trace[1903284575] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"204.575285ms","start":"2026-05-10T04:05:41.098589Z","end":"2026-05-10T04:05:41.303164Z","steps":["trace[1903284575] 'process raft request' (duration: 204.217089ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:05:41.329785Z","caller":"traceutil/trace.go:171","msg":"trace[1789307069] linearizableReadLoop","detail":"{readStateIndex:5130; appliedIndex:5127; }","duration":"180.408039ms","start":"2026-05-10T04:05:41.149354Z","end":"2026-05-10T04:05:41.329762Z","steps":["trace[1789307069] 'read index received' (duration: 60.460639ms)","trace[1789307069] 'applied index is now lower than readState.Index' (duration: 119.9462ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:05:41.329907Z","caller":"traceutil/trace.go:171","msg":"trace[682734212] transaction","detail":"{read_only:false; response_revision:4940; number_of_response:1; }","duration":"230.252239ms","start":"2026-05-10T04:05:41.099621Z","end":"2026-05-10T04:05:41.329874Z","steps":["trace[682734212] 'process raft request' (duration: 203.524486ms)","trace[682734212] 'compare' (duration: 26.503749ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:05:41.330041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.657413ms","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-10T04:05:41.330123Z","caller":"traceutil/trace.go:171","msg":"trace[617204160] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4940; }","duration":"180.809796ms","start":"2026-05-10T04:05:41.149297Z","end":"2026-05-10T04:05:41.330107Z","steps":["trace[617204160] 'agreement among raft nodes before linearized reading' (duration: 180.610452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:05:41.554063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.960557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-10T04:05:41.554155Z","caller":"traceutil/trace.go:171","msg":"trace[2031983151] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4942; }","duration":"113.1347ms","start":"2026-05-10T04:05:41.440991Z","end":"2026-05-10T04:05:41.554126Z","steps":["trace[2031983151] 'range keys from in-memory index tree' (duration: 112.499719ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:06:22.015327Z","caller":"traceutil/trace.go:171","msg":"trace[1024864889] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"127.207447ms","start":"2026-05-10T04:06:21.888094Z","end":"2026-05-10T04:06:22.015301Z","steps":["trace[1024864889] 'process raft request' (duration: 124.236229ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:06:22.015633Z","caller":"traceutil/trace.go:171","msg":"trace[1376044710] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"127.503871ms","start":"2026-05-10T04:06:21.888114Z","end":"2026-05-10T04:06:22.015618Z","steps":["trace[1376044710] 'process raft request' (duration: 127.136145ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:06:22.015599Z","caller":"traceutil/trace.go:171","msg":"trace[1568882036] linearizableReadLoop","detail":"{readStateIndex:5500; appliedIndex:5498; }","duration":"105.181986ms","start":"2026-05-10T04:06:21.910388Z","end":"2026-05-10T04:06:22.01557Z","steps":["trace[1568882036] 'read index received' (duration: 101.888083ms)","trace[1568882036] 'applied index is now lower than readState.Index' (duration: 3.261063ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:06:22.015895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.44163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-10T04:06:22.015969Z","caller":"traceutil/trace.go:171","msg":"trace[426659664] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:5300; }","duration":"105.595793ms","start":"2026-05-10T04:06:21.910359Z","end":"2026-05-10T04:06:22.015954Z","steps":["trace[426659664] 'agreement among raft nodes before linearized reading' (duration: 105.307659ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:06:29.801323Z","caller":"traceutil/trace.go:171","msg":"trace[72135118] transaction","detail":"{read_only:false; response_revision:5361; number_of_response:1; }","duration":"144.121442ms","start":"2026-05-10T04:06:29.657173Z","end":"2026-05-10T04:06:29.801294Z","steps":["trace[72135118] 'process raft request' (duration: 143.914918ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:06:29.801914Z","caller":"traceutil/trace.go:171","msg":"trace[105987936] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"142.136239ms","start":"2026-05-10T04:06:29.65975Z","end":"2026-05-10T04:06:29.801886Z","steps":["trace[105987936] 'process raft request' (duration: 141.996017ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:06:34.122332Z","caller":"traceutil/trace.go:171","msg":"trace[179674840] linearizableReadLoop","detail":"{readStateIndex:5587; appliedIndex:5585; }","duration":"235.642217ms","start":"2026-05-10T04:06:33.886586Z","end":"2026-05-10T04:06:34.122228Z","steps":["trace[179674840] 'read index received' (duration: 13.960014ms)","trace[179674840] 'applied index is now lower than readState.Index' (duration: 221.680853ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:06:34.122362Z","caller":"traceutil/trace.go:171","msg":"trace[1634807621] transaction","detail":"{read_only:false; response_revision:5385; number_of_response:1; }","duration":"243.798378ms","start":"2026-05-10T04:06:33.878522Z","end":"2026-05-10T04:06:34.122321Z","steps":["trace[1634807621] 'process raft request' (duration: 216.536172ms)","trace[1634807621] 'compare' (duration: 27.038622ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:06:34.122556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.951622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-10T04:06:34.122616Z","caller":"traceutil/trace.go:171","msg":"trace[143630655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5385; }","duration":"236.030213ms","start":"2026-05-10T04:06:33.886571Z","end":"2026-05-10T04:06:34.122602Z","steps":["trace[143630655] 'agreement among raft nodes before linearized reading' (duration: 235.889771ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:06:34.122905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.053139ms","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-10T04:06:34.122999Z","caller":"traceutil/trace.go:171","msg":"trace[349639635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5385; }","duration":"212.183281ms","start":"2026-05-10T04:06:33.910797Z","end":"2026-05-10T04:06:34.12298Z","steps":["trace[349639635] 'agreement among raft nodes before linearized reading' (duration: 211.935547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:06:34.123081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.678326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-10T04:06:34.123124Z","caller":"traceutil/trace.go:171","msg":"trace[1999068809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5385; }","duration":"193.741547ms","start":"2026-05-10T04:06:33.929372Z","end":"2026-05-10T04:06:34.123114Z","steps":["trace[1999068809] 'agreement among raft nodes before linearized reading' (duration: 193.588245ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:06:52.892554Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2871} {"level":"info","ts":"2026-05-10T04:06:52.981158Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2871,"took":"87.134364ms","hash":3616396703,"current-db-size-bytes":52596736,"current-db-size":"53 MB","current-db-size-in-use-bytes":28782592,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-10T04:06:52.981235Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3616396703,"revision":2871,"compact-revision":-1} {"level":"info","ts":"2026-05-10T04:09:14.868829Z","caller":"traceutil/trace.go:171","msg":"trace[1218858462] transaction","detail":"{read_only:false; response_revision:6505; number_of_response:1; }","duration":"126.684505ms","start":"2026-05-10T04:09:14.742114Z","end":"2026-05-10T04:09:14.868799Z","steps":["trace[1218858462] 'process raft request' (duration: 126.363881ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:09:17.337262Z","caller":"traceutil/trace.go:171","msg":"trace[2132464690] transaction","detail":"{read_only:false; response_revision:6519; number_of_response:1; }","duration":"131.440928ms","start":"2026-05-10T04:09:17.205782Z","end":"2026-05-10T04:09:17.337222Z","steps":["trace[2132464690] 'process raft request' (duration: 131.127274ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:09:17.388368Z","caller":"traceutil/trace.go:171","msg":"trace[1952791111] transaction","detail":"{read_only:false; response_revision:6520; number_of_response:1; }","duration":"182.36097ms","start":"2026-05-10T04:09:17.205983Z","end":"2026-05-10T04:09:17.388344Z","steps":["trace[1952791111] 'process raft request' (duration: 182.218518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-10T04:09:37.826693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.158416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-10T04:09:37.826789Z","caller":"traceutil/trace.go:171","msg":"trace[204016665] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:6680; }","duration":"128.327958ms","start":"2026-05-10T04:09:37.698443Z","end":"2026-05-10T04:09:37.826771Z","steps":["trace[204016665] 'count revisions from in-memory index tree' (duration: 128.037004ms)"],"step_count":1} {"level":"info","ts":"2026-05-10T04:11:52.899321Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5539} {"level":"info","ts":"2026-05-10T04:11:52.97388Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5539,"took":"70.928489ms","hash":3210304277,"current-db-size-bytes":52596736,"current-db-size":"53 MB","current-db-size-in-use-bytes":18378752,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-10T04:11:52.973942Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3210304277,"revision":5539,"compact-revision":2871} {"level":"info","ts":"2026-05-10T04:12:13.138707Z","caller":"traceutil/trace.go:171","msg":"trace[1628445472] linearizableReadLoop","detail":"{readStateIndex:7773; appliedIndex:7772; }","duration":"110.570211ms","start":"2026-05-10T04:12:13.028099Z","end":"2026-05-10T04:12:13.13867Z","steps":["trace[1628445472] 'read index received' (duration: 75.184432ms)","trace[1628445472] 'applied index is now lower than readState.Index' (duration: 35.384379ms)"],"step_count":2} {"level":"info","ts":"2026-05-10T04:12:13.138777Z","caller":"traceutil/trace.go:171","msg":"trace[726004521] transaction","detail":"{read_only:false; response_revision:7493; number_of_response:1; }","duration":"112.899171ms","start":"2026-05-10T04:12:13.025852Z","end":"2026-05-10T04:12:13.138751Z","steps":["trace[726004521] 'process raft request' (duration: 77.520883ms)","trace[726004521] 'compare' (duration: 35.09415ms)"],"step_count":2} {"level":"warn","ts":"2026-05-10T04:12:13.138928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.818407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:496"} {"level":"info","ts":"2026-05-10T04:12:13.13901Z","caller":"traceutil/trace.go:171","msg":"trace[1500506147] range","detail":"{range_begin:/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:7493; }","duration":"110.94432ms","start":"2026-05-10T04:12:13.028045Z","end":"2026-05-10T04:12:13.138989Z","steps":["trace[1500506147] 'agreement among raft nodes before linearized reading' (duration: 110.741075ms)"],"step_count":1}