{"level":"warn","ts":"2026-06-02T23:46:23.618991Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T23:46:23.619076Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-06-02T23:46:23.61916Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T23:46:23.619171Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-06-02T23:46:23.619188Z","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-06-02T23:46:23.619901Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-06-02T23:46:23.619996Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-06-02T23:46:23.629307Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.088313ms"} {"level":"info","ts":"2026-06-02T23:46:23.641388Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-06-02T23:46:23.641479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T23:46:23.641513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-06-02T23:46:23.641533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T23:46:23.641548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-06-02T23:46:23.641599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-06-02T23:46:23.743535Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T23:46:23.752398Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T23:46:23.754719Z","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-06-02T23:46:23.760036Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T23:46:23.76051Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T23:46:23.760495Z","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-06-02T23:46:23.760574Z","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-06-02T23:46:23.760591Z","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-06-02T23:46:23.764614Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-06-02T23:46:23.764819Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-06-02T23:46:23.767668Z","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-06-02T23:46:23.767918Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-06-02T23:46:23.767966Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-06-02T23:46:23.768032Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T23:46:23.76807Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T23:46:24.042258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T23:46:24.042308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T23:46:24.042333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-06-02T23:46:24.042346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-06-02T23:46:24.042353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-06-02T23:46:24.042364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-06-02T23:46:24.042372Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-06-02T23:46:24.043175Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T23:46:24.043225Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T23:46:24.043302Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T23:46:24.043356Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T23:46:24.043512Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T23:46:24.043611Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T23:46:24.047181Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T23:46:24.047442Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T23:46:24.047497Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T23:46:24.050483Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T23:46:24.051461Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-06-02T23:46:28.852183Z","caller":"traceutil/trace.go:171","msg":"trace[2143742949] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"523.174834ms","start":"2026-06-02T23:46:28.328989Z","end":"2026-06-02T23:46:28.852164Z","steps":["trace[2143742949] 'process raft request' (duration: 523.062021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:28.852728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:28.32897Z","time spent":"523.288955ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:46:29.865092Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.012966372s","expected-duration":"1s"} {"level":"info","ts":"2026-06-02T23:46:29.903566Z","caller":"traceutil/trace.go:171","msg":"trace[28879039] linearizableReadLoop","detail":"{readStateIndex:215; appliedIndex:213; }","duration":"1.084833968s","start":"2026-06-02T23:46:28.81871Z","end":"2026-06-02T23:46:29.903544Z","steps":["trace[28879039] 'read index received' (duration: 33.38784ms)","trace[28879039] 'applied index is now lower than readState.Index' (duration: 1.051445098s)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:46:29.903625Z","caller":"traceutil/trace.go:171","msg":"trace[745399270] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"1.488897321s","start":"2026-06-02T23:46:28.414706Z","end":"2026-06-02T23:46:29.903603Z","steps":["trace[745399270] 'process raft request' (duration: 1.450612739s)","trace[745399270] 'compare' (duration: 37.962757ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:46:29.903732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085017261s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:46:29.903776Z","caller":"traceutil/trace.go:171","msg":"trace[969779674] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:210; }","duration":"1.085127883s","start":"2026-06-02T23:46:28.818638Z","end":"2026-06-02T23:46:29.903766Z","steps":["trace[969779674] 'agreement among raft nodes before linearized reading' (duration: 1.085003631s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:29.903798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:28.818598Z","time spent":"1.085193974s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T23:46:29.903827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:28.414643Z","time spent":"1.489033604s","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T23:46:30.284132Z","caller":"traceutil/trace.go:171","msg":"trace[1847548831] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"375.665545ms","start":"2026-06-02T23:46:29.908447Z","end":"2026-06-02T23:46:30.284112Z","steps":["trace[1847548831] 'process raft request' (duration: 375.631695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:30.284252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:29.908429Z","time spent":"375.771648ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T23:46:30.284559Z","caller":"traceutil/trace.go:171","msg":"trace[193843527] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"900.614844ms","start":"2026-06-02T23:46:29.383928Z","end":"2026-06-02T23:46:30.284542Z","steps":["trace[193843527] 'process raft request' (duration: 896.81134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:30.284628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:29.383904Z","time spent":"900.695796ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T23:46:30.284814Z","caller":"traceutil/trace.go:171","msg":"trace[688342050] linearizableReadLoop","detail":"{readStateIndex:217; appliedIndex:215; }","duration":"381.165866ms","start":"2026-06-02T23:46:29.903618Z","end":"2026-06-02T23:46:30.284784Z","steps":["trace[688342050] 'read index received' (duration: 377.179689ms)","trace[688342050] 'applied index is now lower than readState.Index' (duration: 3.983877ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:46:30.284814Z","caller":"traceutil/trace.go:171","msg":"trace[984541665] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"668.751115ms","start":"2026-06-02T23:46:29.616037Z","end":"2026-06-02T23:46:30.284788Z","steps":["trace[984541665] 'process raft request' (duration: 668.004093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:30.284901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"760.261156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:46:30.284948Z","caller":"traceutil/trace.go:171","msg":"trace[1938332845] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:213; }","duration":"760.338778ms","start":"2026-06-02T23:46:29.52459Z","end":"2026-06-02T23:46:30.284929Z","steps":["trace[1938332845] 'agreement among raft nodes before linearized reading' (duration: 760.244896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:30.284957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.428934314s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-mzt88d\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:46:30.284987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:29.524572Z","time spent":"760.406778ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T23:46:30.284981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.438268365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:46:30.285024Z","caller":"traceutil/trace.go:171","msg":"trace[834495507] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-mzt88d; range_end:; response_count:0; response_revision:213; }","duration":"1.429022276s","start":"2026-06-02T23:46:28.85598Z","end":"2026-06-02T23:46:30.285003Z","steps":["trace[834495507] 'agreement among raft nodes before linearized reading' (duration: 1.428867343s)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:46:30.285054Z","caller":"traceutil/trace.go:171","msg":"trace[1623927463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:213; }","duration":"1.438417997s","start":"2026-06-02T23:46:28.846622Z","end":"2026-06-02T23:46:30.28504Z","steps":["trace[1623927463] 'agreement among raft nodes before linearized reading' (duration: 1.438270545s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:30.285074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:28.855966Z","time spent":"1.429094527s","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-mzt88d\" "} {"level":"warn","ts":"2026-06-02T23:46:30.28512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:28.846601Z","time spent":"1.43850835s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T23:46:30.285314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:29.616017Z","time spent":"668.904079ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T23:46:30.285342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.234368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:46:30.285407Z","caller":"traceutil/trace.go:171","msg":"trace[1285978733] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:213; }","duration":"487.36982ms","start":"2026-06-02T23:46:29.798012Z","end":"2026-06-02T23:46:30.285381Z","steps":["trace[1285978733] 'agreement among raft nodes before linearized reading' (duration: 487.023254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:46:30.285501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:29.797997Z","time spent":"487.486733ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T23:46:41.67458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.072736ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:46:41.674745Z","caller":"traceutil/trace.go:171","msg":"trace[972564798] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"336.136897ms","start":"2026-06-02T23:46:41.338582Z","end":"2026-06-02T23:46:41.674719Z","steps":["trace[972564798] 'process raft request' (duration: 159.682493ms)","trace[972564798] 'compare' (duration: 175.908453ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:46:41.67483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:46:41.338568Z","time spent":"336.223898ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:47:03.083186Z","caller":"traceutil/trace.go:171","msg":"trace[1297092413] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"124.188878ms","start":"2026-06-02T23:47:02.958971Z","end":"2026-06-02T23:47:03.08316Z","steps":["trace[1297092413] 'process raft request' (duration: 113.639741ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:03.083975Z","caller":"traceutil/trace.go:171","msg":"trace[869388288] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"124.645189ms","start":"2026-06-02T23:47:02.9593Z","end":"2026-06-02T23:47:03.083946Z","steps":["trace[869388288] 'process raft request' (duration: 124.365632ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:03.084714Z","caller":"traceutil/trace.go:171","msg":"trace[1050838400] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"123.325628ms","start":"2026-06-02T23:47:02.961367Z","end":"2026-06-02T23:47:03.084693Z","steps":["trace[1050838400] 'process raft request' (duration: 122.403366ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:03.084849Z","caller":"traceutil/trace.go:171","msg":"trace[1875780755] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"120.033238ms","start":"2026-06-02T23:47:02.964808Z","end":"2026-06-02T23:47:03.084841Z","steps":["trace[1875780755] 'process raft request' (duration: 118.997173ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:03.63015Z","caller":"traceutil/trace.go:171","msg":"trace[1147032817] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"369.105678ms","start":"2026-06-02T23:47:03.261022Z","end":"2026-06-02T23:47:03.630128Z","steps":["trace[1147032817] 'read index received' (duration: 369.054737ms)","trace[1147032817] 'applied index is now lower than readState.Index' (duration: 49.741µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:03.630307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.283093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:03.630369Z","caller":"traceutil/trace.go:171","msg":"trace[1229984611] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"369.392245ms","start":"2026-06-02T23:47:03.260961Z","end":"2026-06-02T23:47:03.630353Z","steps":["trace[1229984611] 'agreement among raft nodes before linearized reading' (duration: 369.260412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:03.630422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:03.260941Z","time spent":"369.468157ms","remote":"127.0.0.1:56942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T23:47:03.630614Z","caller":"traceutil/trace.go:171","msg":"trace[88613666] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"441.390984ms","start":"2026-06-02T23:47:03.189194Z","end":"2026-06-02T23:47:03.630585Z","steps":["trace[88613666] 'process raft request' (duration: 440.80412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:03.630748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:03.189167Z","time spent":"441.526016ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T23:47:03.643241Z","caller":"traceutil/trace.go:171","msg":"trace[1232377786] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"111.860648ms","start":"2026-06-02T23:47:03.531353Z","end":"2026-06-02T23:47:03.643214Z","steps":["trace[1232377786] 'process raft request' (duration: 111.828508ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:03.646274Z","caller":"traceutil/trace.go:171","msg":"trace[1488908163] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"314.522612ms","start":"2026-06-02T23:47:03.330007Z","end":"2026-06-02T23:47:03.64453Z","steps":["trace[1488908163] 'process raft request' (duration: 313.138739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:03.646338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:03.32998Z","time spent":"316.323476ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T23:47:03.646392Z","caller":"traceutil/trace.go:171","msg":"trace[1109286713] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"370.743867ms","start":"2026-06-02T23:47:03.275642Z","end":"2026-06-02T23:47:03.646386Z","steps":["trace[1109286713] 'process raft request' (duration: 363.408179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:03.646427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:03.275616Z","time spent":"370.790058ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:47:04.017512Z","caller":"traceutil/trace.go:171","msg":"trace[927960975] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"328.741769ms","start":"2026-06-02T23:47:03.688742Z","end":"2026-06-02T23:47:04.017484Z","steps":["trace[927960975] 'process raft request' (duration: 318.322994ms)","trace[927960975] 'compare' (duration: 10.281111ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:04.017664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:03.688721Z","time spent":"328.866582ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:47:04.019904Z","caller":"traceutil/trace.go:171","msg":"trace[905482388] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"284.821911ms","start":"2026-06-02T23:47:03.735058Z","end":"2026-06-02T23:47:04.01988Z","steps":["trace[905482388] 'process raft request' (duration: 283.52465ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:04.020074Z","caller":"traceutil/trace.go:171","msg":"trace[1174801107] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"207.745689ms","start":"2026-06-02T23:47:03.812297Z","end":"2026-06-02T23:47:04.020043Z","steps":["trace[1174801107] 'process raft request' (duration: 206.390867ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:04.02024Z","caller":"traceutil/trace.go:171","msg":"trace[349123399] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"163.467794ms","start":"2026-06-02T23:47:03.856761Z","end":"2026-06-02T23:47:04.020229Z","steps":["trace[349123399] 'process raft request' (duration: 162.171063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:04.268644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.821626ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:47:04.268743Z","caller":"traceutil/trace.go:171","msg":"trace[1519843823] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"181.408819ms","start":"2026-06-02T23:47:04.087317Z","end":"2026-06-02T23:47:04.268726Z","steps":["trace[1519843823] 'read index received' (duration: 18.36544ms)","trace[1519843823] 'applied index is now lower than readState.Index' (duration: 163.042119ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:04.268813Z","caller":"traceutil/trace.go:171","msg":"trace[150463351] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"181.639064ms","start":"2026-06-02T23:47:04.087163Z","end":"2026-06-02T23:47:04.268802Z","steps":["trace[150463351] 'process raft request' (duration: 69.579052ms)","trace[150463351] 'compare' (duration: 111.706304ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:04.269037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.714676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:10870"} {"level":"info","ts":"2026-06-02T23:47:04.269078Z","caller":"traceutil/trace.go:171","msg":"trace[929198329] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gatewayclasses.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:611; }","duration":"181.769267ms","start":"2026-06-02T23:47:04.087298Z","end":"2026-06-02T23:47:04.269067Z","steps":["trace[929198329] 'agreement among raft nodes before linearized reading' (duration: 181.643194ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:04.273848Z","caller":"traceutil/trace.go:171","msg":"trace[354098205] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"158.034036ms","start":"2026-06-02T23:47:04.11579Z","end":"2026-06-02T23:47:04.273824Z","steps":["trace[354098205] 'process raft request' (duration: 157.737199ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:04.274133Z","caller":"traceutil/trace.go:171","msg":"trace[311743585] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"141.508452ms","start":"2026-06-02T23:47:04.132593Z","end":"2026-06-02T23:47:04.274101Z","steps":["trace[311743585] 'process raft request' (duration: 141.079871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:04.76724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.765887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-06-02T23:47:04.767304Z","caller":"traceutil/trace.go:171","msg":"trace[1865466653] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:627; }","duration":"145.858028ms","start":"2026-06-02T23:47:04.621431Z","end":"2026-06-02T23:47:04.76729Z","steps":["trace[1865466653] 'range keys from in-memory index tree' (duration: 145.627463ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.463102Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053104271367769,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-02T23:47:06.566173Z","caller":"traceutil/trace.go:171","msg":"trace[1645287484] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:651; }","duration":"603.90556ms","start":"2026-06-02T23:47:05.962244Z","end":"2026-06-02T23:47:06.56615Z","steps":["trace[1645287484] 'read index received' (duration: 603.566132ms)","trace[1645287484] 'applied index is now lower than readState.Index' (duration: 338.428µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:06.566506Z","caller":"traceutil/trace.go:171","msg":"trace[365351918] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"605.781017ms","start":"2026-06-02T23:47:05.960715Z","end":"2026-06-02T23:47:06.566496Z","steps":["trace[365351918] 'process raft request' (duration: 605.195092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.566576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.960701Z","time spent":"605.833089ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T23:47:06.566749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.497945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.566789Z","caller":"traceutil/trace.go:171","msg":"trace[1537812631] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"604.542246ms","start":"2026-06-02T23:47:05.96224Z","end":"2026-06-02T23:47:06.566783Z","steps":["trace[1537812631] 'agreement among raft nodes before linearized reading' (duration: 604.465284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.566811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.9622Z","time spent":"604.605777ms","remote":"127.0.0.1:38466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-06-02T23:47:06.567121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.723042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.567146Z","caller":"traceutil/trace.go:171","msg":"trace[1038219799] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"604.765312ms","start":"2026-06-02T23:47:05.962375Z","end":"2026-06-02T23:47:06.56714Z","steps":["trace[1038219799] 'agreement among raft nodes before linearized reading' (duration: 604.727761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.567166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.962368Z","time spent":"604.793273ms","remote":"127.0.0.1:38466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-02T23:47:06.568049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.311972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.568152Z","caller":"traceutil/trace.go:171","msg":"trace[2015954481] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:628; }","duration":"538.432215ms","start":"2026-06-02T23:47:06.029696Z","end":"2026-06-02T23:47:06.568128Z","steps":["trace[2015954481] 'agreement among raft nodes before linearized reading' (duration: 538.282691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.568201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.029682Z","time spent":"538.507986ms","remote":"127.0.0.1:38506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-06-02T23:47:06.568174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.754197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.568276Z","caller":"traceutil/trace.go:171","msg":"trace[489949829] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:628; }","duration":"592.907201ms","start":"2026-06-02T23:47:05.975351Z","end":"2026-06-02T23:47:06.568258Z","steps":["trace[489949829] 'agreement among raft nodes before linearized reading' (duration: 592.710746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.5683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.933242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.56841Z","caller":"traceutil/trace.go:171","msg":"trace[458245096] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:628; }","duration":"593.069115ms","start":"2026-06-02T23:47:05.975323Z","end":"2026-06-02T23:47:06.568392Z","steps":["trace[458245096] 'agreement among raft nodes before linearized reading' (duration: 592.8555ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.568471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.118326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-06-02T23:47:06.568519Z","caller":"traceutil/trace.go:171","msg":"trace[4940247] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:628; }","duration":"240.181257ms","start":"2026-06-02T23:47:06.328323Z","end":"2026-06-02T23:47:06.568505Z","steps":["trace[4940247] 'agreement among raft nodes before linearized reading' (duration: 240.050494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.568409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.928576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:06.568593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.482093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.568603Z","caller":"traceutil/trace.go:171","msg":"trace[1923024535] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:628; }","duration":"539.134121ms","start":"2026-06-02T23:47:06.029459Z","end":"2026-06-02T23:47:06.568593Z","steps":["trace[1923024535] 'agreement among raft nodes before linearized reading' (duration: 538.927726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.568719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.029452Z","time spent":"539.256275ms","remote":"127.0.0.1:38506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 "} {"level":"warn","ts":"2026-06-02T23:47:06.569013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.652025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:06.569089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.365662ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.569073Z","caller":"traceutil/trace.go:171","msg":"trace[1135077482] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:628; }","duration":"487.734507ms","start":"2026-06-02T23:47:06.081323Z","end":"2026-06-02T23:47:06.569058Z","steps":["trace[1135077482] 'agreement among raft nodes before linearized reading' (duration: 487.641605ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:06.569193Z","caller":"traceutil/trace.go:171","msg":"trace[1794450249] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:628; }","duration":"467.515245ms","start":"2026-06-02T23:47:06.101665Z","end":"2026-06-02T23:47:06.569181Z","steps":["trace[1794450249] 'agreement among raft nodes before linearized reading' (duration: 467.351281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.56926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.101662Z","time spent":"467.567556ms","remote":"127.0.0.1:38550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-02T23:47:06.569245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.081285Z","time spent":"487.943931ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 "} {"level":"warn","ts":"2026-06-02T23:47:06.568351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.975348Z","time spent":"592.980383ms","remote":"127.0.0.1:38476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-02T23:47:06.569586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.934516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.569631Z","caller":"traceutil/trace.go:171","msg":"trace[1195094888] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:628; }","duration":"467.996747ms","start":"2026-06-02T23:47:06.101623Z","end":"2026-06-02T23:47:06.569619Z","steps":["trace[1195094888] 'agreement among raft nodes before linearized reading' (duration: 467.927115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.56848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.854448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:06.569758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.495231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.569817Z","caller":"traceutil/trace.go:171","msg":"trace[593902108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"308.595665ms","start":"2026-06-02T23:47:06.261212Z","end":"2026-06-02T23:47:06.569808Z","steps":["trace[593902108] 'agreement among raft nodes before linearized reading' (duration: 308.510211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.569853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.261192Z","time spent":"308.654275ms","remote":"127.0.0.1:56942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T23:47:06.569856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.389658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:06.569827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.991154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:06.568486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.975316Z","time spent":"593.158887ms","remote":"127.0.0.1:38476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-02T23:47:06.569695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.101613Z","time spent":"468.042709ms","remote":"127.0.0.1:38550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 "} {"level":"info","ts":"2026-06-02T23:47:06.569997Z","caller":"traceutil/trace.go:171","msg":"trace[741143793] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:628; }","duration":"518.503081ms","start":"2026-06-02T23:47:06.051411Z","end":"2026-06-02T23:47:06.569914Z","steps":["trace[741143793] 'agreement among raft nodes before linearized reading' (duration: 518.339186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.570051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.051399Z","time spent":"518.637274ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-06-02T23:47:06.568666Z","caller":"traceutil/trace.go:171","msg":"trace[527730172] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"554.575535ms","start":"2026-06-02T23:47:06.014039Z","end":"2026-06-02T23:47:06.568614Z","steps":["trace[527730172] 'agreement among raft nodes before linearized reading' (duration: 554.500674ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.570222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.014023Z","time spent":"556.157245ms","remote":"127.0.0.1:38498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-02T23:47:06.570294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.122014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.570352Z","caller":"traceutil/trace.go:171","msg":"trace[394397251] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:628; }","duration":"504.214175ms","start":"2026-06-02T23:47:06.066121Z","end":"2026-06-02T23:47:06.570336Z","steps":["trace[394397251] 'agreement among raft nodes before linearized reading' (duration: 504.137204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.570421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.066107Z","time spent":"504.297048ms","remote":"127.0.0.1:38522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 "} {"level":"warn","ts":"2026-06-02T23:47:06.570513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.466402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.570568Z","caller":"traceutil/trace.go:171","msg":"trace[1953545456] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"556.551625ms","start":"2026-06-02T23:47:06.014005Z","end":"2026-06-02T23:47:06.570557Z","steps":["trace[1953545456] 'agreement among raft nodes before linearized reading' (duration: 556.465423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.570688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.715184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:06.570709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.261804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.570733Z","caller":"traceutil/trace.go:171","msg":"trace[2139586853] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:628; }","duration":"505.798986ms","start":"2026-06-02T23:47:06.064923Z","end":"2026-06-02T23:47:06.570722Z","steps":["trace[2139586853] 'agreement among raft nodes before linearized reading' (duration: 505.716554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.570779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.064901Z","time spent":"505.867807ms","remote":"127.0.0.1:38522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-06-02T23:47:06.570846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.472945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.570909Z","caller":"traceutil/trace.go:171","msg":"trace[119582024] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:628; }","duration":"519.564957ms","start":"2026-06-02T23:47:06.051329Z","end":"2026-06-02T23:47:06.570894Z","steps":["trace[119582024] 'agreement among raft nodes before linearized reading' (duration: 519.413633ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.570943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.051323Z","time spent":"519.613638ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 "} {"level":"warn","ts":"2026-06-02T23:47:06.570619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.600391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.56976Z","caller":"traceutil/trace.go:171","msg":"trace[1524380089] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"555.141139ms","start":"2026-06-02T23:47:06.014609Z","end":"2026-06-02T23:47:06.56975Z","steps":["trace[1524380089] 'agreement among raft nodes before linearized reading' (duration: 553.849138ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:06.571062Z","caller":"traceutil/trace.go:171","msg":"trace[2012137755] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:628; }","duration":"506.008711ms","start":"2026-06-02T23:47:06.064967Z","end":"2026-06-02T23:47:06.570976Z","steps":["trace[2012137755] 'agreement among raft nodes before linearized reading' (duration: 505.620882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.57111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.755801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:06.571115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.064941Z","time spent":"506.159304ms","remote":"127.0.0.1:38522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 "} {"level":"info","ts":"2026-06-02T23:47:06.571136Z","caller":"traceutil/trace.go:171","msg":"trace[890066761] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:628; }","duration":"519.807023ms","start":"2026-06-02T23:47:06.051324Z","end":"2026-06-02T23:47:06.571131Z","steps":["trace[890066761] 'agreement among raft nodes before linearized reading' (duration: 519.763322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.571158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.051311Z","time spent":"519.841953ms","remote":"127.0.0.1:38520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 "} {"level":"warn","ts":"2026-06-02T23:47:06.569103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.465854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.57084Z","caller":"traceutil/trace.go:171","msg":"trace[133335601] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:628; }","duration":"468.311215ms","start":"2026-06-02T23:47:06.102427Z","end":"2026-06-02T23:47:06.570738Z","steps":["trace[133335601] 'agreement among raft nodes before linearized reading' (duration: 468.246984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.571263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.102421Z","time spent":"468.832118ms","remote":"127.0.0.1:38550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:500 "} {"level":"warn","ts":"2026-06-02T23:47:06.57127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.850759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.571335Z","caller":"traceutil/trace.go:171","msg":"trace[199215027] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:628; }","duration":"594.927911ms","start":"2026-06-02T23:47:05.976392Z","end":"2026-06-02T23:47:06.57132Z","steps":["trace[199215027] 'agreement among raft nodes before linearized reading' (duration: 594.829988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.571351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.736264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:47:06.571066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.014603Z","time spent":"556.435102ms","remote":"127.0.0.1:38488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-06-02T23:47:06.571369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.976358Z","time spent":"595.003233ms","remote":"127.0.0.1:38476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-02T23:47:06.571397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.530906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.571419Z","caller":"traceutil/trace.go:171","msg":"trace[401575980] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:628; }","duration":"540.561797ms","start":"2026-06-02T23:47:06.030852Z","end":"2026-06-02T23:47:06.571414Z","steps":["trace[401575980] 'agreement among raft nodes before linearized reading' (duration: 540.526506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.571434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.030848Z","time spent":"540.582757ms","remote":"127.0.0.1:38506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 "} {"level":"warn","ts":"2026-06-02T23:47:06.570691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.013988Z","time spent":"556.691208ms","remote":"127.0.0.1:38498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-06-02T23:47:06.57058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.89054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"warn","ts":"2026-06-02T23:47:06.570729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.129939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.571552Z","caller":"traceutil/trace.go:171","msg":"trace[1714922182] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"574.962009ms","start":"2026-06-02T23:47:05.996579Z","end":"2026-06-02T23:47:06.571541Z","steps":["trace[1714922182] 'agreement among raft nodes before linearized reading' (duration: 574.130139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.571591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.996569Z","time spent":"575.00489ms","remote":"127.0.0.1:38488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-06-02T23:47:06.571488Z","caller":"traceutil/trace.go:171","msg":"trace[181178629] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:628; }","duration":"574.810765ms","start":"2026-06-02T23:47:05.996565Z","end":"2026-06-02T23:47:06.571375Z","steps":["trace[181178629] 'agreement among raft nodes before linearized reading' (duration: 574.636311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.571733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.996542Z","time spent":"575.181604ms","remote":"127.0.0.1:38488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-06-02T23:47:06.571518Z","caller":"traceutil/trace.go:171","msg":"trace[1156244958] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:628; }","duration":"442.865054ms","start":"2026-06-02T23:47:06.128644Z","end":"2026-06-02T23:47:06.571509Z","steps":["trace[1156244958] 'agreement among raft nodes before linearized reading' (duration: 441.611103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.5718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.128627Z","time spent":"443.168282ms","remote":"127.0.0.1:56988","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13252,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"info","ts":"2026-06-02T23:47:06.571232Z","caller":"traceutil/trace.go:171","msg":"trace[288558547] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:628; }","duration":"608.656448ms","start":"2026-06-02T23:47:05.962569Z","end":"2026-06-02T23:47:06.571225Z","steps":["trace[288558547] 'agreement among raft nodes before linearized reading' (duration: 606.459574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.571883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:05.962564Z","time spent":"609.313964ms","remote":"127.0.0.1:38466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"info","ts":"2026-06-02T23:47:06.571881Z","caller":"traceutil/trace.go:171","msg":"trace[1029799184] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:628; }","duration":"490.061075ms","start":"2026-06-02T23:47:06.08181Z","end":"2026-06-02T23:47:06.571871Z","steps":["trace[1029799184] 'agreement among raft nodes before linearized reading' (duration: 487.985374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.571909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.081804Z","time spent":"490.096606ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 "} {"level":"warn","ts":"2026-06-02T23:47:06.572164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.363262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:06.572234Z","caller":"traceutil/trace.go:171","msg":"trace[1420746638] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:628; }","duration":"490.466165ms","start":"2026-06-02T23:47:06.081757Z","end":"2026-06-02T23:47:06.572223Z","steps":["trace[1420746638] 'agreement among raft nodes before linearized reading' (duration: 488.432185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:06.572326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:06.081741Z","time spent":"490.573337ms","remote":"127.0.0.1:38536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-06-02T23:47:11.098368Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053104271367858,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T23:47:11.598809Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053104271367858,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T23:47:12.099868Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053104271367858,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T23:47:12.600065Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053104271367858,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T23:47:12.964113Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.57868425s","expected-duration":"1s"} {"level":"info","ts":"2026-06-02T23:47:12.970408Z","caller":"traceutil/trace.go:171","msg":"trace[523127408] transaction","detail":"{read_only:false; response_revision:666; number_of_response:1; }","duration":"2.586820228s","start":"2026-06-02T23:47:10.38356Z","end":"2026-06-02T23:47:12.970381Z","steps":["trace[523127408] 'process raft request' (duration: 2.58299119s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:12.970565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:10.383494Z","time spent":"2.586989173s","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:47:13.018735Z","caller":"traceutil/trace.go:171","msg":"trace[291310821] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"1.369536969s","start":"2026-06-02T23:47:11.649177Z","end":"2026-06-02T23:47:13.018714Z","steps":["trace[291310821] 'process raft request' (duration: 1.368898931s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:13.018838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:11.649156Z","time spent":"1.369630321s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:47:13.253185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.982716ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-02T23:47:13.253425Z","caller":"traceutil/trace.go:171","msg":"trace[1044998974] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:690; }","duration":"2.655986563s","start":"2026-06-02T23:47:10.597421Z","end":"2026-06-02T23:47:13.253408Z","steps":["trace[1044998974] 'read index received' (duration: 2.368933405s)","trace[1044998974] 'applied index is now lower than readState.Index' (duration: 287.051968ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:13.253661Z","caller":"traceutil/trace.go:171","msg":"trace[1167523241] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"200.327977ms","start":"2026-06-02T23:47:13.053316Z","end":"2026-06-02T23:47:13.253644Z","steps":["trace[1167523241] 'process raft request' (duration: 200.05792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:13.268422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.665539963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-02T23:47:13.268486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.170075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:13.268522Z","caller":"traceutil/trace.go:171","msg":"trace[1918750050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"508.257057ms","start":"2026-06-02T23:47:12.760255Z","end":"2026-06-02T23:47:13.268512Z","steps":["trace[1918750050] 'agreement among raft nodes before linearized reading' (duration: 493.537935ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:13.268506Z","caller":"traceutil/trace.go:171","msg":"trace[1049019721] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:668; }","duration":"2.665640986s","start":"2026-06-02T23:47:10.602842Z","end":"2026-06-02T23:47:13.268483Z","steps":["trace[1049019721] 'agreement among raft nodes before linearized reading' (duration: 2.650789981s)","trace[1049019721] 'range keys from in-memory index tree' (duration: 14.699562ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:13.268543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.65008834s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-02T23:47:13.268611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:12.760235Z","time spent":"508.367569ms","remote":"127.0.0.1:56950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T23:47:13.268633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:10.602832Z","time spent":"2.66578913s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T23:47:13.268773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.671360161s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-02T23:47:13.268826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.650407448s","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-06-02T23:47:13.268869Z","caller":"traceutil/trace.go:171","msg":"trace[210220934] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:668; }","duration":"2.65047266s","start":"2026-06-02T23:47:10.618384Z","end":"2026-06-02T23:47:13.268857Z","steps":["trace[210220934] 'agreement among raft nodes before linearized reading' (duration: 2.63544179s)","trace[210220934] 'range keys from in-memory index tree' (duration: 14.933788ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:13.268904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:10.618371Z","time spent":"2.650524691s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T23:47:13.268937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.007910622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:13.269011Z","caller":"traceutil/trace.go:171","msg":"trace[492728127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:668; }","duration":"2.008021955s","start":"2026-06-02T23:47:11.260969Z","end":"2026-06-02T23:47:13.268991Z","steps":["trace[492728127] 'agreement among raft nodes before linearized reading' (duration: 1.992835411s)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:13.268915Z","caller":"traceutil/trace.go:171","msg":"trace[1030677767] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:668; }","duration":"2.671463514s","start":"2026-06-02T23:47:10.597368Z","end":"2026-06-02T23:47:13.268831Z","steps":["trace[1030677767] 'agreement among raft nodes before linearized reading' (duration: 2.656222919s)","trace[1030677767] 'range keys from in-memory index tree' (duration: 15.000099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:13.269091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:10.597346Z","time spent":"2.671732572s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-02T23:47:13.269096Z","caller":"traceutil/trace.go:171","msg":"trace[213237178] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:668; }","duration":"2.650196803s","start":"2026-06-02T23:47:10.618426Z","end":"2026-06-02T23:47:13.268622Z","steps":["trace[213237178] 'agreement among raft nodes before linearized reading' (duration: 2.635394129s)","trace[213237178] 'range keys from in-memory index tree' (duration: 14.610629ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:13.269239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.445999998s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4psq9\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-06-02T23:47:13.269219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.661587763s","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-06-02T23:47:13.269291Z","caller":"traceutil/trace.go:171","msg":"trace[584436360] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4psq9; range_end:; response_count:1; response_revision:668; }","duration":"2.446076501s","start":"2026-06-02T23:47:10.823201Z","end":"2026-06-02T23:47:13.269277Z","steps":["trace[584436360] 'agreement among raft nodes before linearized reading' (duration: 2.43061186s)","trace[584436360] 'range keys from in-memory index tree' (duration: 15.335467ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:13.269294Z","caller":"traceutil/trace.go:171","msg":"trace[138185088] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:668; }","duration":"2.661701236s","start":"2026-06-02T23:47:10.607581Z","end":"2026-06-02T23:47:13.269283Z","steps":["trace[138185088] 'agreement among raft nodes before linearized reading' (duration: 2.646250845s)","trace[138185088] 'range keys from in-memory index tree' (duration: 15.219965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:13.269037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:11.260934Z","time spent":"2.008097567s","remote":"127.0.0.1:56950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T23:47:13.269361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:10.823186Z","time spent":"2.446136592s","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-4psq9\" "} {"level":"warn","ts":"2026-06-02T23:47:13.269393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:10.60755Z","time spent":"2.661833569s","remote":"127.0.0.1:57184","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-06-02T23:47:13.269469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:10.61842Z","time spent":"2.650801098s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T23:47:17.049021Z","caller":"traceutil/trace.go:171","msg":"trace[1740176851] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"154.977206ms","start":"2026-06-02T23:47:16.894014Z","end":"2026-06-02T23:47:17.048991Z","steps":["trace[1740176851] 'process raft request' (duration: 114.262009ms)","trace[1740176851] 'compare' (duration: 40.584834ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:17.111471Z","caller":"traceutil/trace.go:171","msg":"trace[447858286] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:724; }","duration":"141.682075ms","start":"2026-06-02T23:47:16.969762Z","end":"2026-06-02T23:47:17.111444Z","steps":["trace[447858286] 'read index received' (duration: 38.527514ms)","trace[447858286] 'applied index is now lower than readState.Index' (duration: 103.153111ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:17.111533Z","caller":"traceutil/trace.go:171","msg":"trace[863841391] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"172.284051ms","start":"2026-06-02T23:47:16.939189Z","end":"2026-06-02T23:47:17.111473Z","steps":["trace[863841391] 'process raft request' (duration: 172.110195ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:17.111728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.949203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.227\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-02T23:47:17.111789Z","caller":"traceutil/trace.go:171","msg":"trace[1429682044] range","detail":"{range_begin:/registry/masterleases/199.204.45.227; range_end:; response_count:1; response_revision:700; }","duration":"142.030665ms","start":"2026-06-02T23:47:16.969743Z","end":"2026-06-02T23:47:17.111774Z","steps":["trace[1429682044] 'agreement among raft nodes before linearized reading' (duration: 141.810629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:29.76173Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053104271368095,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-02T23:47:30.003161Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.052210441s","expected-duration":"1s"} {"level":"info","ts":"2026-06-02T23:47:30.003924Z","caller":"traceutil/trace.go:171","msg":"trace[1339508634] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"1.053072686s","start":"2026-06-02T23:47:28.950827Z","end":"2026-06-02T23:47:30.003899Z","steps":["trace[1339508634] 'process raft request' (duration: 1.052711906s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:30.004069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"742.644475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:47:30.004149Z","caller":"traceutil/trace.go:171","msg":"trace[882232007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:789; }","duration":"742.779298ms","start":"2026-06-02T23:47:29.261352Z","end":"2026-06-02T23:47:30.004131Z","steps":["trace[882232007] 'agreement among raft nodes before linearized reading' (duration: 742.658425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:30.004212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:29.261322Z","time spent":"742.864881ms","remote":"127.0.0.1:56950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T23:47:30.004087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:28.950802Z","time spent":"1.053206459s","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:47:30.004303Z","caller":"traceutil/trace.go:171","msg":"trace[1717090676] linearizableReadLoop","detail":"{readStateIndex:819; appliedIndex:818; }","duration":"742.370167ms","start":"2026-06-02T23:47:29.261421Z","end":"2026-06-02T23:47:30.003791Z","steps":["trace[1717090676] 'read index received' (duration: 741.913903ms)","trace[1717090676] 'applied index is now lower than readState.Index' (duration: 454.504µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:47:30.005021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.29216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-02T23:47:30.005032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.040335ms","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-06-02T23:47:30.005081Z","caller":"traceutil/trace.go:171","msg":"trace[1062811559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:789; }","duration":"580.397583ms","start":"2026-06-02T23:47:29.424671Z","end":"2026-06-02T23:47:30.005068Z","steps":["trace[1062811559] 'agreement among raft nodes before linearized reading' (duration: 580.263529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:30.005114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:29.424643Z","time spent":"580.463685ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T23:47:30.0052Z","caller":"traceutil/trace.go:171","msg":"trace[176842862] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:789; }","duration":"589.166489ms","start":"2026-06-02T23:47:29.415924Z","end":"2026-06-02T23:47:30.00509Z","steps":["trace[176842862] 'agreement among raft nodes before linearized reading' (duration: 588.918252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:30.005266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:29.415905Z","time spent":"589.347533ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T23:47:30.005031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.294941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-02T23:47:30.005532Z","caller":"traceutil/trace.go:171","msg":"trace[1097680117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:789; }","duration":"580.822304ms","start":"2026-06-02T23:47:29.424692Z","end":"2026-06-02T23:47:30.005514Z","steps":["trace[1097680117] 'agreement among raft nodes before linearized reading' (duration: 580.214058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:30.005621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:29.424672Z","time spent":"580.928058ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T23:47:30.00583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.78591ms","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-06-02T23:47:30.00605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.759245ms","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-06-02T23:47:30.005966Z","caller":"traceutil/trace.go:171","msg":"trace[1059280601] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:789; }","duration":"582.947285ms","start":"2026-06-02T23:47:29.422988Z","end":"2026-06-02T23:47:30.005936Z","steps":["trace[1059280601] 'agreement among raft nodes before linearized reading' (duration: 582.663007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:30.00633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:29.422966Z","time spent":"583.216773ms","remote":"127.0.0.1:57184","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":"info","ts":"2026-06-02T23:47:30.006093Z","caller":"traceutil/trace.go:171","msg":"trace[1653495886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:789; }","duration":"575.605868ms","start":"2026-06-02T23:47:29.430476Z","end":"2026-06-02T23:47:30.006082Z","steps":["trace[1653495886] 'agreement among raft nodes before linearized reading' (duration: 574.59387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:30.00645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:47:29.430468Z","time spent":"575.97135ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-02T23:47:39.130634Z","caller":"traceutil/trace.go:171","msg":"trace[71327657] transaction","detail":"{read_only:false; response_revision:890; number_of_response:1; }","duration":"117.302117ms","start":"2026-06-02T23:47:39.013296Z","end":"2026-06-02T23:47:39.130598Z","steps":["trace[71327657] 'process raft request' (duration: 117.075641ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:39.208571Z","caller":"traceutil/trace.go:171","msg":"trace[630097280] transaction","detail":"{read_only:false; response_revision:891; number_of_response:1; }","duration":"119.720767ms","start":"2026-06-02T23:47:39.088823Z","end":"2026-06-02T23:47:39.208544Z","steps":["trace[630097280] 'process raft request' (duration: 119.567092ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:44.246928Z","caller":"traceutil/trace.go:171","msg":"trace[1351246508] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"139.399386ms","start":"2026-06-02T23:47:44.10751Z","end":"2026-06-02T23:47:44.246909Z","steps":["trace[1351246508] 'process raft request' (duration: 139.331044ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:44.246936Z","caller":"traceutil/trace.go:171","msg":"trace[1516794539] transaction","detail":"{read_only:false; response_revision:958; number_of_response:1; }","duration":"139.537189ms","start":"2026-06-02T23:47:44.107358Z","end":"2026-06-02T23:47:44.246895Z","steps":["trace[1516794539] 'process raft request' (duration: 73.081237ms)","trace[1516794539] 'compare' (duration: 66.260327ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:44.247231Z","caller":"traceutil/trace.go:171","msg":"trace[470754279] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"138.963593ms","start":"2026-06-02T23:47:44.108248Z","end":"2026-06-02T23:47:44.247211Z","steps":["trace[470754279] 'process raft request' (duration: 138.614622ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:44.247647Z","caller":"traceutil/trace.go:171","msg":"trace[853914374] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"139.435437ms","start":"2026-06-02T23:47:44.10748Z","end":"2026-06-02T23:47:44.246916Z","steps":["trace[853914374] 'process raft request' (duration: 139.332204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:47:44.724633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.434786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-jvqn4\" ","response":"range_response_count:1 size:5677"} {"level":"info","ts":"2026-06-02T23:47:44.724715Z","caller":"traceutil/trace.go:171","msg":"trace[1556106704] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-jvqn4; range_end:; response_count:1; response_revision:961; }","duration":"243.564661ms","start":"2026-06-02T23:47:44.481134Z","end":"2026-06-02T23:47:44.724699Z","steps":["trace[1556106704] 'range keys from in-memory index tree' (duration: 243.173088ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:47:44.896331Z","caller":"traceutil/trace.go:171","msg":"trace[1992034992] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"129.607247ms","start":"2026-06-02T23:47:44.766696Z","end":"2026-06-02T23:47:44.896303Z","steps":["trace[1992034992] 'process raft request' (duration: 99.473117ms)","trace[1992034992] 'compare' (duration: 30.000666ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:47:59.541597Z","caller":"traceutil/trace.go:171","msg":"trace[103512768] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"216.588258ms","start":"2026-06-02T23:47:59.324982Z","end":"2026-06-02T23:47:59.54157Z","steps":["trace[103512768] 'process raft request' (duration: 216.368131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:20.639732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.6171ms","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-06-02T23:48:20.639824Z","caller":"traceutil/trace.go:171","msg":"trace[1528862381] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1440; }","duration":"119.755814ms","start":"2026-06-02T23:48:20.52005Z","end":"2026-06-02T23:48:20.639806Z","steps":["trace[1528862381] 'range keys from in-memory index tree' (duration: 119.411104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:20.639825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.785663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-02T23:48:20.639849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.774456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-02T23:48:20.639917Z","caller":"traceutil/trace.go:171","msg":"trace[576420130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1440; }","duration":"123.917307ms","start":"2026-06-02T23:48:20.515979Z","end":"2026-06-02T23:48:20.639896Z","steps":["trace[576420130] 'range keys from in-memory index tree' (duration: 123.614328ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:20.639954Z","caller":"traceutil/trace.go:171","msg":"trace[1596129987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1440; }","duration":"120.925951ms","start":"2026-06-02T23:48:20.519006Z","end":"2026-06-02T23:48:20.639932Z","steps":["trace[1596129987] 'range keys from in-memory index tree' (duration: 120.597411ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:20.887187Z","caller":"traceutil/trace.go:171","msg":"trace[220636738] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"243.766304ms","start":"2026-06-02T23:48:20.643394Z","end":"2026-06-02T23:48:20.88716Z","steps":["trace[220636738] 'process raft request' (duration: 243.612959ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:20.888466Z","caller":"traceutil/trace.go:171","msg":"trace[37681709] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"244.374525ms","start":"2026-06-02T23:48:20.644069Z","end":"2026-06-02T23:48:20.888443Z","steps":["trace[37681709] 'process raft request' (duration: 244.182808ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:20.888429Z","caller":"traceutil/trace.go:171","msg":"trace[684481912] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"132.002816ms","start":"2026-06-02T23:48:20.75641Z","end":"2026-06-02T23:48:20.888413Z","steps":["trace[684481912] 'process raft request' (duration: 131.894752ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:20.889026Z","caller":"traceutil/trace.go:171","msg":"trace[1121105417] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"244.302992ms","start":"2026-06-02T23:48:20.644058Z","end":"2026-06-02T23:48:20.888361Z","steps":["trace[1121105417] 'process raft request' (duration: 244.080275ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:41.169503Z","caller":"traceutil/trace.go:171","msg":"trace[992079905] transaction","detail":"{read_only:false; response_revision:1755; number_of_response:1; }","duration":"167.720454ms","start":"2026-06-02T23:48:41.001746Z","end":"2026-06-02T23:48:41.169466Z","steps":["trace[992079905] 'process raft request' (duration: 166.767973ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:41.183231Z","caller":"traceutil/trace.go:171","msg":"trace[76225961] linearizableReadLoop","detail":"{readStateIndex:1831; appliedIndex:1829; }","duration":"179.414639ms","start":"2026-06-02T23:48:41.003797Z","end":"2026-06-02T23:48:41.183211Z","steps":["trace[76225961] 'read index received' (duration: 164.705695ms)","trace[76225961] 'applied index is now lower than readState.Index' (duration: 14.707324ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:48:41.183593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.783101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T23:48:41.183636Z","caller":"traceutil/trace.go:171","msg":"trace[700042212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1756; }","duration":"179.879555ms","start":"2026-06-02T23:48:41.00374Z","end":"2026-06-02T23:48:41.18362Z","steps":["trace[700042212] 'agreement among raft nodes before linearized reading' (duration: 179.543244ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:41.18378Z","caller":"traceutil/trace.go:171","msg":"trace[1417246617] transaction","detail":"{read_only:false; response_revision:1756; number_of_response:1; }","duration":"180.33556ms","start":"2026-06-02T23:48:41.003409Z","end":"2026-06-02T23:48:41.183744Z","steps":["trace[1417246617] 'process raft request' (duration: 179.686049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:47.693107Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053104271370162,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-02T23:48:48.017645Z","caller":"traceutil/trace.go:171","msg":"trace[649969618] linearizableReadLoop","detail":"{readStateIndex:1931; appliedIndex:1930; }","duration":"825.281806ms","start":"2026-06-02T23:48:47.192315Z","end":"2026-06-02T23:48:48.017597Z","steps":["trace[649969618] 'read index received' (duration: 766.245949ms)","trace[649969618] 'applied index is now lower than readState.Index' (duration: 59.034237ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:48:48.018011Z","caller":"traceutil/trace.go:171","msg":"trace[519250790] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"942.365907ms","start":"2026-06-02T23:48:47.075625Z","end":"2026-06-02T23:48:48.017991Z","steps":["trace[519250790] 'process raft request' (duration: 882.923866ms)","trace[519250790] 'compare' (duration: 58.646655ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:48:48.018412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:47.075602Z","time spent":"942.443469ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:48:48.018502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"826.150705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-02T23:48:48.019072Z","caller":"traceutil/trace.go:171","msg":"trace[1299690267] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1854; }","duration":"826.760375ms","start":"2026-06-02T23:48:47.192257Z","end":"2026-06-02T23:48:48.019018Z","steps":["trace[1299690267] 'agreement among raft nodes before linearized reading' (duration: 825.982229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:48.019158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:47.192233Z","time spent":"826.90651ms","remote":"127.0.0.1:57184","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-06-02T23:48:48.054768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.745404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-02T23:48:48.054875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.768762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:48:48.054956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"743.62006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fb5d8051-9eef-4ff5-a579-d8b451fc7609\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-06-02T23:48:48.055063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.33678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fb5d8051-9eef-4ff5-a579-d8b451fc7609\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-06-02T23:48:48.055105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.710648ms","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-06-02T23:48:48.055076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.572723ms","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-06-02T23:48:48.055206Z","caller":"traceutil/trace.go:171","msg":"trace[1851817535] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1855; }","duration":"417.747648ms","start":"2026-06-02T23:48:47.637431Z","end":"2026-06-02T23:48:48.055178Z","steps":["trace[1851817535] 'agreement among raft nodes before linearized reading' (duration: 417.422098ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:48.055206Z","caller":"traceutil/trace.go:171","msg":"trace[1697541313] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"269.68681ms","start":"2026-06-02T23:48:47.784783Z","end":"2026-06-02T23:48:48.054469Z","steps":["trace[1697541313] 'process raft request' (duration: 269.484024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:48.055278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:47.637403Z","time spent":"417.859882ms","remote":"127.0.0.1:45622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-02T23:48:48.055381Z","caller":"traceutil/trace.go:171","msg":"trace[844157091] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1855; }","duration":"851.869978ms","start":"2026-06-02T23:48:47.202971Z","end":"2026-06-02T23:48:48.054841Z","steps":["trace[844157091] 'agreement among raft nodes before linearized reading' (duration: 851.557728ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:48.055439Z","caller":"traceutil/trace.go:171","msg":"trace[591419149] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1855; }","duration":"793.882826ms","start":"2026-06-02T23:48:47.261077Z","end":"2026-06-02T23:48:48.05496Z","steps":["trace[591419149] 'agreement among raft nodes before linearized reading' (duration: 793.769833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:48.055553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:47.20296Z","time spent":"852.576761ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-02T23:48:48.055564Z","caller":"traceutil/trace.go:171","msg":"trace[106166367] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fb5d8051-9eef-4ff5-a579-d8b451fc7609; range_end:; response_count:1; response_revision:1855; }","duration":"743.773745ms","start":"2026-06-02T23:48:47.311258Z","end":"2026-06-02T23:48:48.055031Z","steps":["trace[106166367] 'agreement among raft nodes before linearized reading' (duration: 743.494995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:48.055723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:47.311223Z","time spent":"744.478788ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fb5d8051-9eef-4ff5-a579-d8b451fc7609\" "} {"level":"warn","ts":"2026-06-02T23:48:48.055571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:47.261057Z","time spent":"794.462835ms","remote":"127.0.0.1:56950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T23:48:48.055606Z","caller":"traceutil/trace.go:171","msg":"trace[289132709] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-fb5d8051-9eef-4ff5-a579-d8b451fc7609; range_end:; response_count:1; response_revision:1855; }","duration":"406.483365ms","start":"2026-06-02T23:48:47.648662Z","end":"2026-06-02T23:48:48.055145Z","steps":["trace[289132709] 'agreement among raft nodes before linearized reading' (duration: 406.174085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:48.055918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:47.648646Z","time spent":"407.21864ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-fb5d8051-9eef-4ff5-a579-d8b451fc7609\" "} {"level":"info","ts":"2026-06-02T23:48:48.055625Z","caller":"traceutil/trace.go:171","msg":"trace[282558608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1855; }","duration":"846.8077ms","start":"2026-06-02T23:48:47.208362Z","end":"2026-06-02T23:48:48.05517Z","steps":["trace[282558608] 'agreement among raft nodes before linearized reading' (duration: 846.601703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:48.056074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:47.208352Z","time spent":"847.703971ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T23:48:48.303998Z","caller":"traceutil/trace.go:171","msg":"trace[465078178] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"242.838668ms","start":"2026-06-02T23:48:48.061123Z","end":"2026-06-02T23:48:48.303962Z","steps":["trace[465078178] 'process raft request' (duration: 151.280929ms)","trace[465078178] 'compare' (duration: 91.29402ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:48:48.304113Z","caller":"traceutil/trace.go:171","msg":"trace[1721951514] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"240.695606ms","start":"2026-06-02T23:48:48.063403Z","end":"2026-06-02T23:48:48.304099Z","steps":["trace[1721951514] 'process raft request' (duration: 240.50035ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:48:48.304188Z","caller":"traceutil/trace.go:171","msg":"trace[326540529] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"242.818228ms","start":"2026-06-02T23:48:48.061359Z","end":"2026-06-02T23:48:48.304178Z","steps":["trace[326540529] 'process raft request' (duration: 242.488227ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:48.913332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.173914ms","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-06-02T23:48:48.913408Z","caller":"traceutil/trace.go:171","msg":"trace[655354003] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1862; }","duration":"345.308128ms","start":"2026-06-02T23:48:48.56808Z","end":"2026-06-02T23:48:48.913388Z","steps":["trace[655354003] 'range keys from in-memory index tree' (duration: 344.966317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:48:48.913462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:48:48.568058Z","time spent":"345.394122ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-02T23:48:56.748164Z","caller":"traceutil/trace.go:171","msg":"trace[96971711] transaction","detail":"{read_only:false; response_revision:1947; number_of_response:1; }","duration":"135.629374ms","start":"2026-06-02T23:48:56.612504Z","end":"2026-06-02T23:48:56.748133Z","steps":["trace[96971711] 'process raft request' (duration: 135.467898ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:02.303619Z","caller":"traceutil/trace.go:171","msg":"trace[657305963] transaction","detail":"{read_only:false; response_revision:1973; number_of_response:1; }","duration":"237.483918ms","start":"2026-06-02T23:49:02.066114Z","end":"2026-06-02T23:49:02.303598Z","steps":["trace[657305963] 'process raft request' (duration: 237.349163ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:02.307561Z","caller":"traceutil/trace.go:171","msg":"trace[562009916] linearizableReadLoop","detail":"{readStateIndex:2053; appliedIndex:2052; }","duration":"181.476527ms","start":"2026-06-02T23:49:02.126065Z","end":"2026-06-02T23:49:02.307542Z","steps":["trace[562009916] 'read index received' (duration: 177.639487ms)","trace[562009916] 'applied index is now lower than readState.Index' (duration: 3.8364ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:49:02.307651Z","caller":"traceutil/trace.go:171","msg":"trace[739268265] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"197.372851ms","start":"2026-06-02T23:49:02.110242Z","end":"2026-06-02T23:49:02.307614Z","steps":["trace[739268265] 'process raft request' (duration: 197.213386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:02.307747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.662683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-02T23:49:02.307783Z","caller":"traceutil/trace.go:171","msg":"trace[941609828] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1974; }","duration":"181.735916ms","start":"2026-06-02T23:49:02.126038Z","end":"2026-06-02T23:49:02.307773Z","steps":["trace[941609828] 'agreement among raft nodes before linearized reading' (duration: 181.601131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:02.307779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.732127ms","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-06-02T23:49:02.307816Z","caller":"traceutil/trace.go:171","msg":"trace[349633701] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1974; }","duration":"159.818179ms","start":"2026-06-02T23:49:02.147987Z","end":"2026-06-02T23:49:02.307806Z","steps":["trace[349633701] 'agreement among raft nodes before linearized reading' (duration: 159.704045ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:20.966327Z","caller":"traceutil/trace.go:171","msg":"trace[1724620124] transaction","detail":"{read_only:false; response_revision:2093; number_of_response:1; }","duration":"447.7797ms","start":"2026-06-02T23:49:20.518531Z","end":"2026-06-02T23:49:20.966311Z","steps":["trace[1724620124] 'process raft request' (duration: 447.516321ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:20.966622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:20.518506Z","time spent":"447.871593ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:49:20.966244Z","caller":"traceutil/trace.go:171","msg":"trace[542332492] linearizableReadLoop","detail":"{readStateIndex:2176; appliedIndex:2175; }","duration":"441.00395ms","start":"2026-06-02T23:49:20.525213Z","end":"2026-06-02T23:49:20.966216Z","steps":["trace[542332492] 'read index received' (duration: 440.772883ms)","trace[542332492] 'applied index is now lower than readState.Index' (duration: 230.167µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:49:20.967006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.732405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-02T23:49:20.967249Z","caller":"traceutil/trace.go:171","msg":"trace[2017912998] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2093; }","duration":"441.976783ms","start":"2026-06-02T23:49:20.52516Z","end":"2026-06-02T23:49:20.967137Z","steps":["trace[2017912998] 'agreement among raft nodes before linearized reading' (duration: 441.268208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:20.967345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:20.525139Z","time spent":"442.190131ms","remote":"127.0.0.1:57184","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":"warn","ts":"2026-06-02T23:49:20.967632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.890426ms","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-06-02T23:49:20.967788Z","caller":"traceutil/trace.go:171","msg":"trace[1781502508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2093; }","duration":"326.087563ms","start":"2026-06-02T23:49:20.64168Z","end":"2026-06-02T23:49:20.967767Z","steps":["trace[1781502508] 'agreement among raft nodes before linearized reading' (duration: 325.821334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:20.967874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:20.64166Z","time spent":"326.200627ms","remote":"127.0.0.1:57184","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-06-02T23:49:21.331337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.95855ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:49:21.331442Z","caller":"traceutil/trace.go:171","msg":"trace[262684809] transaction","detail":"{read_only:false; response_revision:2094; number_of_response:1; }","duration":"359.762404ms","start":"2026-06-02T23:49:20.971661Z","end":"2026-06-02T23:49:21.331423Z","steps":["trace[262684809] 'process raft request' (duration: 126.625699ms)","trace[262684809] 'compare' (duration: 232.836725ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:49:21.331504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:20.971641Z","time spent":"359.832957ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:49:21.362426Z","caller":"traceutil/trace.go:171","msg":"trace[679550573] linearizableReadLoop","detail":"{readStateIndex:2178; appliedIndex:2177; }","duration":"196.82425ms","start":"2026-06-02T23:49:21.165585Z","end":"2026-06-02T23:49:21.362409Z","steps":["trace[679550573] 'read index received' (duration: 196.680265ms)","trace[679550573] 'applied index is now lower than readState.Index' (duration: 143.365µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:49:21.362698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.153426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-02T23:49:21.362802Z","caller":"traceutil/trace.go:171","msg":"trace[1992970778] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2095; }","duration":"191.302421ms","start":"2026-06-02T23:49:21.171489Z","end":"2026-06-02T23:49:21.362792Z","steps":["trace[1992970778] 'agreement among raft nodes before linearized reading' (duration: 191.059602ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:21.362503Z","caller":"traceutil/trace.go:171","msg":"trace[1289995513] transaction","detail":"{read_only:false; response_revision:2095; number_of_response:1; }","duration":"390.301074ms","start":"2026-06-02T23:49:20.972165Z","end":"2026-06-02T23:49:21.362466Z","steps":["trace[1289995513] 'process raft request' (duration: 390.145048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:21.362819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.206723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"warn","ts":"2026-06-02T23:49:21.362845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.325765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b56886d88ec62b\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-02T23:49:21.362899Z","caller":"traceutil/trace.go:171","msg":"trace[277606687] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b56886d88ec62b; range_end:; response_count:1; response_revision:2095; }","duration":"182.397658ms","start":"2026-06-02T23:49:21.180485Z","end":"2026-06-02T23:49:21.362882Z","steps":["trace[277606687] 'agreement among raft nodes before linearized reading' (duration: 182.228632ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:21.362895Z","caller":"traceutil/trace.go:171","msg":"trace[1213109340] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2095; }","duration":"197.329016ms","start":"2026-06-02T23:49:21.165545Z","end":"2026-06-02T23:49:21.362874Z","steps":["trace[1213109340] 'agreement among raft nodes before linearized reading' (duration: 196.952014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:21.362829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.410198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:49:21.362974Z","caller":"traceutil/trace.go:171","msg":"trace[883819111] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2095; }","duration":"100.601454ms","start":"2026-06-02T23:49:21.26235Z","end":"2026-06-02T23:49:21.362952Z","steps":["trace[883819111] 'agreement among raft nodes before linearized reading' (duration: 100.325275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:21.363028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:20.972139Z","time spent":"390.76772ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:49:21.585533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.525756ms","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-06-02T23:49:21.585619Z","caller":"traceutil/trace.go:171","msg":"trace[1524755748] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2097; }","duration":"136.64083ms","start":"2026-06-02T23:49:21.448958Z","end":"2026-06-02T23:49:21.585599Z","steps":["trace[1524755748] 'range keys from in-memory index tree' (duration: 136.323319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:21.585756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.656916ms","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-06-02T23:49:21.585822Z","caller":"traceutil/trace.go:171","msg":"trace[1274273036] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2097; }","duration":"140.76034ms","start":"2026-06-02T23:49:21.445043Z","end":"2026-06-02T23:49:21.585803Z","steps":["trace[1274273036] 'range keys from in-memory index tree' (duration: 140.495141ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:21.88123Z","caller":"traceutil/trace.go:171","msg":"trace[1542943088] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"224.697276ms","start":"2026-06-02T23:49:21.656509Z","end":"2026-06-02T23:49:21.881207Z","steps":["trace[1542943088] 'process raft request' (duration: 224.549041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:22.225143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.666149ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-02T23:49:22.687362Z","caller":"traceutil/trace.go:171","msg":"trace[1059293142] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"317.283404ms","start":"2026-06-02T23:49:22.370053Z","end":"2026-06-02T23:49:22.687336Z","steps":["trace[1059293142] 'process raft request' (duration: 317.105658ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:22.687542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.370031Z","time spent":"317.403188ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:49:23.576627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.579212ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:49:23.576812Z","caller":"traceutil/trace.go:171","msg":"trace[1601201254] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2183; }","duration":"1.173139726s","start":"2026-06-02T23:49:22.403656Z","end":"2026-06-02T23:49:23.576796Z","steps":["trace[1601201254] 'read index received' (duration: 283.498294ms)","trace[1601201254] 'applied index is now lower than readState.Index' (duration: 889.640502ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:49:23.576899Z","caller":"traceutil/trace.go:171","msg":"trace[871238159] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"1.165178115s","start":"2026-06-02T23:49:22.411711Z","end":"2026-06-02T23:49:23.576889Z","steps":["trace[871238159] 'process raft request' (duration: 1.16502698s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.576963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.411697Z","time spent":"1.165226886s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:49:23.577017Z","caller":"traceutil/trace.go:171","msg":"trace[684463503] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"1.205235498s","start":"2026-06-02T23:49:22.371746Z","end":"2026-06-02T23:49:23.576981Z","steps":["trace[684463503] 'process raft request' (duration: 675.221851ms)","trace[684463503] 'compare' (duration: 529.154428ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:49:23.577207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.371718Z","time spent":"1.205397753s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:49:23.577266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.173608231s","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-06-02T23:49:23.577299Z","caller":"traceutil/trace.go:171","msg":"trace[214101461] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2102; }","duration":"1.173676283s","start":"2026-06-02T23:49:22.403613Z","end":"2026-06-02T23:49:23.577289Z","steps":["trace[214101461] 'agreement among raft nodes before linearized reading' (duration: 1.173558119s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.57733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.403594Z","time spent":"1.173729085s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T23:49:23.577496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106950921s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-02T23:49:23.577524Z","caller":"traceutil/trace.go:171","msg":"trace[1947241756] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2102; }","duration":"1.107010563s","start":"2026-06-02T23:49:22.470505Z","end":"2026-06-02T23:49:23.577515Z","steps":["trace[1947241756] 'agreement among raft nodes before linearized reading' (duration: 1.10692094s)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.577555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.470478Z","time spent":"1.107067065s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T23:49:23.577616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.809777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T23:49:23.577675Z","caller":"traceutil/trace.go:171","msg":"trace[1806637833] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:2102; }","duration":"300.881131ms","start":"2026-06-02T23:49:23.276782Z","end":"2026-06-02T23:49:23.577663Z","steps":["trace[1806637833] 'agreement among raft nodes before linearized reading' (duration: 300.761876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.577712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:23.276694Z","time spent":"301.010815ms","remote":"127.0.0.1:57038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":9,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-06-02T23:49:23.577748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"787.784504ms","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-06-02T23:49:23.577788Z","caller":"traceutil/trace.go:171","msg":"trace[1333693949] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2102; }","duration":"787.821597ms","start":"2026-06-02T23:49:22.789955Z","end":"2026-06-02T23:49:23.577776Z","steps":["trace[1333693949] 'agreement among raft nodes before linearized reading' (duration: 787.704283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.577818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.789908Z","time spent":"787.901829ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-02T23:49:23.57789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"984.900096ms","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":"warn","ts":"2026-06-02T23:49:23.57793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100634146s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-02T23:49:23.577962Z","caller":"traceutil/trace.go:171","msg":"trace[576713479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2102; }","duration":"1.100689658s","start":"2026-06-02T23:49:22.477265Z","end":"2026-06-02T23:49:23.577954Z","steps":["trace[576713479] 'agreement among raft nodes before linearized reading' (duration: 1.100612155s)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:23.577971Z","caller":"traceutil/trace.go:171","msg":"trace[191659444] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2102; }","duration":"985.061641ms","start":"2026-06-02T23:49:22.592884Z","end":"2026-06-02T23:49:23.577946Z","steps":["trace[191659444] 'agreement among raft nodes before linearized reading' (duration: 984.830723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.577995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.477252Z","time spent":"1.10073644s","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T23:49:23.578014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.592852Z","time spent":"985.151744ms","remote":"127.0.0.1:45622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-02T23:49:23.578044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.395502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:49:23.577923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.339756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-02T23:49:23.578073Z","caller":"traceutil/trace.go:171","msg":"trace[839731215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2102; }","duration":"817.459124ms","start":"2026-06-02T23:49:22.760607Z","end":"2026-06-02T23:49:23.578066Z","steps":["trace[839731215] 'agreement among raft nodes before linearized reading' (duration: 817.421383ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:23.578083Z","caller":"traceutil/trace.go:171","msg":"trace[647417305] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2102; }","duration":"242.535193ms","start":"2026-06-02T23:49:23.335538Z","end":"2026-06-02T23:49:23.578073Z","steps":["trace[647417305] 'agreement among raft nodes before linearized reading' (duration: 242.306705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.578091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:22.760583Z","time spent":"817.504306ms","remote":"127.0.0.1:56950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T23:49:23.577643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.749631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:49:23.57817Z","caller":"traceutil/trace.go:171","msg":"trace[917043016] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2102; }","duration":"317.310091ms","start":"2026-06-02T23:49:23.260853Z","end":"2026-06-02T23:49:23.578163Z","steps":["trace[917043016] 'agreement among raft nodes before linearized reading' (duration: 316.772211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.578202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:23.260832Z","time spent":"317.362823ms","remote":"127.0.0.1:56942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T23:49:23.578218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.626535ms","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-06-02T23:49:23.578291Z","caller":"traceutil/trace.go:171","msg":"trace[222291445] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2102; }","duration":"210.883614ms","start":"2026-06-02T23:49:23.367393Z","end":"2026-06-02T23:49:23.578277Z","steps":["trace[222291445] 'agreement among raft nodes before linearized reading' (duration: 210.44375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:23.579978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.833984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-02T23:49:23.580038Z","caller":"traceutil/trace.go:171","msg":"trace[907798838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2102; }","duration":"154.918997ms","start":"2026-06-02T23:49:23.425103Z","end":"2026-06-02T23:49:23.580022Z","steps":["trace[907798838] 'agreement among raft nodes before linearized reading' (duration: 152.894469ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:24.438683Z","caller":"traceutil/trace.go:171","msg":"trace[1977733086] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"854.74627ms","start":"2026-06-02T23:49:23.583886Z","end":"2026-06-02T23:49:24.438632Z","steps":["trace[1977733086] 'process raft request' (duration: 854.483271ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:24.438726Z","caller":"traceutil/trace.go:171","msg":"trace[1051625844] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"854.307205ms","start":"2026-06-02T23:49:23.58439Z","end":"2026-06-02T23:49:24.438698Z","steps":["trace[1051625844] 'process raft request' (duration: 854.173531ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:24.438746Z","caller":"traceutil/trace.go:171","msg":"trace[1295824435] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"854.632057ms","start":"2026-06-02T23:49:23.584078Z","end":"2026-06-02T23:49:24.43871Z","steps":["trace[1295824435] 'process raft request' (duration: 854.4457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:24.438863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:23.583848Z","time spent":"854.923977ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:49:24.438881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:23.584382Z","time spent":"854.41798ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:49:24.439059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:23.584068Z","time spent":"854.756431ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:49:24.439287Z","caller":"traceutil/trace.go:171","msg":"trace[1935239895] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"854.71103ms","start":"2026-06-02T23:49:23.584562Z","end":"2026-06-02T23:49:24.439273Z","steps":["trace[1935239895] 'process raft request' (duration: 854.041767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:24.439351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:23.584545Z","time spent":"854.772991ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:49:24.439738Z","caller":"traceutil/trace.go:171","msg":"trace[237086230] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"855.065151ms","start":"2026-06-02T23:49:23.584648Z","end":"2026-06-02T23:49:24.439713Z","steps":["trace[237086230] 'process raft request' (duration: 854.71621ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:24.43995Z","caller":"traceutil/trace.go:171","msg":"trace[122294151] linearizableReadLoop","detail":"{readStateIndex:2193; appliedIndex:2187; }","duration":"176.89491ms","start":"2026-06-02T23:49:24.26299Z","end":"2026-06-02T23:49:24.439885Z","steps":["trace[122294151] 'read index received' (duration: 175.289976ms)","trace[122294151] 'applied index is now lower than readState.Index' (duration: 1.603174ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:49:24.44003Z","caller":"traceutil/trace.go:171","msg":"trace[1947139264] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"855.372072ms","start":"2026-06-02T23:49:23.584643Z","end":"2026-06-02T23:49:24.440015Z","steps":["trace[1947139264] 'process raft request' (duration: 855.010519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:49:24.440101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:23.584631Z","time spent":"855.433063ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:49:24.440192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:49:23.58464Z","time spent":"855.33259ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:49:24.440255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.264602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:49:24.440265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.666538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T23:49:24.440355Z","caller":"traceutil/trace.go:171","msg":"trace[1025517360] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2109; }","duration":"177.394747ms","start":"2026-06-02T23:49:24.262943Z","end":"2026-06-02T23:49:24.440338Z","steps":["trace[1025517360] 'agreement among raft nodes before linearized reading' (duration: 177.271282ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:49:24.44044Z","caller":"traceutil/trace.go:171","msg":"trace[1045732129] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:2109; }","duration":"104.834093ms","start":"2026-06-02T23:49:24.335581Z","end":"2026-06-02T23:49:24.440415Z","steps":["trace[1045732129] 'agreement among raft nodes before linearized reading' (duration: 104.618226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:00.92762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.45314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:553"} {"level":"info","ts":"2026-06-02T23:51:00.927712Z","caller":"traceutil/trace.go:171","msg":"trace[691676512] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2730; }","duration":"780.597352ms","start":"2026-06-02T23:51:00.147094Z","end":"2026-06-02T23:51:00.927692Z","steps":["trace[691676512] 'range keys from in-memory index tree' (duration: 780.217949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:00.927754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:51:00.147073Z","time spent":"780.671224ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-02T23:51:00.927821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.076466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:51:00.927872Z","caller":"traceutil/trace.go:171","msg":"trace[854734589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2730; }","duration":"666.160147ms","start":"2026-06-02T23:51:00.261698Z","end":"2026-06-02T23:51:00.927858Z","steps":["trace[854734589] 'range keys from in-memory index tree' (duration: 666.013855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:00.927905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:51:00.261678Z","time spent":"666.216527ms","remote":"127.0.0.1:56950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T23:51:00.928252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.627863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18b5689a81c397d5\" ","response":"range_response_count:1 size:779"} {"level":"info","ts":"2026-06-02T23:51:00.928334Z","caller":"traceutil/trace.go:171","msg":"trace[781955094] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18b5689a81c397d5; range_end:; response_count:1; response_revision:2730; }","duration":"419.757114ms","start":"2026-06-02T23:51:00.508558Z","end":"2026-06-02T23:51:00.928315Z","steps":["trace[781955094] 'range keys from in-memory index tree' (duration: 419.468092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:00.928378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:51:00.508543Z","time spent":"419.822985ms","remote":"127.0.0.1:57010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":802,"request content":"key:\"/registry/events/auth-system/keycloak-0.18b5689a81c397d5\" "} {"level":"info","ts":"2026-06-02T23:51:01.119102Z","caller":"traceutil/trace.go:171","msg":"trace[639001975] linearizableReadLoop","detail":"{readStateIndex:2837; appliedIndex:2836; }","duration":"186.633657ms","start":"2026-06-02T23:51:00.932447Z","end":"2026-06-02T23:51:01.11908Z","steps":["trace[639001975] 'read index received' (duration: 186.470975ms)","trace[639001975] 'applied index is now lower than readState.Index' (duration: 161.722µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:51:01.11917Z","caller":"traceutil/trace.go:171","msg":"trace[1631347170] transaction","detail":"{read_only:false; response_revision:2731; number_of_response:1; }","duration":"187.650685ms","start":"2026-06-02T23:51:00.931482Z","end":"2026-06-02T23:51:01.119133Z","steps":["trace[1631347170] 'process raft request' (duration: 187.472474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:01.119319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.850779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:51:01.119377Z","caller":"traceutil/trace.go:171","msg":"trace[1336869668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2731; }","duration":"186.93805ms","start":"2026-06-02T23:51:00.932427Z","end":"2026-06-02T23:51:01.119365Z","steps":["trace[1336869668] 'agreement among raft nodes before linearized reading' (duration: 186.799919ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:01.122441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.082909ms","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-06-02T23:51:01.122482Z","caller":"traceutil/trace.go:171","msg":"trace[47342409] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2733; }","duration":"137.148641ms","start":"2026-06-02T23:51:00.985326Z","end":"2026-06-02T23:51:01.122474Z","steps":["trace[47342409] 'agreement among raft nodes before linearized reading' (duration: 137.03602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:01.122534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.18997ms","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-06-02T23:51:01.122597Z","caller":"traceutil/trace.go:171","msg":"trace[1149903451] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2733; }","duration":"125.26034ms","start":"2026-06-02T23:51:00.997316Z","end":"2026-06-02T23:51:01.122576Z","steps":["trace[1149903451] 'agreement among raft nodes before linearized reading' (duration: 125.073789ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:01.122634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.480624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T23:51:01.122681Z","caller":"traceutil/trace.go:171","msg":"trace[651365822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2733; }","duration":"130.561785ms","start":"2026-06-02T23:51:00.992112Z","end":"2026-06-02T23:51:01.122674Z","steps":["trace[651365822] 'agreement among raft nodes before linearized reading' (duration: 130.474915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:01.122595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.62906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-02T23:51:01.122751Z","caller":"traceutil/trace.go:171","msg":"trace[1751024591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2733; }","duration":"127.844872ms","start":"2026-06-02T23:51:00.994899Z","end":"2026-06-02T23:51:01.122744Z","steps":["trace[1751024591] 'agreement among raft nodes before linearized reading' (duration: 127.518249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:51:01.122784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.4874ms","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-06-02T23:51:01.122857Z","caller":"traceutil/trace.go:171","msg":"trace[360976298] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2733; }","duration":"126.602961ms","start":"2026-06-02T23:51:00.99624Z","end":"2026-06-02T23:51:01.122843Z","steps":["trace[360976298] 'agreement among raft nodes before linearized reading' (duration: 126.433209ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:51:01.122901Z","caller":"traceutil/trace.go:171","msg":"trace[36443379] transaction","detail":"{read_only:false; response_revision:2732; number_of_response:1; }","duration":"188.178751ms","start":"2026-06-02T23:51:00.934712Z","end":"2026-06-02T23:51:01.122891Z","steps":["trace[36443379] 'process raft request' (duration: 187.530626ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:29.006896Z","caller":"traceutil/trace.go:171","msg":"trace[1431680450] transaction","detail":"{read_only:false; response_revision:4023; number_of_response:1; }","duration":"157.543572ms","start":"2026-06-02T23:54:28.849325Z","end":"2026-06-02T23:54:29.006869Z","steps":["trace[1431680450] 'process raft request' (duration: 157.305335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:37.285759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.191214ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:54:37.285881Z","caller":"traceutil/trace.go:171","msg":"trace[436175632] linearizableReadLoop","detail":"{readStateIndex:4657; appliedIndex:4656; }","duration":"174.039645ms","start":"2026-06-02T23:54:37.111824Z","end":"2026-06-02T23:54:37.285863Z","steps":["trace[436175632] 'read index received' (duration: 66.668637ms)","trace[436175632] 'applied index is now lower than readState.Index' (duration: 107.369848ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:54:37.286108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.884478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d42b83ae-bf57-4483-ae08-9d027ea8157c\" ","response":"range_response_count:1 size:3894"} {"level":"info","ts":"2026-06-02T23:54:37.286152Z","caller":"traceutil/trace.go:171","msg":"trace[1569564357] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d42b83ae-bf57-4483-ae08-9d027ea8157c; range_end:; response_count:1; response_revision:4481; }","duration":"162.95542ms","start":"2026-06-02T23:54:37.123183Z","end":"2026-06-02T23:54:37.286139Z","steps":["trace[1569564357] 'agreement among raft nodes before linearized reading' (duration: 162.790685ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:37.28614Z","caller":"traceutil/trace.go:171","msg":"trace[1942142769] transaction","detail":"{read_only:false; response_revision:4481; number_of_response:1; }","duration":"198.860259ms","start":"2026-06-02T23:54:37.087237Z","end":"2026-06-02T23:54:37.286097Z","steps":["trace[1942142769] 'process raft request' (duration: 91.224953ms)","trace[1942142769] 'compare' (duration: 107.06752ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:54:37.286492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.604991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-06-02T23:54:37.286809Z","caller":"traceutil/trace.go:171","msg":"trace[1396773214] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:4481; }","duration":"174.985281ms","start":"2026-06-02T23:54:37.111792Z","end":"2026-06-02T23:54:37.286777Z","steps":["trace[1396773214] 'agreement among raft nodes before linearized reading' (duration: 174.187499ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:42.446232Z","caller":"traceutil/trace.go:171","msg":"trace[42204824] linearizableReadLoop","detail":"{readStateIndex:4778; appliedIndex:4777; }","duration":"128.10574ms","start":"2026-06-02T23:54:42.318105Z","end":"2026-06-02T23:54:42.44621Z","steps":["trace[42204824] 'read index received' (duration: 101.39715ms)","trace[42204824] 'applied index is now lower than readState.Index' (duration: 26.70717ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:54:42.446343Z","caller":"traceutil/trace.go:171","msg":"trace[110194045] transaction","detail":"{read_only:false; response_revision:4597; number_of_response:1; }","duration":"154.854242ms","start":"2026-06-02T23:54:42.291475Z","end":"2026-06-02T23:54:42.446329Z","steps":["trace[110194045] 'process raft request' (duration: 128.014298ms)","trace[110194045] 'compare' (duration: 26.616778ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:54:42.446637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.555415ms","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-06-02T23:54:42.446727Z","caller":"traceutil/trace.go:171","msg":"trace[1752912843] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4597; }","duration":"145.676007ms","start":"2026-06-02T23:54:42.301037Z","end":"2026-06-02T23:54:42.446713Z","steps":["trace[1752912843] 'agreement among raft nodes before linearized reading' (duration: 145.485782ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:42.461203Z","caller":"traceutil/trace.go:171","msg":"trace[1249515734] transaction","detail":"{read_only:false; response_revision:4598; number_of_response:1; }","duration":"138.775497ms","start":"2026-06-02T23:54:42.322398Z","end":"2026-06-02T23:54:42.461173Z","steps":["trace[1249515734] 'process raft request' (duration: 137.124161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:42.524286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.223786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:54:42.524376Z","caller":"traceutil/trace.go:171","msg":"trace[1168661369] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:4598; }","duration":"127.329748ms","start":"2026-06-02T23:54:42.397026Z","end":"2026-06-02T23:54:42.524356Z","steps":["trace[1168661369] 'agreement among raft nodes before linearized reading' (duration: 127.168124ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:42.524458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.440014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T23:54:42.524601Z","caller":"traceutil/trace.go:171","msg":"trace[1105222024] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4598; }","duration":"205.622849ms","start":"2026-06-02T23:54:42.318937Z","end":"2026-06-02T23:54:42.52456Z","steps":["trace[1105222024] 'agreement among raft nodes before linearized reading' (duration: 205.370242ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:43.652799Z","caller":"traceutil/trace.go:171","msg":"trace[959288892] linearizableReadLoop","detail":"{readStateIndex:4787; appliedIndex:4786; }","duration":"204.402482ms","start":"2026-06-02T23:54:43.448361Z","end":"2026-06-02T23:54:43.652764Z","steps":["trace[959288892] 'read index received' (duration: 204.005391ms)","trace[959288892] 'applied index is now lower than readState.Index' (duration: 395.951µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:54:43.653286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.866864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T23:54:43.653343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.775944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-4xbr5\" ","response":"range_response_count:1 size:5148"} {"level":"info","ts":"2026-06-02T23:54:43.653411Z","caller":"traceutil/trace.go:171","msg":"trace[1580752944] transaction","detail":"{read_only:false; response_revision:4605; number_of_response:1; }","duration":"341.62273ms","start":"2026-06-02T23:54:43.311746Z","end":"2026-06-02T23:54:43.653368Z","steps":["trace[1580752944] 'process raft request' (duration: 340.775996ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:43.653499Z","caller":"traceutil/trace.go:171","msg":"trace[2113884218] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:4605; }","duration":"205.120241ms","start":"2026-06-02T23:54:43.448294Z","end":"2026-06-02T23:54:43.653414Z","steps":["trace[2113884218] 'agreement among raft nodes before linearized reading' (duration: 204.811032ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:43.653449Z","caller":"traceutil/trace.go:171","msg":"trace[1703450283] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-kube-state-metrics-5c97764fc9-4xbr5; range_end:; response_count:1; response_revision:4605; }","duration":"132.944218ms","start":"2026-06-02T23:54:43.520485Z","end":"2026-06-02T23:54:43.653429Z","steps":["trace[1703450283] 'agreement among raft nodes before linearized reading' (duration: 132.662761ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:43.653747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:54:43.311726Z","time spent":"341.875776ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:54:49.483111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.990504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2131aed-ed36-43fd-9ed9-6df46567a0c2\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-06-02T23:54:49.483483Z","caller":"traceutil/trace.go:171","msg":"trace[590537707] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e2131aed-ed36-43fd-9ed9-6df46567a0c2; range_end:; response_count:1; response_revision:4707; }","duration":"361.395845ms","start":"2026-06-02T23:54:49.122051Z","end":"2026-06-02T23:54:49.483447Z","steps":["trace[590537707] 'range keys from in-memory index tree' (duration: 360.646355ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:49.483701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.552787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:54:49.483768Z","caller":"traceutil/trace.go:171","msg":"trace[1549286459] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4709; }","duration":"222.66342ms","start":"2026-06-02T23:54:49.261089Z","end":"2026-06-02T23:54:49.483752Z","steps":["trace[1549286459] 'agreement among raft nodes before linearized reading' (duration: 222.511356ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:49.483862Z","caller":"traceutil/trace.go:171","msg":"trace[875300756] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"315.406041ms","start":"2026-06-02T23:54:49.168416Z","end":"2026-06-02T23:54:49.483822Z","steps":["trace[875300756] 'process raft request' (duration: 311.462671ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:49.483972Z","caller":"traceutil/trace.go:171","msg":"trace[1310115920] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"314.616429ms","start":"2026-06-02T23:54:49.169329Z","end":"2026-06-02T23:54:49.483945Z","steps":["trace[1310115920] 'process raft request' (duration: 314.133965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:49.484029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:54:49.168387Z","time spent":"315.555185ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:54:49.484095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:54:49.169309Z","time spent":"314.722272ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:54:49.483563Z","caller":"traceutil/trace.go:171","msg":"trace[938233232] linearizableReadLoop","detail":"{readStateIndex:4895; appliedIndex:4893; }","duration":"222.393222ms","start":"2026-06-02T23:54:49.261151Z","end":"2026-06-02T23:54:49.483544Z","steps":["trace[938233232] 'read index received' (duration: 218.705229ms)","trace[938233232] 'applied index is now lower than readState.Index' (duration: 3.686573ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:54:49.484502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.965827ms","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-06-02T23:54:49.484587Z","caller":"traceutil/trace.go:171","msg":"trace[1024267835] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:4709; }","duration":"190.0967ms","start":"2026-06-02T23:54:49.294476Z","end":"2026-06-02T23:54:49.484573Z","steps":["trace[1024267835] 'agreement among raft nodes before linearized reading' (duration: 189.976717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:49.484717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:54:49.122031Z","time spent":"362.454936ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2131aed-ed36-43fd-9ed9-6df46567a0c2\" "} {"level":"info","ts":"2026-06-02T23:54:49.65997Z","caller":"traceutil/trace.go:171","msg":"trace[1093164474] linearizableReadLoop","detail":"{readStateIndex:4896; appliedIndex:4895; }","duration":"168.96799ms","start":"2026-06-02T23:54:49.490981Z","end":"2026-06-02T23:54:49.659949Z","steps":["trace[1093164474] 'read index received' (duration: 168.862307ms)","trace[1093164474] 'applied index is now lower than readState.Index' (duration: 104.943µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:54:49.66006Z","caller":"traceutil/trace.go:171","msg":"trace[229315715] transaction","detail":"{read_only:false; response_revision:4710; number_of_response:1; }","duration":"169.421053ms","start":"2026-06-02T23:54:49.49063Z","end":"2026-06-02T23:54:49.660052Z","steps":["trace[229315715] 'process raft request' (duration: 169.204327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:49.660287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.298679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:54:49.660311Z","caller":"traceutil/trace.go:171","msg":"trace[1690589278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4710; }","duration":"169.356681ms","start":"2026-06-02T23:54:49.490946Z","end":"2026-06-02T23:54:49.660303Z","steps":["trace[1690589278] 'agreement among raft nodes before linearized reading' (duration: 169.293969ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:49.669727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.504657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-06-02T23:54:49.66978Z","caller":"traceutil/trace.go:171","msg":"trace[1048424379] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4711; }","duration":"178.559099ms","start":"2026-06-02T23:54:49.491207Z","end":"2026-06-02T23:54:49.669766Z","steps":["trace[1048424379] 'agreement among raft nodes before linearized reading' (duration: 178.415245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:49.669799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.377687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-02T23:54:49.669856Z","caller":"traceutil/trace.go:171","msg":"trace[1265744782] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4711; }","duration":"133.452109ms","start":"2026-06-02T23:54:49.536388Z","end":"2026-06-02T23:54:49.66984Z","steps":["trace[1265744782] 'agreement among raft nodes before linearized reading' (duration: 133.239853ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:49.820984Z","caller":"traceutil/trace.go:171","msg":"trace[1561664623] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"108.585484ms","start":"2026-06-02T23:54:49.712365Z","end":"2026-06-02T23:54:49.82095Z","steps":["trace[1561664623] 'process raft request' (duration: 108.190833ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:49.821071Z","caller":"traceutil/trace.go:171","msg":"trace[1620574148] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"108.294395ms","start":"2026-06-02T23:54:49.712751Z","end":"2026-06-02T23:54:49.821046Z","steps":["trace[1620574148] 'process raft request' (duration: 108.029618ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:49.821199Z","caller":"traceutil/trace.go:171","msg":"trace[1165540648] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"108.124761ms","start":"2026-06-02T23:54:49.713021Z","end":"2026-06-02T23:54:49.821146Z","steps":["trace[1165540648] 'process raft request' (duration: 107.944606ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:50.527321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.21494ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:54:50.52747Z","caller":"traceutil/trace.go:171","msg":"trace[408124786] transaction","detail":"{read_only:false; response_revision:4721; number_of_response:1; }","duration":"261.345539ms","start":"2026-06-02T23:54:50.266112Z","end":"2026-06-02T23:54:50.527458Z","steps":["trace[408124786] 'process raft request' (duration: 261.289417ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:50.527506Z","caller":"traceutil/trace.go:171","msg":"trace[438489390] transaction","detail":"{read_only:false; response_revision:4720; number_of_response:1; }","duration":"598.374972ms","start":"2026-06-02T23:54:49.929096Z","end":"2026-06-02T23:54:50.527471Z","steps":["trace[438489390] 'process raft request' (duration: 319.945506ms)","trace[438489390] 'compare' (duration: 278.120347ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:54:50.527627Z","caller":"traceutil/trace.go:171","msg":"trace[309017271] linearizableReadLoop","detail":"{readStateIndex:4906; appliedIndex:4905; }","duration":"265.930797ms","start":"2026-06-02T23:54:50.261689Z","end":"2026-06-02T23:54:50.52762Z","steps":["trace[309017271] 'read index received' (duration: 35.441µs)","trace[309017271] 'applied index is now lower than readState.Index' (duration: 265.894476ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:54:50.527626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:54:49.929071Z","time spent":"598.491575ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:54:50.527962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.067915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-02T23:54:50.527941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.02039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-02T23:54:50.528087Z","caller":"traceutil/trace.go:171","msg":"trace[2128154273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4721; }","duration":"207.219445ms","start":"2026-06-02T23:54:50.320844Z","end":"2026-06-02T23:54:50.528064Z","steps":["trace[2128154273] 'agreement among raft nodes before linearized reading' (duration: 206.872726ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:50.5283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.485021ms","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-06-02T23:54:50.527997Z","caller":"traceutil/trace.go:171","msg":"trace[1519545075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4721; }","duration":"175.133507ms","start":"2026-06-02T23:54:50.352856Z","end":"2026-06-02T23:54:50.52799Z","steps":["trace[1519545075] 'agreement among raft nodes before linearized reading' (duration: 175.000724ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:50.528348Z","caller":"traceutil/trace.go:171","msg":"trace[497635353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4721; }","duration":"178.558333ms","start":"2026-06-02T23:54:50.349768Z","end":"2026-06-02T23:54:50.528326Z","steps":["trace[497635353] 'agreement among raft nodes before linearized reading' (duration: 178.488441ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:50.52797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.285377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:54:50.528443Z","caller":"traceutil/trace.go:171","msg":"trace[633043416] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4721; }","duration":"266.788831ms","start":"2026-06-02T23:54:50.261649Z","end":"2026-06-02T23:54:50.528437Z","steps":["trace[633043416] 'agreement among raft nodes before linearized reading' (duration: 266.299007ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:50.528442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.59473ms","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-06-02T23:54:50.52847Z","caller":"traceutil/trace.go:171","msg":"trace[2048075975] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4721; }","duration":"175.644651ms","start":"2026-06-02T23:54:50.352816Z","end":"2026-06-02T23:54:50.528461Z","steps":["trace[2048075975] 'agreement among raft nodes before linearized reading' (duration: 175.58208ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:50.741852Z","caller":"traceutil/trace.go:171","msg":"trace[592524330] transaction","detail":"{read_only:false; response_revision:4725; number_of_response:1; }","duration":"205.997571ms","start":"2026-06-02T23:54:50.535829Z","end":"2026-06-02T23:54:50.741826Z","steps":["trace[592524330] 'process raft request' (duration: 205.928939ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:50.742183Z","caller":"traceutil/trace.go:171","msg":"trace[875346756] transaction","detail":"{read_only:false; response_revision:4726; number_of_response:1; }","duration":"205.910669ms","start":"2026-06-02T23:54:50.536237Z","end":"2026-06-02T23:54:50.742148Z","steps":["trace[875346756] 'process raft request' (duration: 205.550299ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:50.742312Z","caller":"traceutil/trace.go:171","msg":"trace[1472023787] transaction","detail":"{read_only:false; response_revision:4728; number_of_response:1; }","duration":"204.087558ms","start":"2026-06-02T23:54:50.538207Z","end":"2026-06-02T23:54:50.742294Z","steps":["trace[1472023787] 'process raft request' (duration: 203.886902ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:50.742262Z","caller":"traceutil/trace.go:171","msg":"trace[2051275538] transaction","detail":"{read_only:false; response_revision:4724; number_of_response:1; }","duration":"206.424933ms","start":"2026-06-02T23:54:50.535829Z","end":"2026-06-02T23:54:50.742254Z","steps":["trace[2051275538] 'process raft request' (duration: 205.887018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:50.742389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.47537ms","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-06-02T23:54:50.742459Z","caller":"traceutil/trace.go:171","msg":"trace[606370509] 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:4728; }","duration":"149.591884ms","start":"2026-06-02T23:54:50.592849Z","end":"2026-06-02T23:54:50.742441Z","steps":["trace[606370509] 'agreement among raft nodes before linearized reading' (duration: 149.390438ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:50.742186Z","caller":"traceutil/trace.go:171","msg":"trace[2105219302] linearizableReadLoop","detail":"{readStateIndex:4914; appliedIndex:4908; }","duration":"149.280865ms","start":"2026-06-02T23:54:50.592887Z","end":"2026-06-02T23:54:50.742168Z","steps":["trace[2105219302] 'read index received' (duration: 148.593285ms)","trace[2105219302] 'applied index is now lower than readState.Index' (duration: 686.29µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:54:50.742541Z","caller":"traceutil/trace.go:171","msg":"trace[63210803] transaction","detail":"{read_only:false; response_revision:4727; number_of_response:1; }","duration":"205.914709ms","start":"2026-06-02T23:54:50.536602Z","end":"2026-06-02T23:54:50.742517Z","steps":["trace[63210803] 'process raft request' (duration: 205.349973ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:50.742189Z","caller":"traceutil/trace.go:171","msg":"trace[996182912] transaction","detail":"{read_only:false; response_revision:4723; number_of_response:1; }","duration":"206.34142ms","start":"2026-06-02T23:54:50.53583Z","end":"2026-06-02T23:54:50.742171Z","steps":["trace[996182912] 'process raft request' (duration: 205.713502ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:54:53.895872Z","caller":"traceutil/trace.go:171","msg":"trace[1873559242] linearizableReadLoop","detail":"{readStateIndex:4947; appliedIndex:4946; }","duration":"351.648275ms","start":"2026-06-02T23:54:53.544211Z","end":"2026-06-02T23:54:53.895859Z","steps":["trace[1873559242] 'read index received' (duration: 351.511351ms)","trace[1873559242] 'applied index is now lower than readState.Index' (duration: 136.434µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:54:53.896033Z","caller":"traceutil/trace.go:171","msg":"trace[1311577803] transaction","detail":"{read_only:false; response_revision:4760; number_of_response:1; }","duration":"354.324109ms","start":"2026-06-02T23:54:53.541702Z","end":"2026-06-02T23:54:53.896026Z","steps":["trace[1311577803] 'process raft request' (duration: 354.073812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:53.89611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:54:53.54169Z","time spent":"354.364982ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3936,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:54:53.896209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.974015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2131aed-ed36-43fd-9ed9-6df46567a0c2\" ","response":"range_response_count:1 size:3951"} {"level":"info","ts":"2026-06-02T23:54:53.896263Z","caller":"traceutil/trace.go:171","msg":"trace[432217611] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e2131aed-ed36-43fd-9ed9-6df46567a0c2; range_end:; response_count:1; response_revision:4760; }","duration":"352.069067ms","start":"2026-06-02T23:54:53.544181Z","end":"2026-06-02T23:54:53.89625Z","steps":["trace[432217611] 'agreement among raft nodes before linearized reading' (duration: 351.938914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:53.896292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:54:53.544166Z","time spent":"352.121149ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3974,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e2131aed-ed36-43fd-9ed9-6df46567a0c2\" "} {"level":"warn","ts":"2026-06-02T23:54:53.89631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.216921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T23:54:53.89639Z","caller":"traceutil/trace.go:171","msg":"trace[469831556] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:4760; }","duration":"265.337264ms","start":"2026-06-02T23:54:53.631034Z","end":"2026-06-02T23:54:53.896371Z","steps":["trace[469831556] 'agreement among raft nodes before linearized reading' (duration: 265.18839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:54:58.8985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.827476ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T23:54:58.898638Z","caller":"traceutil/trace.go:171","msg":"trace[1784789905] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"171.114276ms","start":"2026-06-02T23:54:58.727505Z","end":"2026-06-02T23:54:58.89862Z","steps":["trace[1784789905] 'process raft request' (duration: 65.080634ms)","trace[1784789905] 'compare' (duration: 105.485386ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:55:02.95675Z","caller":"traceutil/trace.go:171","msg":"trace[35899745] linearizableReadLoop","detail":"{readStateIndex:5066; appliedIndex:5065; }","duration":"364.423537ms","start":"2026-06-02T23:55:02.5923Z","end":"2026-06-02T23:55:02.956723Z","steps":["trace[35899745] 'read index received' (duration: 348.251079ms)","trace[35899745] 'applied index is now lower than readState.Index' (duration: 16.171168ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:55:02.956825Z","caller":"traceutil/trace.go:171","msg":"trace[118996272] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"385.656518ms","start":"2026-06-02T23:55:02.571135Z","end":"2026-06-02T23:55:02.956791Z","steps":["trace[118996272] 'process raft request' (duration: 369.47203ms)","trace[118996272] 'compare' (duration: 15.857339ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:55:02.956986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.675084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-02T23:55:02.957019Z","caller":"traceutil/trace.go:171","msg":"trace[1771904101] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4873; }","duration":"364.763706ms","start":"2026-06-02T23:55:02.592246Z","end":"2026-06-02T23:55:02.957009Z","steps":["trace[1771904101] 'agreement among raft nodes before linearized reading' (duration: 364.603591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:55:02.95705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:55:02.592191Z","time spent":"364.851219ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T23:55:02.956999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:55:02.571104Z","time spent":"385.808382ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:55:02.957344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.439857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-06-02T23:55:02.957437Z","caller":"traceutil/trace.go:171","msg":"trace[501360571] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4873; }","duration":"328.570451ms","start":"2026-06-02T23:55:02.628843Z","end":"2026-06-02T23:55:02.957414Z","steps":["trace[501360571] 'agreement among raft nodes before linearized reading' (duration: 328.303764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:55:02.957515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:55:02.62883Z","time spent":"328.649863ms","remote":"127.0.0.1:57108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10415,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-06-02T23:55:02.957957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.081006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"warn","ts":"2026-06-02T23:55:02.957952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.575245ms","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-06-02T23:55:02.957983Z","caller":"traceutil/trace.go:171","msg":"trace[1011158044] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4873; }","duration":"193.143778ms","start":"2026-06-02T23:55:02.764832Z","end":"2026-06-02T23:55:02.957976Z","steps":["trace[1011158044] 'agreement among raft nodes before linearized reading' (duration: 193.074966ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:02.957994Z","caller":"traceutil/trace.go:171","msg":"trace[1575468009] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4873; }","duration":"308.639987ms","start":"2026-06-02T23:55:02.649343Z","end":"2026-06-02T23:55:02.957983Z","steps":["trace[1575468009] 'agreement among raft nodes before linearized reading' (duration: 308.540624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:55:02.958022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:55:02.649332Z","time spent":"308.683008ms","remote":"127.0.0.1:57086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-02T23:55:03.108699Z","caller":"traceutil/trace.go:171","msg":"trace[1129346278] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"145.012549ms","start":"2026-06-02T23:55:02.963659Z","end":"2026-06-02T23:55:03.108671Z","steps":["trace[1129346278] 'process raft request' (duration: 138.752662ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.121914Z","caller":"traceutil/trace.go:171","msg":"trace[1956982015] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"158.237594ms","start":"2026-06-02T23:55:02.963659Z","end":"2026-06-02T23:55:03.121896Z","steps":["trace[1956982015] 'process raft request' (duration: 158.09196ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.122197Z","caller":"traceutil/trace.go:171","msg":"trace[790850541] transaction","detail":"{read_only:false; response_revision:4876; number_of_response:1; }","duration":"158.513991ms","start":"2026-06-02T23:55:02.963671Z","end":"2026-06-02T23:55:03.122185Z","steps":["trace[790850541] 'process raft request' (duration: 158.183351ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.122357Z","caller":"traceutil/trace.go:171","msg":"trace[1579620906] transaction","detail":"{read_only:false; response_revision:4877; number_of_response:1; }","duration":"158.597504ms","start":"2026-06-02T23:55:02.963731Z","end":"2026-06-02T23:55:03.122329Z","steps":["trace[1579620906] 'process raft request' (duration: 158.310686ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.122586Z","caller":"traceutil/trace.go:171","msg":"trace[968815895] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"158.676375ms","start":"2026-06-02T23:55:02.96388Z","end":"2026-06-02T23:55:03.122557Z","steps":["trace[968815895] 'process raft request' (duration: 158.282064ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.123056Z","caller":"traceutil/trace.go:171","msg":"trace[1184310709] linearizableReadLoop","detail":"{readStateIndex:5071; appliedIndex:5066; }","duration":"158.731705ms","start":"2026-06-02T23:55:02.964305Z","end":"2026-06-02T23:55:03.123037Z","steps":["trace[1184310709] 'read index received' (duration: 138.189104ms)","trace[1184310709] 'applied index is now lower than readState.Index' (duration: 20.541201ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:55:03.123098Z","caller":"traceutil/trace.go:171","msg":"trace[1699418935] transaction","detail":"{read_only:false; response_revision:4880; number_of_response:1; }","duration":"153.448747ms","start":"2026-06-02T23:55:02.96964Z","end":"2026-06-02T23:55:03.123089Z","steps":["trace[1699418935] 'process raft request' (duration: 153.279742ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.123134Z","caller":"traceutil/trace.go:171","msg":"trace[486133827] transaction","detail":"{read_only:false; response_revision:4879; number_of_response:1; }","duration":"158.285923ms","start":"2026-06-02T23:55:02.964821Z","end":"2026-06-02T23:55:03.123107Z","steps":["trace[486133827] 'process raft request' (duration: 157.45696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:55:03.123259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.932612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:11719"} {"level":"info","ts":"2026-06-02T23:55:03.123309Z","caller":"traceutil/trace.go:171","msg":"trace[1137470683] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4880; }","duration":"159.011884ms","start":"2026-06-02T23:55:02.964282Z","end":"2026-06-02T23:55:03.123294Z","steps":["trace[1137470683] 'agreement among raft nodes before linearized reading' (duration: 158.832489ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.32306Z","caller":"traceutil/trace.go:171","msg":"trace[155150272] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"191.26559ms","start":"2026-06-02T23:55:03.131766Z","end":"2026-06-02T23:55:03.323031Z","steps":["trace[155150272] 'process raft request' (duration: 101.759534ms)","trace[155150272] 'compare' (duration: 89.381993ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:55:03.334534Z","caller":"traceutil/trace.go:171","msg":"trace[589682460] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"202.630812ms","start":"2026-06-02T23:55:03.131892Z","end":"2026-06-02T23:55:03.334523Z","steps":["trace[589682460] 'process raft request' (duration: 202.508728ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.334893Z","caller":"traceutil/trace.go:171","msg":"trace[1492841159] linearizableReadLoop","detail":"{readStateIndex:5077; appliedIndex:5073; }","duration":"198.137785ms","start":"2026-06-02T23:55:03.136737Z","end":"2026-06-02T23:55:03.334875Z","steps":["trace[1492841159] 'read index received' (duration: 96.732212ms)","trace[1492841159] 'applied index is now lower than readState.Index' (duration: 101.404443ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:55:03.335028Z","caller":"traceutil/trace.go:171","msg":"trace[1800143094] transaction","detail":"{read_only:false; response_revision:4883; number_of_response:1; }","duration":"203.066285ms","start":"2026-06-02T23:55:03.131952Z","end":"2026-06-02T23:55:03.335019Z","steps":["trace[1800143094] 'process raft request' (duration: 202.518549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:55:03.335442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.92658ms","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-06-02T23:55:03.335509Z","caller":"traceutil/trace.go:171","msg":"trace[1868842269] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4884; }","duration":"161.027362ms","start":"2026-06-02T23:55:03.174468Z","end":"2026-06-02T23:55:03.335496Z","steps":["trace[1868842269] 'agreement among raft nodes before linearized reading' (duration: 160.914329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:55:03.33561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.856855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"info","ts":"2026-06-02T23:55:03.335678Z","caller":"traceutil/trace.go:171","msg":"trace[644297246] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4884; }","duration":"198.964148ms","start":"2026-06-02T23:55:03.136704Z","end":"2026-06-02T23:55:03.335669Z","steps":["trace[644297246] 'agreement among raft nodes before linearized reading' (duration: 198.778273ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.33591Z","caller":"traceutil/trace.go:171","msg":"trace[1262221935] transaction","detail":"{read_only:false; response_revision:4884; number_of_response:1; }","duration":"203.678491ms","start":"2026-06-02T23:55:03.132223Z","end":"2026-06-02T23:55:03.335902Z","steps":["trace[1262221935] 'process raft request' (duration: 202.55301ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.838673Z","caller":"traceutil/trace.go:171","msg":"trace[1994192306] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"253.112663ms","start":"2026-06-02T23:55:03.58551Z","end":"2026-06-02T23:55:03.838622Z","steps":["trace[1994192306] 'process raft request' (duration: 176.975784ms)","trace[1994192306] 'compare' (duration: 75.859731ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:55:03.838735Z","caller":"traceutil/trace.go:171","msg":"trace[665379549] linearizableReadLoop","detail":"{readStateIndex:5088; appliedIndex:5085; }","duration":"164.739228ms","start":"2026-06-02T23:55:03.673973Z","end":"2026-06-02T23:55:03.838713Z","steps":["trace[665379549] 'read index received' (duration: 88.513447ms)","trace[665379549] 'applied index is now lower than readState.Index' (duration: 76.224731ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:55:03.838894Z","caller":"traceutil/trace.go:171","msg":"trace[566166658] transaction","detail":"{read_only:false; response_revision:4895; number_of_response:1; }","duration":"246.867685ms","start":"2026-06-02T23:55:03.592007Z","end":"2026-06-02T23:55:03.838874Z","steps":["trace[566166658] 'process raft request' (duration: 246.587057ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:03.839029Z","caller":"traceutil/trace.go:171","msg":"trace[1422795765] transaction","detail":"{read_only:false; response_revision:4894; number_of_response:1; }","duration":"247.976718ms","start":"2026-06-02T23:55:03.591034Z","end":"2026-06-02T23:55:03.83901Z","steps":["trace[1422795765] 'process raft request' (duration: 247.485804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:55:03.839273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.281083ms","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-06-02T23:55:03.83933Z","caller":"traceutil/trace.go:171","msg":"trace[2069262362] 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:4895; }","duration":"165.380176ms","start":"2026-06-02T23:55:03.673933Z","end":"2026-06-02T23:55:03.839313Z","steps":["trace[2069262362] 'agreement among raft nodes before linearized reading' (duration: 165.206061ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:04.845882Z","caller":"traceutil/trace.go:171","msg":"trace[1526566305] transaction","detail":"{read_only:false; response_revision:4902; number_of_response:1; }","duration":"179.909072ms","start":"2026-06-02T23:55:04.66595Z","end":"2026-06-02T23:55:04.845859Z","steps":["trace[1526566305] 'process raft request' (duration: 179.717217ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:55:04.860891Z","caller":"traceutil/trace.go:171","msg":"trace[246103915] linearizableReadLoop","detail":"{readStateIndex:5096; appliedIndex:5094; }","duration":"158.700571ms","start":"2026-06-02T23:55:04.702164Z","end":"2026-06-02T23:55:04.860864Z","steps":["trace[246103915] 'read index received' (duration: 143.544521ms)","trace[246103915] 'applied index is now lower than readState.Index' (duration: 15.15528ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:55:04.860925Z","caller":"traceutil/trace.go:171","msg":"trace[764101441] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"181.346053ms","start":"2026-06-02T23:55:04.679555Z","end":"2026-06-02T23:55:04.860901Z","steps":["trace[764101441] 'process raft request' (duration: 181.203819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:55:04.889227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.040925ms","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-06-02T23:55:04.889339Z","caller":"traceutil/trace.go:171","msg":"trace[197961572] 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:4903; }","duration":"187.201249ms","start":"2026-06-02T23:55:04.702115Z","end":"2026-06-02T23:55:04.889316Z","steps":["trace[197961572] 'agreement among raft nodes before linearized reading' (duration: 158.825215ms)","trace[197961572] 'range keys from in-memory index tree' (duration: 28.132278ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:56:24.178691Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2856} {"level":"info","ts":"2026-06-02T23:56:24.266639Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2856,"took":"86.778111ms","hash":93345224,"current-db-size-bytes":53010432,"current-db-size":"53 MB","current-db-size-in-use-bytes":29179904,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-02T23:56:24.266717Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":93345224,"revision":2856,"compact-revision":-1} {"level":"info","ts":"2026-06-02T23:58:49.408808Z","caller":"traceutil/trace.go:171","msg":"trace[2002277808] transaction","detail":"{read_only:false; response_revision:6523; number_of_response:1; }","duration":"107.681822ms","start":"2026-06-02T23:58:49.301076Z","end":"2026-06-02T23:58:49.408758Z","steps":["trace[2002277808] 'process raft request' (duration: 78.279654ms)","trace[2002277808] 'compare' (duration: 28.759418ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:59:10.954583Z","caller":"traceutil/trace.go:171","msg":"trace[66996439] transaction","detail":"{read_only:false; response_revision:6684; number_of_response:1; }","duration":"474.591554ms","start":"2026-06-02T23:59:10.479973Z","end":"2026-06-02T23:59:10.954565Z","steps":["trace[66996439] 'process raft request' (duration: 474.469092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:59:10.954719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:59:10.479962Z","time spent":"474.673525ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:59:10.954883Z","caller":"traceutil/trace.go:171","msg":"trace[786920781] transaction","detail":"{read_only:false; response_revision:6686; number_of_response:1; }","duration":"471.128338ms","start":"2026-06-02T23:59:10.483734Z","end":"2026-06-02T23:59:10.954862Z","steps":["trace[786920781] 'process raft request' (duration: 471.013576ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:59:10.954967Z","caller":"traceutil/trace.go:171","msg":"trace[1695908813] transaction","detail":"{read_only:false; response_revision:6687; number_of_response:1; }","duration":"471.006835ms","start":"2026-06-02T23:59:10.483952Z","end":"2026-06-02T23:59:10.954959Z","steps":["trace[1695908813] 'process raft request' (duration: 470.877673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:59:10.955006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:59:10.483947Z","time spent":"471.039126ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:59:10.955008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:59:10.483726Z","time spent":"471.215019ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T23:59:10.95519Z","caller":"traceutil/trace.go:171","msg":"trace[1551374233] transaction","detail":"{read_only:false; response_revision:6685; number_of_response:1; }","duration":"472.166554ms","start":"2026-06-02T23:59:10.483018Z","end":"2026-06-02T23:59:10.955184Z","steps":["trace[1551374233] 'process raft request' (duration: 471.522963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:59:10.955223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:59:10.483011Z","time spent":"472.197024ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T23:59:10.955376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.258865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-02T23:59:10.955397Z","caller":"traceutil/trace.go:171","msg":"trace[1402388659] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6687; }","duration":"475.282515ms","start":"2026-06-02T23:59:10.48011Z","end":"2026-06-02T23:59:10.955393Z","steps":["trace[1402388659] 'agreement among raft nodes before linearized reading' (duration: 475.208644ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:59:10.955411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:59:10.480094Z","time spent":"475.314547ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T23:59:10.955653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.863886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-02T23:59:10.955678Z","caller":"traceutil/trace.go:171","msg":"trace[1540453601] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6687; }","duration":"475.919586ms","start":"2026-06-02T23:59:10.479752Z","end":"2026-06-02T23:59:10.955672Z","steps":["trace[1540453601] 'agreement among raft nodes before linearized reading' (duration: 475.850435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:59:10.955693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:59:10.479734Z","time spent":"475.955487ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-02T23:59:10.956766Z","caller":"traceutil/trace.go:171","msg":"trace[2046254761] linearizableReadLoop","detail":"{readStateIndex:6937; appliedIndex:6936; }","duration":"474.679136ms","start":"2026-06-02T23:59:10.48025Z","end":"2026-06-02T23:59:10.954929Z","steps":["trace[2046254761] 'read index received' (duration: 87.292192ms)","trace[2046254761] 'applied index is now lower than readState.Index' (duration: 387.385854ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:59:10.957087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.234163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107247"} {"level":"info","ts":"2026-06-02T23:59:10.957114Z","caller":"traceutil/trace.go:171","msg":"trace[1782108903] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:6687; }","duration":"440.289373ms","start":"2026-06-02T23:59:10.516817Z","end":"2026-06-02T23:59:10.957106Z","steps":["trace[1782108903] 'agreement among raft nodes before linearized reading' (duration: 440.191932ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T23:59:10.957129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T23:59:10.516801Z","time spent":"440.324534ms","remote":"127.0.0.1:57020","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":2,"response size":107270,"request content":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" "} {"level":"info","ts":"2026-06-02T23:59:49.273448Z","caller":"traceutil/trace.go:171","msg":"trace[1167819015] transaction","detail":"{read_only:false; response_revision:6888; number_of_response:1; }","duration":"102.531521ms","start":"2026-06-02T23:59:49.170858Z","end":"2026-06-02T23:59:49.273389Z","steps":["trace[1167819015] 'process raft request' (duration: 57.306223ms)","trace[1167819015] 'compare' (duration: 45.008814ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:59:50.68402Z","caller":"traceutil/trace.go:171","msg":"trace[1088512465] transaction","detail":"{read_only:false; response_revision:6894; number_of_response:1; }","duration":"112.735857ms","start":"2026-06-02T23:59:50.571271Z","end":"2026-06-02T23:59:50.684006Z","steps":["trace[1088512465] 'process raft request' (duration: 112.658915ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:59:50.716325Z","caller":"traceutil/trace.go:171","msg":"trace[862821643] transaction","detail":"{read_only:false; response_revision:6895; number_of_response:1; }","duration":"100.533179ms","start":"2026-06-02T23:59:50.615774Z","end":"2026-06-02T23:59:50.716307Z","steps":["trace[862821643] 'process raft request' (duration: 100.144162ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T23:59:57.484029Z","caller":"traceutil/trace.go:171","msg":"trace[377063174] linearizableReadLoop","detail":"{readStateIndex:7211; appliedIndex:7210; }","duration":"130.15641ms","start":"2026-06-02T23:59:57.353847Z","end":"2026-06-02T23:59:57.484003Z","steps":["trace[377063174] 'read index received' (duration: 53.003011ms)","trace[377063174] 'applied index is now lower than readState.Index' (duration: 77.152329ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T23:59:57.484128Z","caller":"traceutil/trace.go:171","msg":"trace[707907472] transaction","detail":"{read_only:false; response_revision:6948; number_of_response:1; }","duration":"134.637115ms","start":"2026-06-02T23:59:57.349482Z","end":"2026-06-02T23:59:57.484119Z","steps":["trace[707907472] 'process raft request' (duration: 57.443006ms)","trace[707907472] 'compare' (duration: 76.412534ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T23:59:57.484449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.588948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-02T23:59:57.484479Z","caller":"traceutil/trace.go:171","msg":"trace[1571837456] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6948; }","duration":"130.657998ms","start":"2026-06-02T23:59:57.353813Z","end":"2026-06-02T23:59:57.484471Z","steps":["trace[1571837456] 'agreement among raft nodes before linearized reading' (duration: 130.531026ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T00:00:08.428718Z","caller":"traceutil/trace.go:171","msg":"trace[1026169939] transaction","detail":"{read_only:false; response_revision:7025; number_of_response:1; }","duration":"101.110429ms","start":"2026-06-03T00:00:08.327585Z","end":"2026-06-03T00:00:08.428696Z","steps":["trace[1026169939] 'process raft request' (duration: 94.746735ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T00:01:24.184356Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5533} {"level":"info","ts":"2026-06-03T00:01:24.26073Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5533,"took":"75.378409ms","hash":3533447245,"current-db-size-bytes":53010432,"current-db-size":"53 MB","current-db-size-in-use-bytes":18391040,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-03T00:01:24.260786Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3533447245,"revision":5533,"compact-revision":2856} {"level":"info","ts":"2026-06-03T00:01:40.811351Z","caller":"traceutil/trace.go:171","msg":"trace[1869722073] linearizableReadLoop","detail":"{readStateIndex:7789; appliedIndex:7788; }","duration":"102.345586ms","start":"2026-06-03T00:01:40.708986Z","end":"2026-06-03T00:01:40.811332Z","steps":["trace[1869722073] 'read index received' (duration: 102.166682ms)","trace[1869722073] 'applied index is now lower than readState.Index' (duration: 178.134µs)"],"step_count":2} {"level":"warn","ts":"2026-06-03T00:01:40.811529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.526069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager\" ","response":"range_response_count:1 size:968"} {"level":"info","ts":"2026-06-03T00:01:40.811463Z","caller":"traceutil/trace.go:171","msg":"trace[1469078635] transaction","detail":"{read_only:false; response_revision:7504; number_of_response:1; }","duration":"132.504829ms","start":"2026-06-03T00:01:40.678923Z","end":"2026-06-03T00:01:40.811428Z","steps":["trace[1469078635] 'process raft request' (duration: 132.290044ms)"],"step_count":1} {"level":"info","ts":"2026-06-03T00:01:40.811571Z","caller":"traceutil/trace.go:171","msg":"trace[1748072378] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager; range_end:; response_count:1; response_revision:7504; }","duration":"102.599552ms","start":"2026-06-03T00:01:40.708959Z","end":"2026-06-03T00:01:40.811559Z","steps":["trace[1748072378] 'agreement among raft nodes before linearized reading' (duration: 102.474439ms)"],"step_count":1}