{"level":"warn","ts":"2026-06-09T17:03:26.954486Z","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-09T17:03:26.954666Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.5:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.5:2380","--initial-cluster=instance=https://199.19.213.5:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.5:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.5: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-09T17:03:26.954779Z","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-09T17:03:26.954822Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.5:2380"]} {"level":"info","ts":"2026-06-09T17:03:26.954873Z","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-09T17:03:26.955808Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"]} {"level":"info","ts":"2026-06-09T17:03:26.955937Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.5: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-09T17:03:26.963141Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.870826ms"} {"level":"info","ts":"2026-06-09T17:03:26.974353Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"dcb0af7a3afe1d6d","cluster-id":"4564295d4e5c9a3e"} {"level":"info","ts":"2026-06-09T17:03:26.974485Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=()"} {"level":"info","ts":"2026-06-09T17:03:26.974534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 0"} {"level":"info","ts":"2026-06-09T17:03:26.97457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft dcb0af7a3afe1d6d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-09T17:03:26.974597Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became follower at term 1"} {"level":"info","ts":"2026-06-09T17:03:26.974668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"} {"level":"warn","ts":"2026-06-09T17:03:26.985811Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-09T17:03:26.988Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-09T17:03:26.991367Z","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-09T17:03:26.99378Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"dcb0af7a3afe1d6d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-09T17:03:26.995681Z","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-09T17:03:26.995861Z","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-09T17:03:26.995882Z","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-09T17:03:26.996085Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"dcb0af7a3afe1d6d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-09T17:03:26.996716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d switched to configuration voters=(15902403223755824493)"} {"level":"info","ts":"2026-06-09T17:03:26.997241Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","added-peer-id":"dcb0af7a3afe1d6d","added-peer-peer-urls":["https://199.19.213.5:2380"]} {"level":"info","ts":"2026-06-09T17:03:26.998497Z","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-09T17:03:26.998823Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"dcb0af7a3afe1d6d","initial-advertise-peer-urls":["https://199.19.213.5:2380"],"listen-peer-urls":["https://199.19.213.5:2380"],"advertise-client-urls":["https://199.19.213.5:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.5:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-09T17:03:26.999379Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.5:2380"} {"level":"info","ts":"2026-06-09T17:03:26.999402Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.5:2380"} {"level":"info","ts":"2026-06-09T17:03:26.998858Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-09T17:03:27.575683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d is starting a new election at term 1"} {"level":"info","ts":"2026-06-09T17:03:27.575809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-09T17:03:27.57587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgPreVoteResp from dcb0af7a3afe1d6d at term 1"} {"level":"info","ts":"2026-06-09T17:03:27.575903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became candidate at term 2"} {"level":"info","ts":"2026-06-09T17:03:27.57592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d received MsgVoteResp from dcb0af7a3afe1d6d at term 2"} {"level":"info","ts":"2026-06-09T17:03:27.575941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"dcb0af7a3afe1d6d became leader at term 2"} {"level":"info","ts":"2026-06-09T17:03:27.575962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: dcb0af7a3afe1d6d elected leader dcb0af7a3afe1d6d at term 2"} {"level":"info","ts":"2026-06-09T17:03:27.577253Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:03:27.578111Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"dcb0af7a3afe1d6d","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.5:2379]}","request-path":"/0/members/dcb0af7a3afe1d6d/attributes","cluster-id":"4564295d4e5c9a3e","publish-timeout":"7s"} {"level":"info","ts":"2026-06-09T17:03:27.578387Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T17:03:27.578464Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-09T17:03:27.57873Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-09T17:03:27.578799Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-09T17:03:27.583124Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-09T17:03:27.586095Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.5:2379"} {"level":"info","ts":"2026-06-09T17:03:27.62576Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4564295d4e5c9a3e","local-member-id":"dcb0af7a3afe1d6d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:03:27.62598Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-09T17:03:27.626088Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-06-09T17:03:49.244639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.046661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-09T17:03:49.244762Z","caller":"traceutil/trace.go:171","msg":"trace[764369185] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:427; }","duration":"173.194965ms","start":"2026-06-09T17:03:49.071545Z","end":"2026-06-09T17:03:49.24474Z","steps":["trace[764369185] 'range keys from in-memory index tree' (duration: 172.839655ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:03:49.351822Z","caller":"traceutil/trace.go:171","msg":"trace[962678023] transaction","detail":"{read_only:false; response_revision:428; number_of_response:1; }","duration":"103.404158ms","start":"2026-06-09T17:03:49.248385Z","end":"2026-06-09T17:03:49.351789Z","steps":["trace[962678023] 'process raft request' (duration: 103.195472ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:03:50.253408Z","caller":"traceutil/trace.go:171","msg":"trace[450830306] linearizableReadLoop","detail":"{readStateIndex:445; appliedIndex:444; }","duration":"396.980198ms","start":"2026-06-09T17:03:49.856397Z","end":"2026-06-09T17:03:50.253377Z","steps":["trace[450830306] 'read index received' (duration: 396.694289ms)","trace[450830306] 'applied index is now lower than readState.Index' (duration: 284.589µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:03:50.253508Z","caller":"traceutil/trace.go:171","msg":"trace[1669565178] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"606.914539ms","start":"2026-06-09T17:03:49.646552Z","end":"2026-06-09T17:03:50.253466Z","steps":["trace[1669565178] 'process raft request' (duration: 606.63415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:03:50.253578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.164574ms","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-09T17:03:50.253618Z","caller":"traceutil/trace.go:171","msg":"trace[501514497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:429; }","duration":"397.262706ms","start":"2026-06-09T17:03:49.856342Z","end":"2026-06-09T17:03:50.253605Z","steps":["trace[501514497] 'agreement among raft nodes before linearized reading' (duration: 397.169904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:03:50.253654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:03:49.856316Z","time spent":"397.329668ms","remote":"127.0.0.1:59398","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-09T17:03:50.254376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:03:49.64652Z","time spent":"607.053092ms","remote":"127.0.0.1:59398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:03:50.375631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.504268ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:03:50.375782Z","caller":"traceutil/trace.go:171","msg":"trace[82689760] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"117.966235ms","start":"2026-06-09T17:03:50.257796Z","end":"2026-06-09T17:03:50.375762Z","steps":["trace[82689760] 'process raft request' (duration: 15.089985ms)","trace[82689760] 'compare' (duration: 102.387285ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:03:50.401566Z","caller":"traceutil/trace.go:171","msg":"trace[476953143] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"134.518915ms","start":"2026-06-09T17:03:50.26697Z","end":"2026-06-09T17:03:50.401488Z","steps":["trace[476953143] 'process raft request' (duration: 134.285778ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:03:50.58949Z","caller":"traceutil/trace.go:171","msg":"trace[847696612] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"180.889533ms","start":"2026-06-09T17:03:50.408546Z","end":"2026-06-09T17:03:50.589436Z","steps":["trace[847696612] 'process raft request' (duration: 99.077533ms)","trace[847696612] 'compare' (duration: 81.48293ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:03:50.945266Z","caller":"traceutil/trace.go:171","msg":"trace[2078247853] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"201.102946ms","start":"2026-06-09T17:03:50.744118Z","end":"2026-06-09T17:03:50.945221Z","steps":["trace[2078247853] 'process raft request' (duration: 122.118854ms)","trace[2078247853] 'compare' (duration: 78.653943ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:03:50.945439Z","caller":"traceutil/trace.go:171","msg":"trace[1017186893] transaction","detail":"{read_only:false; number_of_response:1; response_revision:447; }","duration":"183.019639ms","start":"2026-06-09T17:03:50.762384Z","end":"2026-06-09T17:03:50.945404Z","steps":["trace[1017186893] 'process raft request' (duration: 182.953266ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:03:50.945589Z","caller":"traceutil/trace.go:171","msg":"trace[185828900] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"200.948591ms","start":"2026-06-09T17:03:50.744619Z","end":"2026-06-09T17:03:50.945567Z","steps":["trace[185828900] 'process raft request' (duration: 200.58518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:03:50.945826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.652693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-67659f764b\" ","response":"range_response_count:1 size:3810"} {"level":"info","ts":"2026-06-09T17:03:50.945885Z","caller":"traceutil/trace.go:171","msg":"trace[1148258507] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-67659f764b; range_end:; response_count:1; response_revision:447; }","duration":"201.761717ms","start":"2026-06-09T17:03:50.744108Z","end":"2026-06-09T17:03:50.94587Z","steps":["trace[1148258507] 'agreement among raft nodes before linearized reading' (duration: 201.617172ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:03:50.946389Z","caller":"traceutil/trace.go:171","msg":"trace[1261453251] linearizableReadLoop","detail":"{readStateIndex:463; appliedIndex:461; }","duration":"201.335104ms","start":"2026-06-09T17:03:50.744173Z","end":"2026-06-09T17:03:50.945508Z","steps":["trace[1261453251] 'read index received' (duration: 16.652853ms)","trace[1261453251] 'applied index is now lower than readState.Index' (duration: 184.67225ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:03:50.946584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.970646ms","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-09T17:03:50.946612Z","caller":"traceutil/trace.go:171","msg":"trace[433509408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:447; }","duration":"182.04134ms","start":"2026-06-09T17:03:50.764562Z","end":"2026-06-09T17:03:50.946603Z","steps":["trace[433509408] 'agreement among raft nodes before linearized reading' (duration: 181.943527ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:03:51.165612Z","caller":"traceutil/trace.go:171","msg":"trace[2135542575] linearizableReadLoop","detail":"{readStateIndex:472; appliedIndex:471; }","duration":"129.419513ms","start":"2026-06-09T17:03:51.036162Z","end":"2026-06-09T17:03:51.165582Z","steps":["trace[2135542575] 'read index received' (duration: 126.628018ms)","trace[2135542575] 'applied index is now lower than readState.Index' (duration: 2.790265ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:03:51.165692Z","caller":"traceutil/trace.go:171","msg":"trace[2111634858] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"131.676543ms","start":"2026-06-09T17:03:51.033958Z","end":"2026-06-09T17:03:51.165635Z","steps":["trace[2111634858] 'process raft request' (duration: 128.877207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:03:51.165914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.429063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-7c96b6546b\" ","response":"range_response_count:1 size:3819"} {"level":"warn","ts":"2026-06-09T17:03:51.165913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.721233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4172"} {"level":"info","ts":"2026-06-09T17:03:51.165964Z","caller":"traceutil/trace.go:171","msg":"trace[1366768970] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-7c96b6546b; range_end:; response_count:1; response_revision:454; }","duration":"129.518697ms","start":"2026-06-09T17:03:51.036431Z","end":"2026-06-09T17:03:51.16595Z","steps":["trace[1366768970] 'agreement among raft nodes before linearized reading' (duration: 129.314741ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:03:51.166Z","caller":"traceutil/trace.go:171","msg":"trace[5490302] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:454; }","duration":"129.867368ms","start":"2026-06-09T17:03:51.036112Z","end":"2026-06-09T17:03:51.165979Z","steps":["trace[5490302] 'agreement among raft nodes before linearized reading' (duration: 129.62696ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:04.38342Z","caller":"traceutil/trace.go:171","msg":"trace[1093139189] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"236.552686ms","start":"2026-06-09T17:04:04.146831Z","end":"2026-06-09T17:04:04.383383Z","steps":["trace[1093139189] 'process raft request' (duration: 224.416119ms)","trace[1093139189] 'compare' (duration: 11.718155ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:04:04.383446Z","caller":"traceutil/trace.go:171","msg":"trace[1683035304] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"190.125969ms","start":"2026-06-09T17:04:04.193289Z","end":"2026-06-09T17:04:04.383415Z","steps":["trace[1683035304] 'process raft request' (duration: 189.938384ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:04.38368Z","caller":"traceutil/trace.go:171","msg":"trace[1648298354] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"168.658647ms","start":"2026-06-09T17:04:04.21501Z","end":"2026-06-09T17:04:04.383668Z","steps":["trace[1648298354] 'process raft request' (duration: 168.292356ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:04.383967Z","caller":"traceutil/trace.go:171","msg":"trace[558418508] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:638; }","duration":"121.518159ms","start":"2026-06-09T17:04:04.262422Z","end":"2026-06-09T17:04:04.38394Z","steps":["trace[558418508] 'read index received' (duration: 108.896127ms)","trace[558418508] 'applied index is now lower than readState.Index' (duration: 12.620792ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:04:04.384332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.89914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-bfdxm\" ","response":"range_response_count:1 size:4675"} {"level":"info","ts":"2026-06-09T17:04:04.38437Z","caller":"traceutil/trace.go:171","msg":"trace[110827779] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-bfdxm; range_end:; response_count:1; response_revision:619; }","duration":"121.977124ms","start":"2026-06-09T17:04:04.262384Z","end":"2026-06-09T17:04:04.384361Z","steps":["trace[110827779] 'agreement among raft nodes before linearized reading' (duration: 121.781857ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:04.972178Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2120525466884047622,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-09T17:04:05.072313Z","caller":"traceutil/trace.go:171","msg":"trace[965309846] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"626.310079ms","start":"2026-06-09T17:04:04.445799Z","end":"2026-06-09T17:04:05.072109Z","steps":["trace[965309846] 'process raft request' (duration: 529.271638ms)","trace[965309846] 'compare' (duration: 96.433624ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:04:05.07245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:04.445774Z","time spent":"626.606879ms","remote":"127.0.0.1:59210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:04:05.072466Z","caller":"traceutil/trace.go:171","msg":"trace[1990568124] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"626.229218ms","start":"2026-06-09T17:04:04.446213Z","end":"2026-06-09T17:04:05.072443Z","steps":["trace[1990568124] 'process raft request' (duration: 625.569439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.072635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:04.446202Z","time spent":"626.340062ms","remote":"127.0.0.1:59210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:04:05.079789Z","caller":"traceutil/trace.go:171","msg":"trace[571505227] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:647; }","duration":"607.943268ms","start":"2026-06-09T17:04:04.47183Z","end":"2026-06-09T17:04:05.079773Z","steps":["trace[571505227] 'read index received' (duration: 503.249902ms)","trace[571505227] 'applied index is now lower than readState.Index' (duration: 104.692536ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:04:05.079982Z","caller":"traceutil/trace.go:171","msg":"trace[1559031259] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"462.519565ms","start":"2026-06-09T17:04:04.617444Z","end":"2026-06-09T17:04:05.079963Z","steps":["trace[1559031259] 'process raft request' (duration: 462.296228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.080041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:04.617416Z","time spent":"462.589218ms","remote":"127.0.0.1:59210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:04:05.080017Z","caller":"traceutil/trace.go:171","msg":"trace[493695340] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"612.706489ms","start":"2026-06-09T17:04:04.46712Z","end":"2026-06-09T17:04:05.079827Z","steps":["trace[493695340] 'process raft request' (duration: 612.501763ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.080157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"576.474362ms","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-09T17:04:05.080195Z","caller":"traceutil/trace.go:171","msg":"trace[1562008619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"576.575275ms","start":"2026-06-09T17:04:04.503611Z","end":"2026-06-09T17:04:05.080187Z","steps":["trace[1562008619] 'agreement among raft nodes before linearized reading' (duration: 576.486782ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.080221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:04.503593Z","time spent":"576.623706ms","remote":"127.0.0.1:59398","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-09T17:04:05.080332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.007707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:04:05.080357Z","caller":"traceutil/trace.go:171","msg":"trace[6695056] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:628; }","duration":"268.031068ms","start":"2026-06-09T17:04:04.812318Z","end":"2026-06-09T17:04:05.080349Z","steps":["trace[6695056] 'agreement among raft nodes before linearized reading' (duration: 267.997677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.080416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:04.467103Z","time spent":"613.114381ms","remote":"127.0.0.1:59596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4694,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:04:05.080492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.6932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T17:04:05.080521Z","caller":"traceutil/trace.go:171","msg":"trace[1935284565] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:628; }","duration":"573.760983ms","start":"2026-06-09T17:04:04.506754Z","end":"2026-06-09T17:04:05.080515Z","steps":["trace[1935284565] 'agreement among raft nodes before linearized reading' (duration: 573.67483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.08054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:04.506725Z","time spent":"573.811133ms","remote":"127.0.0.1:59398","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":"warn","ts":"2026-06-09T17:04:05.080448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"608.610198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-06-09T17:04:05.081222Z","caller":"traceutil/trace.go:171","msg":"trace[947725922] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:628; }","duration":"608.977008ms","start":"2026-06-09T17:04:04.471808Z","end":"2026-06-09T17:04:05.080785Z","steps":["trace[947725922] 'agreement among raft nodes before linearized reading' (duration: 608.547166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.082077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:04.471801Z","time spent":"609.488473ms","remote":"127.0.0.1:59210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":93,"response count":1,"response size":59654,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-06-09T17:04:05.272042Z","caller":"traceutil/trace.go:171","msg":"trace[2142603045] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"189.123022ms","start":"2026-06-09T17:04:05.082891Z","end":"2026-06-09T17:04:05.272014Z","steps":["trace[2142603045] 'process raft request' (duration: 144.743769ms)","trace[2142603045] 'compare' (duration: 44.109636ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:04:05.312743Z","caller":"traceutil/trace.go:171","msg":"trace[1920668773] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:651; }","duration":"208.051359ms","start":"2026-06-09T17:04:05.10464Z","end":"2026-06-09T17:04:05.312692Z","steps":["trace[1920668773] 'read index received' (duration: 123.191787ms)","trace[1920668773] 'applied index is now lower than readState.Index' (duration: 84.858602ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:04:05.312988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.324027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:80703"} {"level":"info","ts":"2026-06-09T17:04:05.31303Z","caller":"traceutil/trace.go:171","msg":"trace[700294168] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/grpcroutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:632; }","duration":"208.420181ms","start":"2026-06-09T17:04:05.104599Z","end":"2026-06-09T17:04:05.313019Z","steps":["trace[700294168] 'agreement among raft nodes before linearized reading' (duration: 208.237946ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:05.313464Z","caller":"traceutil/trace.go:171","msg":"trace[357933136] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"228.877981ms","start":"2026-06-09T17:04:05.084575Z","end":"2026-06-09T17:04:05.313453Z","steps":["trace[357933136] 'process raft request' (duration: 227.852461ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:05.313593Z","caller":"traceutil/trace.go:171","msg":"trace[33147137] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"228.16824ms","start":"2026-06-09T17:04:05.085416Z","end":"2026-06-09T17:04:05.313584Z","steps":["trace[33147137] 'process raft request' (duration: 227.172161ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:05.313772Z","caller":"traceutil/trace.go:171","msg":"trace[1781643081] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"218.400172ms","start":"2026-06-09T17:04:05.095363Z","end":"2026-06-09T17:04:05.313763Z","steps":["trace[1781643081] 'process raft request' (duration: 217.27897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.314255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.252976ms","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-09T17:04:05.314339Z","caller":"traceutil/trace.go:171","msg":"trace[1262666985] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"177.376778ms","start":"2026-06-09T17:04:05.136942Z","end":"2026-06-09T17:04:05.314319Z","steps":["trace[1262666985] 'agreement among raft nodes before linearized reading' (duration: 177.188112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:05.314551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.918792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:04:05.314646Z","caller":"traceutil/trace.go:171","msg":"trace[1525064843] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:632; }","duration":"103.052986ms","start":"2026-06-09T17:04:05.211572Z","end":"2026-06-09T17:04:05.314625Z","steps":["trace[1525064843] 'agreement among raft nodes before linearized reading' (duration: 102.906681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.134558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.975633ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:04:11.134835Z","caller":"traceutil/trace.go:171","msg":"trace[2126617240] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:707; }","duration":"581.921759ms","start":"2026-06-09T17:04:10.552887Z","end":"2026-06-09T17:04:11.134809Z","steps":["trace[2126617240] 'read index received' (duration: 298.626706ms)","trace[2126617240] 'applied index is now lower than readState.Index' (duration: 283.292603ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:04:11.1349Z","caller":"traceutil/trace.go:171","msg":"trace[179814857] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"511.999425ms","start":"2026-06-09T17:04:10.622892Z","end":"2026-06-09T17:04:11.134891Z","steps":["trace[179814857] 'process raft request' (duration: 511.781198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.134953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.065882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-06-09T17:04:11.134961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:10.622877Z","time spent":"512.049915ms","remote":"127.0.0.1:59398","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-09T17:04:11.135009Z","caller":"traceutil/trace.go:171","msg":"trace[841663185] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:684; }","duration":"582.163706ms","start":"2026-06-09T17:04:10.552833Z","end":"2026-06-09T17:04:11.134996Z","steps":["trace[841663185] 'agreement among raft nodes before linearized reading' (duration: 582.044882ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:11.13476Z","caller":"traceutil/trace.go:171","msg":"trace[1649785064] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"583.134833ms","start":"2026-06-09T17:04:10.551594Z","end":"2026-06-09T17:04:11.134729Z","steps":["trace[1649785064] 'process raft request' (duration: 299.907793ms)","trace[1649785064] 'compare' (duration: 282.074887ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:04:11.135045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:10.552813Z","time spent":"582.224598ms","remote":"127.0.0.1:59356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-06-09T17:04:11.135141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:10.551577Z","time spent":"583.491345ms","remote":"127.0.0.1:59198","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:04:11.484773Z","caller":"traceutil/trace.go:171","msg":"trace[1552276420] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"341.207123ms","start":"2026-06-09T17:04:11.143532Z","end":"2026-06-09T17:04:11.484739Z","steps":["trace[1552276420] 'process raft request' (duration: 341.027218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.484968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.143521Z","time spent":"341.370077ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:04:11.485177Z","caller":"traceutil/trace.go:171","msg":"trace[128323194] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:710; }","duration":"204.354211ms","start":"2026-06-09T17:04:11.280787Z","end":"2026-06-09T17:04:11.485141Z","steps":["trace[128323194] 'read index received' (duration: 204.343361ms)","trace[128323194] 'applied index is now lower than readState.Index' (duration: 8.07µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:04:11.485453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.64811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5m8vj\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-06-09T17:04:11.485532Z","caller":"traceutil/trace.go:171","msg":"trace[1729917022] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5m8vj; range_end:; response_count:1; response_revision:685; }","duration":"204.781623ms","start":"2026-06-09T17:04:11.280733Z","end":"2026-06-09T17:04:11.485515Z","steps":["trace[1729917022] 'agreement among raft nodes before linearized reading' (duration: 204.504976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.485617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.211819ms","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-09T17:04:11.485624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.326425ms","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-09T17:04:11.48566Z","caller":"traceutil/trace.go:171","msg":"trace[917325460] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:685; }","duration":"131.300292ms","start":"2026-06-09T17:04:11.354347Z","end":"2026-06-09T17:04:11.485647Z","steps":["trace[917325460] 'agreement among raft nodes before linearized reading' (duration: 131.168208ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:11.485673Z","caller":"traceutil/trace.go:171","msg":"trace[1079614221] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:685; }","duration":"128.390788ms","start":"2026-06-09T17:04:11.35727Z","end":"2026-06-09T17:04:11.48566Z","steps":["trace[1079614221] 'agreement among raft nodes before linearized reading' (duration: 128.190892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.485478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.826917ms","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-09T17:04:11.485728Z","caller":"traceutil/trace.go:171","msg":"trace[199453688] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:685; }","duration":"132.150206ms","start":"2026-06-09T17:04:11.353566Z","end":"2026-06-09T17:04:11.485716Z","steps":["trace[199453688] 'agreement among raft nodes before linearized reading' (duration: 131.740194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.485851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.197059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:04:11.485942Z","caller":"traceutil/trace.go:171","msg":"trace[5464936] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:685; }","duration":"113.315842ms","start":"2026-06-09T17:04:11.372606Z","end":"2026-06-09T17:04:11.485922Z","steps":["trace[5464936] 'agreement among raft nodes before linearized reading' (duration: 113.201189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.930225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.376829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-09T17:04:11.930591Z","caller":"traceutil/trace.go:171","msg":"trace[1032610957] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"440.070037ms","start":"2026-06-09T17:04:11.490502Z","end":"2026-06-09T17:04:11.930572Z","steps":["trace[1032610957] 'process raft request' (duration: 439.903542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.93071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.490497Z","time spent":"440.17671ms","remote":"127.0.0.1:59398","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-09T17:04:11.930842Z","caller":"traceutil/trace.go:171","msg":"trace[1277361504] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"440.222893ms","start":"2026-06-09T17:04:11.490605Z","end":"2026-06-09T17:04:11.930828Z","steps":["trace[1277361504] 'process raft request' (duration: 439.923094ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.93093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.4906Z","time spent":"440.286704ms","remote":"127.0.0.1:59238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:04:11.931074Z","caller":"traceutil/trace.go:171","msg":"trace[916634978] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"440.361116ms","start":"2026-06-09T17:04:11.490458Z","end":"2026-06-09T17:04:11.930819Z","steps":["trace[916634978] 'process raft request' (duration: 339.302507ms)","trace[916634978] 'compare' (duration: 100.147583ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:04:11.931405Z","caller":"traceutil/trace.go:171","msg":"trace[1233661676] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"439.495641ms","start":"2026-06-09T17:04:11.491898Z","end":"2026-06-09T17:04:11.931394Z","steps":["trace[1233661676] 'process raft request' (duration: 439.418118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.931475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.491881Z","time spent":"439.561393ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:04:11.931456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.490448Z","time spent":"440.710966ms","remote":"127.0.0.1:59398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:04:11.931615Z","caller":"traceutil/trace.go:171","msg":"trace[1950309869] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"440.954234ms","start":"2026-06-09T17:04:11.490652Z","end":"2026-06-09T17:04:11.931606Z","steps":["trace[1950309869] 'process raft request' (duration: 440.124599ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:11.931611Z","caller":"traceutil/trace.go:171","msg":"trace[271002680] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"433.137867ms","start":"2026-06-09T17:04:11.498401Z","end":"2026-06-09T17:04:11.931539Z","steps":["trace[271002680] 'process raft request' (duration: 432.954072ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:04:11.931721Z","caller":"traceutil/trace.go:171","msg":"trace[999366362] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"440.412087ms","start":"2026-06-09T17:04:11.491299Z","end":"2026-06-09T17:04:11.931712Z","steps":["trace[999366362] 'process raft request' (duration: 439.895643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.931769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.491292Z","time spent":"440.454099ms","remote":"127.0.0.1:59398","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-09T17:04:11.931846Z","caller":"traceutil/trace.go:171","msg":"trace[806338858] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"440.449948ms","start":"2026-06-09T17:04:11.491388Z","end":"2026-06-09T17:04:11.931838Z","steps":["trace[806338858] 'process raft request' (duration: 439.858231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.93189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.491383Z","time spent":"440.48519ms","remote":"127.0.0.1:59398","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-09T17:04:11.931906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.498392Z","time spent":"433.341503ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:04:11.931688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.490645Z","time spent":"441.020935ms","remote":"127.0.0.1:59238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-09T17:04:11.932112Z","caller":"traceutil/trace.go:171","msg":"trace[117787655] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"440.383347ms","start":"2026-06-09T17:04:11.491719Z","end":"2026-06-09T17:04:11.932102Z","steps":["trace[117787655] 'process raft request' (duration: 439.560533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:11.932173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:11.49171Z","time spent":"440.431329ms","remote":"127.0.0.1:59392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:04:13.047223Z","caller":"traceutil/trace.go:171","msg":"trace[1758485617] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"414.496045ms","start":"2026-06-09T17:04:12.6327Z","end":"2026-06-09T17:04:13.047196Z","steps":["trace[1758485617] 'process raft request' (duration: 408.016268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:13.047367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:12.632674Z","time spent":"414.619808ms","remote":"127.0.0.1:59398","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-09T17:04:13.047824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.668697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:04:13.048095Z","caller":"traceutil/trace.go:171","msg":"trace[252515426] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:695; }","duration":"674.980376ms","start":"2026-06-09T17:04:12.373102Z","end":"2026-06-09T17:04:13.048083Z","steps":["trace[252515426] 'range keys from in-memory index tree' (duration: 674.586584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:13.048131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:12.373079Z","time spent":"675.042597ms","remote":"127.0.0.1:59144","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-09T17:04:28.927849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.348314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6wwsf\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-06-09T17:04:28.927958Z","caller":"traceutil/trace.go:171","msg":"trace[282780532] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6wwsf; range_end:; response_count:1; response_revision:807; }","duration":"541.500378ms","start":"2026-06-09T17:04:28.386417Z","end":"2026-06-09T17:04:28.927917Z","steps":["trace[282780532] 'range keys from in-memory index tree' (duration: 541.157519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:28.927969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.043115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T17:04:28.928002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:28.386394Z","time spent":"541.59785ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-6wwsf\" "} {"level":"info","ts":"2026-06-09T17:04:28.928679Z","caller":"traceutil/trace.go:171","msg":"trace[204997049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"554.156268ms","start":"2026-06-09T17:04:28.373869Z","end":"2026-06-09T17:04:28.928025Z","steps":["trace[204997049] 'range keys from in-memory index tree' (duration: 553.918292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:04:28.929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:04:28.373826Z","time spent":"554.920839ms","remote":"127.0.0.1:59144","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-09T17:05:43.508621Z","caller":"traceutil/trace.go:171","msg":"trace[215098392] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"171.896444ms","start":"2026-06-09T17:05:43.336701Z","end":"2026-06-09T17:05:43.508597Z","steps":["trace[215098392] 'read index received' (duration: 171.771161ms)","trace[215098392] 'applied index is now lower than readState.Index' (duration: 124.193µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:05:43.508719Z","caller":"traceutil/trace.go:171","msg":"trace[383427882] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"279.172566ms","start":"2026-06-09T17:05:43.229496Z","end":"2026-06-09T17:05:43.508668Z","steps":["trace[383427882] 'process raft request' (duration: 278.92395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:05:43.508822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.343586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:05:43.508915Z","caller":"traceutil/trace.go:171","msg":"trace[632403498] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1861; }","duration":"135.485851ms","start":"2026-06-09T17:05:43.373413Z","end":"2026-06-09T17:05:43.508899Z","steps":["trace[632403498] 'agreement among raft nodes before linearized reading' (duration: 135.348916ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:05:43.508954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.198762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-30272672-c9c7-4c0f-8ae0-e4394f317968\" ","response":"range_response_count:1 size:3625"} {"level":"info","ts":"2026-06-09T17:05:43.509036Z","caller":"traceutil/trace.go:171","msg":"trace[1569817110] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-30272672-c9c7-4c0f-8ae0-e4394f317968; range_end:; response_count:1; response_revision:1861; }","duration":"172.383017ms","start":"2026-06-09T17:05:43.33664Z","end":"2026-06-09T17:05:43.509023Z","steps":["trace[1569817110] 'agreement among raft nodes before linearized reading' (duration: 172.101759ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:05:43.986489Z","caller":"traceutil/trace.go:171","msg":"trace[1201084578] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"165.581685ms","start":"2026-06-09T17:05:43.820877Z","end":"2026-06-09T17:05:43.986458Z","steps":["trace[1201084578] 'process raft request' (duration: 144.569678ms)","trace[1201084578] 'compare' (duration: 20.874414ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:05:44.377487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.7522ms","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-09T17:05:44.377581Z","caller":"traceutil/trace.go:171","msg":"trace[987598988] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1865; }","duration":"211.910614ms","start":"2026-06-09T17:05:44.165649Z","end":"2026-06-09T17:05:44.377559Z","steps":["trace[987598988] 'range keys from in-memory index tree' (duration: 211.547085ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:05:57.966081Z","caller":"traceutil/trace.go:171","msg":"trace[430844645] transaction","detail":"{read_only:false; response_revision:1980; number_of_response:1; }","duration":"100.160211ms","start":"2026-06-09T17:05:57.865881Z","end":"2026-06-09T17:05:57.966041Z","steps":["trace[430844645] 'process raft request' (duration: 99.991236ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:18.808102Z","caller":"traceutil/trace.go:171","msg":"trace[131396173] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"124.954434ms","start":"2026-06-09T17:06:18.683116Z","end":"2026-06-09T17:06:18.80807Z","steps":["trace[131396173] 'process raft request' (duration: 59.122175ms)","trace[131396173] 'compare' (duration: 65.470841ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:06:18.80892Z","caller":"traceutil/trace.go:171","msg":"trace[852208308] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"113.733147ms","start":"2026-06-09T17:06:18.695138Z","end":"2026-06-09T17:06:18.808871Z","steps":["trace[852208308] 'process raft request' (duration: 113.025421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:19.591438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.089866ms","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-09T17:06:19.591523Z","caller":"traceutil/trace.go:171","msg":"trace[1729992290] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2115; }","duration":"177.219228ms","start":"2026-06-09T17:06:19.414283Z","end":"2026-06-09T17:06:19.591503Z","steps":["trace[1729992290] 'range keys from in-memory index tree' (duration: 176.903481ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:20.42933Z","caller":"traceutil/trace.go:171","msg":"trace[429100861] linearizableReadLoop","detail":"{readStateIndex:2198; appliedIndex:2197; }","duration":"329.152733ms","start":"2026-06-09T17:06:20.100145Z","end":"2026-06-09T17:06:20.429298Z","steps":["trace[429100861] 'read index received' (duration: 328.838945ms)","trace[429100861] 'applied index is now lower than readState.Index' (duration: 311.288µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:06:20.429568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.375328ms","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-09T17:06:20.429769Z","caller":"traceutil/trace.go:171","msg":"trace[1428739125] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2116; }","duration":"329.620373ms","start":"2026-06-09T17:06:20.100128Z","end":"2026-06-09T17:06:20.429748Z","steps":["trace[1428739125] 'agreement among raft nodes before linearized reading' (duration: 329.308656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:20.429828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:20.100071Z","time spent":"329.742447ms","remote":"127.0.0.1:42868","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-06-09T17:06:20.429318Z","caller":"traceutil/trace.go:171","msg":"trace[580329386] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"335.56184ms","start":"2026-06-09T17:06:20.093706Z","end":"2026-06-09T17:06:20.429267Z","steps":["trace[580329386] 'process raft request' (duration: 335.312194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:20.430242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:06:20.093677Z","time spent":"336.426991ms","remote":"127.0.0.1:59398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-09T17:06:20.475456Z","caller":"traceutil/trace.go:171","msg":"trace[1896088824] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"195.394033ms","start":"2026-06-09T17:06:20.28002Z","end":"2026-06-09T17:06:20.475414Z","steps":["trace[1896088824] 'process raft request' (duration: 195.139497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:06:20.475556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.098064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-09T17:06:20.475499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.353186ms","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-09T17:06:20.475633Z","caller":"traceutil/trace.go:171","msg":"trace[405880509] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2117; }","duration":"103.202586ms","start":"2026-06-09T17:06:20.372401Z","end":"2026-06-09T17:06:20.475603Z","steps":["trace[405880509] 'agreement among raft nodes before linearized reading' (duration: 103.130954ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:06:20.47569Z","caller":"traceutil/trace.go:171","msg":"trace[1873737310] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2117; }","duration":"150.529461ms","start":"2026-06-09T17:06:20.325089Z","end":"2026-06-09T17:06:20.475618Z","steps":["trace[1873737310] 'agreement among raft nodes before linearized reading' (duration: 150.235624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:07:25.643716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.245614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-09T17:07:25.64384Z","caller":"traceutil/trace.go:171","msg":"trace[1079704747] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2571; }","duration":"525.422608ms","start":"2026-06-09T17:07:25.118393Z","end":"2026-06-09T17:07:25.643816Z","steps":["trace[1079704747] 'range keys from in-memory index tree' (duration: 524.956657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:07:25.64389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:25.118374Z","time spent":"525.50453ms","remote":"127.0.0.1:59398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-09T17:07:25.644172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.186322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-09T17:07:25.644214Z","caller":"traceutil/trace.go:171","msg":"trace[1585917868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2571; }","duration":"525.274885ms","start":"2026-06-09T17:07:25.118928Z","end":"2026-06-09T17:07:25.644203Z","steps":["trace[1585917868] 'range keys from in-memory index tree' (duration: 525.076859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:07:25.644246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:25.118902Z","time spent":"525.336717ms","remote":"127.0.0.1:59398","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":"warn","ts":"2026-06-09T17:07:25.644483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.923654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-09T17:07:25.644524Z","caller":"traceutil/trace.go:171","msg":"trace[1784356632] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2571; }","duration":"505.024706ms","start":"2026-06-09T17:07:25.13949Z","end":"2026-06-09T17:07:25.644515Z","steps":["trace[1784356632] 'range keys from in-memory index tree' (duration: 504.650657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:07:25.644557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:25.13946Z","time spent":"505.089497ms","remote":"127.0.0.1:59398","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-09T17:07:25.644754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.453513ms","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-09T17:07:25.644783Z","caller":"traceutil/trace.go:171","msg":"trace[1349565791] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2571; }","duration":"502.503505ms","start":"2026-06-09T17:07:25.142272Z","end":"2026-06-09T17:07:25.644775Z","steps":["trace[1349565791] 'range keys from in-memory index tree' (duration: 502.352551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:07:25.644802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:07:25.142257Z","time spent":"502.540195ms","remote":"127.0.0.1:59398","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-09T17:07:25.645371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.656025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-09T17:07:25.645464Z","caller":"traceutil/trace.go:171","msg":"trace[2110476565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2571; }","duration":"271.813478ms","start":"2026-06-09T17:07:25.373628Z","end":"2026-06-09T17:07:25.645442Z","steps":["trace[2110476565] 'range keys from in-memory index tree' (duration: 271.545413ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:07:50.688976Z","caller":"traceutil/trace.go:171","msg":"trace[429977539] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"125.664085ms","start":"2026-06-09T17:07:50.563287Z","end":"2026-06-09T17:07:50.688951Z","steps":["trace[429977539] 'process raft request' (duration: 108.339201ms)","trace[429977539] 'compare' (duration: 17.198181ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:08:02.140427Z","caller":"traceutil/trace.go:171","msg":"trace[842436506] linearizableReadLoop","detail":"{readStateIndex:2877; appliedIndex:2876; }","duration":"312.403469ms","start":"2026-06-09T17:08:01.827985Z","end":"2026-06-09T17:08:02.140388Z","steps":["trace[842436506] 'read index received' (duration: 312.141632ms)","trace[842436506] 'applied index is now lower than readState.Index' (duration: 259.627µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:08:02.140851Z","caller":"traceutil/trace.go:171","msg":"trace[679156328] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"315.754388ms","start":"2026-06-09T17:08:01.824989Z","end":"2026-06-09T17:08:02.140744Z","steps":["trace[679156328] 'process raft request' (duration: 315.08427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:02.141455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:01.824953Z","time spent":"316.129727ms","remote":"127.0.0.1:59398","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-09T17:08:02.141579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.577949ms","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-09T17:08:02.141776Z","caller":"traceutil/trace.go:171","msg":"trace[359240677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2771; }","duration":"313.860867ms","start":"2026-06-09T17:08:01.827896Z","end":"2026-06-09T17:08:02.141757Z","steps":["trace[359240677] 'agreement among raft nodes before linearized reading' (duration: 313.430445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:02.141869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:01.827873Z","time spent":"313.97779ms","remote":"127.0.0.1:59398","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-09T17:08:02.194882Z","caller":"traceutil/trace.go:171","msg":"trace[1201125326] transaction","detail":"{read_only:false; response_revision:2772; number_of_response:1; }","duration":"366.024852ms","start":"2026-06-09T17:08:01.828826Z","end":"2026-06-09T17:08:02.194851Z","steps":["trace[1201125326] 'process raft request' (duration: 365.9097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:02.19503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.833917ms","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-09T17:08:02.195086Z","caller":"traceutil/trace.go:171","msg":"trace[8901613] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2772; }","duration":"365.8954ms","start":"2026-06-09T17:08:01.829178Z","end":"2026-06-09T17:08:02.195073Z","steps":["trace[8901613] 'agreement among raft nodes before linearized reading' (duration: 365.693404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:02.19508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:01.828806Z","time spent":"366.161426ms","remote":"127.0.0.1:59398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:08:02.195121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:01.829146Z","time spent":"365.966222ms","remote":"127.0.0.1:59398","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-09T17:08:11.212553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.258533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:08:11.212626Z","caller":"traceutil/trace.go:171","msg":"trace[1519183846] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2819; }","duration":"304.404107ms","start":"2026-06-09T17:08:10.908205Z","end":"2026-06-09T17:08:11.212609Z","steps":["trace[1519183846] 'count revisions from in-memory index tree' (duration: 304.138419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:08:11.212671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:08:10.908175Z","time spent":"304.488129ms","remote":"127.0.0.1:59420","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":3,"response size":30,"request content":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-09T17:08:11.212834Z","caller":"traceutil/trace.go:171","msg":"trace[939841643] transaction","detail":"{read_only:false; response_revision:2820; number_of_response:1; }","duration":"290.047738ms","start":"2026-06-09T17:08:10.922753Z","end":"2026-06-09T17:08:11.212801Z","steps":["trace[939841643] 'process raft request' (duration: 289.78407ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:49.601212Z","caller":"traceutil/trace.go:171","msg":"trace[313318833] transaction","detail":"{read_only:false; response_revision:4711; number_of_response:1; }","duration":"168.053411ms","start":"2026-06-09T17:11:49.433126Z","end":"2026-06-09T17:11:49.601179Z","steps":["trace[313318833] 'process raft request' (duration: 167.406736ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.601551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.810062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:3958"} {"level":"info","ts":"2026-06-09T17:11:49.601573Z","caller":"traceutil/trace.go:171","msg":"trace[1187002300] linearizableReadLoop","detail":"{readStateIndex:4891; appliedIndex:4890; }","duration":"166.840133ms","start":"2026-06-09T17:11:49.434716Z","end":"2026-06-09T17:11:49.601556Z","steps":["trace[1187002300] 'read index received' (duration: 165.763886ms)","trace[1187002300] 'applied index is now lower than readState.Index' (duration: 956.994µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:49.601694Z","caller":"traceutil/trace.go:171","msg":"trace[1606254117] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4711; }","duration":"166.940125ms","start":"2026-06-09T17:11:49.434676Z","end":"2026-06-09T17:11:49.601616Z","steps":["trace[1606254117] 'agreement among raft nodes before linearized reading' (duration: 166.578977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.602133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.701405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4847"} {"level":"info","ts":"2026-06-09T17:11:49.602165Z","caller":"traceutil/trace.go:171","msg":"trace[870762643] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4711; }","duration":"163.741276ms","start":"2026-06-09T17:11:49.438415Z","end":"2026-06-09T17:11:49.602156Z","steps":["trace[870762643] 'agreement among raft nodes before linearized reading' (duration: 163.657914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.602232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.106715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-09T17:11:49.602271Z","caller":"traceutil/trace.go:171","msg":"trace[1985121486] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4711; }","duration":"164.181287ms","start":"2026-06-09T17:11:49.438079Z","end":"2026-06-09T17:11:49.602261Z","steps":["trace[1985121486] 'agreement among raft nodes before linearized reading' (duration: 163.682584ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:49.821603Z","caller":"traceutil/trace.go:171","msg":"trace[1434416683] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"215.071111ms","start":"2026-06-09T17:11:49.606506Z","end":"2026-06-09T17:11:49.821577Z","steps":["trace[1434416683] 'process raft request' (duration: 214.613509ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:49.822249Z","caller":"traceutil/trace.go:171","msg":"trace[1628064042] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"215.215824ms","start":"2026-06-09T17:11:49.607002Z","end":"2026-06-09T17:11:49.822218Z","steps":["trace[1628064042] 'process raft request' (duration: 214.284251ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:49.822318Z","caller":"traceutil/trace.go:171","msg":"trace[762592929] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"212.016365ms","start":"2026-06-09T17:11:49.610249Z","end":"2026-06-09T17:11:49.822265Z","steps":["trace[762592929] 'process raft request' (duration: 211.754138ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:49.822337Z","caller":"traceutil/trace.go:171","msg":"trace[1732500723] linearizableReadLoop","detail":"{readStateIndex:4893; appliedIndex:4891; }","duration":"215.585204ms","start":"2026-06-09T17:11:49.606725Z","end":"2026-06-09T17:11:49.82231Z","steps":["trace[1732500723] 'read index received' (duration: 88.227765ms)","trace[1732500723] 'applied index is now lower than readState.Index' (duration: 127.356229ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:11:49.822691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.943492ms","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-09T17:11:49.823581Z","caller":"traceutil/trace.go:171","msg":"trace[360811499] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4715; }","duration":"216.855985ms","start":"2026-06-09T17:11:49.606708Z","end":"2026-06-09T17:11:49.823564Z","steps":["trace[360811499] 'agreement among raft nodes before linearized reading' (duration: 215.684756ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:49.845519Z","caller":"traceutil/trace.go:171","msg":"trace[567026721] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"132.441125ms","start":"2026-06-09T17:11:49.713037Z","end":"2026-06-09T17:11:49.845478Z","steps":["trace[567026721] 'process raft request' (duration: 132.206959ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:49.845835Z","caller":"traceutil/trace.go:171","msg":"trace[162431130] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"130.21603ms","start":"2026-06-09T17:11:49.715582Z","end":"2026-06-09T17:11:49.845798Z","steps":["trace[162431130] 'process raft request' (duration: 129.84003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.845967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.196655ms","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-09T17:11:49.846015Z","caller":"traceutil/trace.go:171","msg":"trace[1424344360] 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:4717; }","duration":"101.269786ms","start":"2026-06-09T17:11:49.744729Z","end":"2026-06-09T17:11:49.845999Z","steps":["trace[1424344360] 'agreement among raft nodes before linearized reading' (duration: 101.040231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.846048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.963745ms","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-09T17:11:49.846204Z","caller":"traceutil/trace.go:171","msg":"trace[1825421942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4717; }","duration":"195.115728ms","start":"2026-06-09T17:11:49.651024Z","end":"2026-06-09T17:11:49.84614Z","steps":["trace[1825421942] 'agreement among raft nodes before linearized reading' (duration: 194.716958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.846258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.053994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-06-09T17:11:49.846338Z","caller":"traceutil/trace.go:171","msg":"trace[23139572] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4717; }","duration":"229.158637ms","start":"2026-06-09T17:11:49.617157Z","end":"2026-06-09T17:11:49.846316Z","steps":["trace[23139572] 'agreement among raft nodes before linearized reading' (duration: 228.910461ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.846394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.967553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-06-09T17:11:49.846427Z","caller":"traceutil/trace.go:171","msg":"trace[110955785] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4717; }","duration":"231.044164ms","start":"2026-06-09T17:11:49.615376Z","end":"2026-06-09T17:11:49.84642Z","steps":["trace[110955785] 'agreement among raft nodes before linearized reading' (duration: 230.950021ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.846568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.604594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"} {"level":"info","ts":"2026-06-09T17:11:49.846644Z","caller":"traceutil/trace.go:171","msg":"trace[390063793] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4717; }","duration":"213.747508ms","start":"2026-06-09T17:11:49.632881Z","end":"2026-06-09T17:11:49.846629Z","steps":["trace[390063793] 'agreement among raft nodes before linearized reading' (duration: 213.553234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:49.84691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.65486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12971"} {"level":"info","ts":"2026-06-09T17:11:49.847369Z","caller":"traceutil/trace.go:171","msg":"trace[1782671653] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4717; }","duration":"129.116472ms","start":"2026-06-09T17:11:49.718225Z","end":"2026-06-09T17:11:49.847342Z","steps":["trace[1782671653] 'agreement among raft nodes before linearized reading' (duration: 127.589814ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:50.160777Z","caller":"traceutil/trace.go:171","msg":"trace[1377652772] linearizableReadLoop","detail":"{readStateIndex:4914; appliedIndex:4913; }","duration":"122.210282ms","start":"2026-06-09T17:11:50.038542Z","end":"2026-06-09T17:11:50.160752Z","steps":["trace[1377652772] 'read index received' (duration: 113.18869ms)","trace[1377652772] 'applied index is now lower than readState.Index' (duration: 9.020302ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:50.161262Z","caller":"traceutil/trace.go:171","msg":"trace[634308483] transaction","detail":"{read_only:false; response_revision:4734; number_of_response:1; }","duration":"123.339919ms","start":"2026-06-09T17:11:50.037906Z","end":"2026-06-09T17:11:50.161246Z","steps":["trace[634308483] 'process raft request' (duration: 112.638365ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:50.161827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.255357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1451"} {"level":"info","ts":"2026-06-09T17:11:50.161919Z","caller":"traceutil/trace.go:171","msg":"trace[902370720] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4734; }","duration":"123.395502ms","start":"2026-06-09T17:11:50.038501Z","end":"2026-06-09T17:11:50.161897Z","steps":["trace[902370720] 'agreement among raft nodes before linearized reading' (duration: 122.777796ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:50.206501Z","caller":"traceutil/trace.go:171","msg":"trace[125131622] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"105.261264ms","start":"2026-06-09T17:11:50.101216Z","end":"2026-06-09T17:11:50.206477Z","steps":["trace[125131622] 'process raft request' (duration: 105.0903ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:50.206524Z","caller":"traceutil/trace.go:171","msg":"trace[2013850184] transaction","detail":"{read_only:false; response_revision:4735; number_of_response:1; }","duration":"166.617265ms","start":"2026-06-09T17:11:50.039855Z","end":"2026-06-09T17:11:50.206473Z","steps":["trace[2013850184] 'process raft request' (duration: 166.180064ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:50.2069Z","caller":"traceutil/trace.go:171","msg":"trace[974394865] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"103.991052ms","start":"2026-06-09T17:11:50.102897Z","end":"2026-06-09T17:11:50.206888Z","steps":["trace[974394865] 'process raft request' (duration: 103.46912ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:50.207012Z","caller":"traceutil/trace.go:171","msg":"trace[1835993200] transaction","detail":"{read_only:false; response_revision:4736; number_of_response:1; }","duration":"156.053966ms","start":"2026-06-09T17:11:50.050897Z","end":"2026-06-09T17:11:50.206951Z","steps":["trace[1835993200] 'process raft request' (duration: 155.336229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:50.207226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.379898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"warn","ts":"2026-06-09T17:11:50.207287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.032961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-06-09T17:11:50.207345Z","caller":"traceutil/trace.go:171","msg":"trace[478929662] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4738; }","duration":"168.136423ms","start":"2026-06-09T17:11:50.039193Z","end":"2026-06-09T17:11:50.20733Z","steps":["trace[478929662] 'agreement among raft nodes before linearized reading' (duration: 167.881317ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:50.207465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.760304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-06-09T17:11:50.2073Z","caller":"traceutil/trace.go:171","msg":"trace[156104558] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4738; }","duration":"157.463381ms","start":"2026-06-09T17:11:50.049796Z","end":"2026-06-09T17:11:50.20726Z","steps":["trace[156104558] 'agreement among raft nodes before linearized reading' (duration: 157.266936ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:50.207509Z","caller":"traceutil/trace.go:171","msg":"trace[615340554] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4738; }","duration":"167.856256ms","start":"2026-06-09T17:11:50.039635Z","end":"2026-06-09T17:11:50.207491Z","steps":["trace[615340554] 'agreement among raft nodes before linearized reading' (duration: 167.746204ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:50.457366Z","caller":"traceutil/trace.go:171","msg":"trace[386383335] linearizableReadLoop","detail":"{readStateIndex:4925; appliedIndex:4924; }","duration":"107.708285ms","start":"2026-06-09T17:11:50.349636Z","end":"2026-06-09T17:11:50.457344Z","steps":["trace[386383335] 'read index received' (duration: 107.531989ms)","trace[386383335] 'applied index is now lower than readState.Index' (duration: 175.236µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:11:50.457715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.50848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4847"} {"level":"info","ts":"2026-06-09T17:11:50.457768Z","caller":"traceutil/trace.go:171","msg":"trace[1325783813] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4745; }","duration":"105.586962ms","start":"2026-06-09T17:11:50.352169Z","end":"2026-06-09T17:11:50.457756Z","steps":["trace[1325783813] 'agreement among raft nodes before linearized reading' (duration: 105.383827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:50.458271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.604646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-06-09T17:11:50.458384Z","caller":"traceutil/trace.go:171","msg":"trace[1830798578] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:4745; }","duration":"108.801211ms","start":"2026-06-09T17:11:50.349557Z","end":"2026-06-09T17:11:50.458358Z","steps":["trace[1830798578] 'agreement among raft nodes before linearized reading' (duration: 108.212057ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:50.457483Z","caller":"traceutil/trace.go:171","msg":"trace[872077244] transaction","detail":"{read_only:false; response_revision:4745; number_of_response:1; }","duration":"108.517434ms","start":"2026-06-09T17:11:50.348954Z","end":"2026-06-09T17:11:50.457471Z","steps":["trace[872077244] 'process raft request' (duration: 108.275347ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:53.25739Z","caller":"traceutil/trace.go:171","msg":"trace[1074767984] linearizableReadLoop","detail":"{readStateIndex:4960; appliedIndex:4959; }","duration":"117.27926ms","start":"2026-06-09T17:11:53.140062Z","end":"2026-06-09T17:11:53.257341Z","steps":["trace[1074767984] 'read index received' (duration: 117.098924ms)","trace[1074767984] 'applied index is now lower than readState.Index' (duration: 179.346µs)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:53.257414Z","caller":"traceutil/trace.go:171","msg":"trace[1529355500] transaction","detail":"{read_only:false; response_revision:4779; number_of_response:1; }","duration":"264.292891ms","start":"2026-06-09T17:11:52.993091Z","end":"2026-06-09T17:11:53.257384Z","steps":["trace[1529355500] 'process raft request' (duration: 264.085145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:53.257585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.494525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-09T17:11:53.257628Z","caller":"traceutil/trace.go:171","msg":"trace[484618354] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:4779; }","duration":"117.600437ms","start":"2026-06-09T17:11:53.140018Z","end":"2026-06-09T17:11:53.257619Z","steps":["trace[484618354] 'agreement among raft nodes before linearized reading' (duration: 117.444314ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:58.172984Z","caller":"traceutil/trace.go:171","msg":"trace[1602070269] linearizableReadLoop","detail":"{readStateIndex:5054; appliedIndex:5052; }","duration":"272.830238ms","start":"2026-06-09T17:11:57.900125Z","end":"2026-06-09T17:11:58.172956Z","steps":["trace[1602070269] 'read index received' (duration: 203.426269ms)","trace[1602070269] 'applied index is now lower than readState.Index' (duration: 69.403309ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:11:58.173081Z","caller":"traceutil/trace.go:171","msg":"trace[1767154539] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"300.458258ms","start":"2026-06-09T17:11:57.872616Z","end":"2026-06-09T17:11:58.173074Z","steps":["trace[1767154539] 'process raft request' (duration: 300.263903ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:58.1731Z","caller":"traceutil/trace.go:171","msg":"trace[1292170494] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"309.663034ms","start":"2026-06-09T17:11:57.863415Z","end":"2026-06-09T17:11:58.173079Z","steps":["trace[1292170494] 'process raft request' (duration: 240.124402ms)","trace[1292170494] 'compare' (duration: 68.789534ms)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:11:58.173164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:57.872591Z","time spent":"300.51044ms","remote":"127.0.0.1:59398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:11:58.173205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:11:57.863402Z","time spent":"309.744786ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13833,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:11:58.173243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.591368ms","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-09T17:11:58.173316Z","caller":"traceutil/trace.go:171","msg":"trace[549005394] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4869; }","duration":"269.695911ms","start":"2026-06-09T17:11:57.903606Z","end":"2026-06-09T17:11:58.173302Z","steps":["trace[549005394] 'agreement among raft nodes before linearized reading' (duration: 269.526957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:11:58.173461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.33076ms","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":"warn","ts":"2026-06-09T17:11:58.173473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.423194ms","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-09T17:11:58.173487Z","caller":"traceutil/trace.go:171","msg":"trace[1260272197] 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:4869; }","duration":"273.356041ms","start":"2026-06-09T17:11:57.900122Z","end":"2026-06-09T17:11:58.173478Z","steps":["trace[1260272197] 'agreement among raft nodes before linearized reading' (duration: 273.283679ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:11:58.173503Z","caller":"traceutil/trace.go:171","msg":"trace[2078351024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4869; }","duration":"252.491306ms","start":"2026-06-09T17:11:57.921005Z","end":"2026-06-09T17:11:58.173496Z","steps":["trace[2078351024] 'agreement among raft nodes before linearized reading' (duration: 252.390864ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:02.292979Z","caller":"traceutil/trace.go:171","msg":"trace[495389798] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"530.056913ms","start":"2026-06-09T17:12:01.762886Z","end":"2026-06-09T17:12:02.292943Z","steps":["trace[495389798] 'process raft request' (duration: 529.876399ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:02.293019Z","caller":"traceutil/trace.go:171","msg":"trace[757044955] linearizableReadLoop","detail":"{readStateIndex:5090; appliedIndex:5089; }","duration":"429.736774ms","start":"2026-06-09T17:12:01.863159Z","end":"2026-06-09T17:12:02.292896Z","steps":["trace[757044955] 'read index received' (duration: 429.644752ms)","trace[757044955] 'applied index is now lower than readState.Index' (duration: 90.902µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:12:02.293117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:01.762868Z","time spent":"530.178396ms","remote":"127.0.0.1:59398","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-09T17:12:02.293256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.072013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10390"} {"level":"info","ts":"2026-06-09T17:12:02.293352Z","caller":"traceutil/trace.go:171","msg":"trace[1401049088] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4904; }","duration":"430.185696ms","start":"2026-06-09T17:12:01.86313Z","end":"2026-06-09T17:12:02.293315Z","steps":["trace[1401049088] 'agreement among raft nodes before linearized reading' (duration: 429.969671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:02.293419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:01.863115Z","time spent":"430.294468ms","remote":"127.0.0.1:59344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10413,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-06-09T17:12:02.307954Z","caller":"traceutil/trace.go:171","msg":"trace[1224020098] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"124.095273ms","start":"2026-06-09T17:12:02.183835Z","end":"2026-06-09T17:12:02.30793Z","steps":["trace[1224020098] 'process raft request' (duration: 123.912479ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:02.308372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.946855ms","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-09T17:12:02.308429Z","caller":"traceutil/trace.go:171","msg":"trace[1956337557] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4907; }","duration":"351.053639ms","start":"2026-06-09T17:12:01.957364Z","end":"2026-06-09T17:12:02.308417Z","steps":["trace[1956337557] 'agreement among raft nodes before linearized reading' (duration: 350.872494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:02.308458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-09T17:12:01.957343Z","time spent":"351.1088ms","remote":"127.0.0.1:59320","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":"warn","ts":"2026-06-09T17:12:02.30897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.24419ms","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-09T17:12:02.309069Z","caller":"traceutil/trace.go:171","msg":"trace[872817081] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4907; }","duration":"116.369323ms","start":"2026-06-09T17:12:02.192684Z","end":"2026-06-09T17:12:02.309053Z","steps":["trace[872817081] 'agreement among raft nodes before linearized reading' (duration: 116.165818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:02.309493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.218081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-09T17:12:02.309546Z","caller":"traceutil/trace.go:171","msg":"trace[1867491269] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4907; }","duration":"116.320363ms","start":"2026-06-09T17:12:02.193212Z","end":"2026-06-09T17:12:02.309533Z","steps":["trace[1867491269] 'agreement among raft nodes before linearized reading' (duration: 115.436671ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:02.409143Z","caller":"traceutil/trace.go:171","msg":"trace[1774878543] transaction","detail":"{read_only:false; response_revision:4908; number_of_response:1; }","duration":"104.469101ms","start":"2026-06-09T17:12:02.304642Z","end":"2026-06-09T17:12:02.409111Z","steps":["trace[1774878543] 'process raft request' (duration: 78.973043ms)","trace[1774878543] 'compare' (duration: 25.313514ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:36.621196Z","caller":"traceutil/trace.go:171","msg":"trace[1080427213] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"193.471436ms","start":"2026-06-09T17:12:36.427693Z","end":"2026-06-09T17:12:36.621164Z","steps":["trace[1080427213] 'process raft request' (duration: 130.838159ms)","trace[1080427213] 'compare' (duration: 62.076373ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:36.621399Z","caller":"traceutil/trace.go:171","msg":"trace[1625914730] linearizableReadLoop","detail":"{readStateIndex:5423; appliedIndex:5421; }","duration":"165.173361ms","start":"2026-06-09T17:12:36.45619Z","end":"2026-06-09T17:12:36.621363Z","steps":["trace[1625914730] 'read index received' (duration: 102.30586ms)","trace[1625914730] 'applied index is now lower than readState.Index' (duration: 62.865361ms)"],"step_count":2} {"level":"info","ts":"2026-06-09T17:12:36.62167Z","caller":"traceutil/trace.go:171","msg":"trace[1195821059] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"193.774642ms","start":"2026-06-09T17:12:36.427869Z","end":"2026-06-09T17:12:36.621644Z","steps":["trace[1195821059] 'process raft request' (duration: 193.201958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:12:36.621746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.52557ms","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-09T17:12:36.621791Z","caller":"traceutil/trace.go:171","msg":"trace[1842494315] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5229; }","duration":"165.617312ms","start":"2026-06-09T17:12:36.456158Z","end":"2026-06-09T17:12:36.621776Z","steps":["trace[1842494315] 'agreement among raft nodes before linearized reading' (duration: 165.341706ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:12:52.693787Z","caller":"traceutil/trace.go:171","msg":"trace[1544524273] transaction","detail":"{read_only:false; response_revision:5339; number_of_response:1; }","duration":"107.00693ms","start":"2026-06-09T17:12:52.586753Z","end":"2026-06-09T17:12:52.69376Z","steps":["trace[1544524273] 'process raft request' (duration: 106.844787ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:13:27.61082Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2907} {"level":"info","ts":"2026-06-09T17:13:27.717202Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2907,"took":"104.360791ms","hash":642722342,"current-db-size-bytes":53374976,"current-db-size":"53 MB","current-db-size-in-use-bytes":29577216,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-09T17:13:27.717279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":642722342,"revision":2907,"compact-revision":-1} {"level":"info","ts":"2026-06-09T17:16:03.684077Z","caller":"traceutil/trace.go:171","msg":"trace[111291987] transaction","detail":"{read_only:false; response_revision:6676; number_of_response:1; }","duration":"153.617985ms","start":"2026-06-09T17:16:03.53042Z","end":"2026-06-09T17:16:03.684038Z","steps":["trace[111291987] 'process raft request' (duration: 153.502273ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:16:03.684286Z","caller":"traceutil/trace.go:171","msg":"trace[1886248546] transaction","detail":"{read_only:false; response_revision:6675; number_of_response:1; }","duration":"174.248746ms","start":"2026-06-09T17:16:03.510024Z","end":"2026-06-09T17:16:03.684272Z","steps":["trace[1886248546] 'process raft request' (duration: 173.764185ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:18:27.620447Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5618} {"level":"info","ts":"2026-06-09T17:18:27.698334Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5618,"took":"75.989778ms","hash":1125067055,"current-db-size-bytes":53374976,"current-db-size":"53 MB","current-db-size-in-use-bytes":18325504,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-09T17:18:27.698413Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1125067055,"revision":5618,"compact-revision":2907} {"level":"info","ts":"2026-06-09T17:19:26.572783Z","caller":"traceutil/trace.go:171","msg":"trace[1185312295] transaction","detail":"{read_only:false; response_revision:7729; number_of_response:1; }","duration":"222.494852ms","start":"2026-06-09T17:19:26.350263Z","end":"2026-06-09T17:19:26.572758Z","steps":["trace[1185312295] 'process raft request' (duration: 222.310616ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:19:26.572985Z","caller":"traceutil/trace.go:171","msg":"trace[1093775559] linearizableReadLoop","detail":"{readStateIndex:8016; appliedIndex:8015; }","duration":"214.570616ms","start":"2026-06-09T17:19:26.358397Z","end":"2026-06-09T17:19:26.572967Z","steps":["trace[1093775559] 'read index received' (duration: 214.160445ms)","trace[1093775559] 'applied index is now lower than readState.Index' (duration: 408.471µs)"],"step_count":2} {"level":"warn","ts":"2026-06-09T17:19:26.57347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.033617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" limit:500 ","response":"range_response_count:6 size:61984"} {"level":"info","ts":"2026-06-09T17:19:26.57363Z","caller":"traceutil/trace.go:171","msg":"trace[1101580604] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:7729; }","duration":"215.194511ms","start":"2026-06-09T17:19:26.358388Z","end":"2026-06-09T17:19:26.573582Z","steps":["trace[1101580604] 'agreement among raft nodes before linearized reading' (duration: 214.703339ms)"],"step_count":1} {"level":"warn","ts":"2026-06-09T17:19:26.573705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.951663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-cainjector-64b59ddb75-wlnt8\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-06-09T17:19:26.573798Z","caller":"traceutil/trace.go:171","msg":"trace[299911686] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-cainjector-64b59ddb75-wlnt8; range_end:; response_count:1; response_revision:7731; }","duration":"208.116567ms","start":"2026-06-09T17:19:26.365663Z","end":"2026-06-09T17:19:26.57378Z","steps":["trace[299911686] 'agreement among raft nodes before linearized reading' (duration: 207.85618ms)"],"step_count":1} {"level":"info","ts":"2026-06-09T17:19:26.574097Z","caller":"traceutil/trace.go:171","msg":"trace[732567386] transaction","detail":"{read_only:false; response_revision:7730; number_of_response:1; }","duration":"125.339067ms","start":"2026-06-09T17:19:26.448628Z","end":"2026-06-09T17:19:26.573967Z","steps":["trace[732567386] 'process raft request' (duration: 124.728732ms)"],"step_count":1}