{"level":"warn","ts":"2026-09-12T01:00:40.229932Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-12T01:00:40.230062Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.57: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://162.253.55.57:2380","--initial-cluster=instance=https://162.253.55.57:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.57:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.57: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-09-12T01:00:40.230152Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-12T01:00:40.230171Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.57:2380"]} {"level":"info","ts":"2026-09-12T01:00:40.230196Z","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-09-12T01:00:40.230911Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"]} {"level":"info","ts":"2026-09-12T01:00:40.230992Z","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://162.253.55.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.57: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-09-12T01:00:40.238333Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.08884ms"} {"level":"info","ts":"2026-09-12T01:00:40.247555Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"db28a37eabf8270","cluster-id":"33328f64ab44b15e"} {"level":"info","ts":"2026-09-12T01:00:40.247651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=()"} {"level":"info","ts":"2026-09-12T01:00:40.247703Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 0"} {"level":"info","ts":"2026-09-12T01:00:40.247713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft db28a37eabf8270 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-12T01:00:40.247722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became follower at term 1"} {"level":"info","ts":"2026-09-12T01:00:40.247767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"} {"level":"warn","ts":"2026-09-12T01:00:40.256686Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-12T01:00:40.25811Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-12T01:00:40.259261Z","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-09-12T01:00:40.261248Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"db28a37eabf8270","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-12T01:00:40.26362Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"db28a37eabf8270","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-12T01:00:40.263694Z","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-09-12T01:00:40.263889Z","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-09-12T01:00:40.26391Z","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-09-12T01:00:40.264676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 switched to configuration voters=(987003241113813616)"} {"level":"info","ts":"2026-09-12T01:00:40.264841Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","added-peer-id":"db28a37eabf8270","added-peer-peer-urls":["https://162.253.55.57:2380"]} {"level":"info","ts":"2026-09-12T01:00:40.265441Z","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-09-12T01:00:40.265544Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.57:2380"} {"level":"info","ts":"2026-09-12T01:00:40.265676Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.57:2380"} {"level":"info","ts":"2026-09-12T01:00:40.265854Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"db28a37eabf8270","initial-advertise-peer-urls":["https://162.253.55.57:2380"],"listen-peer-urls":["https://162.253.55.57:2380"],"advertise-client-urls":["https://162.253.55.57:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.57:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-12T01:00:40.265898Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-12T01:00:41.048321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 is starting a new election at term 1"} {"level":"info","ts":"2026-09-12T01:00:41.0484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-12T01:00:41.048517Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgPreVoteResp from db28a37eabf8270 at term 1"} {"level":"info","ts":"2026-09-12T01:00:41.048547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became candidate at term 2"} {"level":"info","ts":"2026-09-12T01:00:41.048563Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 received MsgVoteResp from db28a37eabf8270 at term 2"} {"level":"info","ts":"2026-09-12T01:00:41.048586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"db28a37eabf8270 became leader at term 2"} {"level":"info","ts":"2026-09-12T01:00:41.048605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: db28a37eabf8270 elected leader db28a37eabf8270 at term 2"} {"level":"info","ts":"2026-09-12T01:00:41.050013Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"db28a37eabf8270","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.57:2379]}","request-path":"/0/members/db28a37eabf8270/attributes","cluster-id":"33328f64ab44b15e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-12T01:00:41.050018Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T01:00:41.050068Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T01:00:41.050051Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-12T01:00:41.050367Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-12T01:00:41.050407Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-12T01:00:41.051248Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"33328f64ab44b15e","local-member-id":"db28a37eabf8270","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T01:00:41.051399Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T01:00:41.051436Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-12T01:00:41.053711Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-12T01:00:41.054343Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.57:2379"} {"level":"info","ts":"2026-09-12T01:00:43.733777Z","caller":"traceutil/trace.go:171","msg":"trace[1550196199] linearizableReadLoop","detail":"{readStateIndex:75; appliedIndex:74; }","duration":"110.540902ms","start":"2026-09-12T01:00:43.623211Z","end":"2026-09-12T01:00:43.733752Z","steps":["trace[1550196199] 'read index received' (duration: 110.344991ms)","trace[1550196199] 'applied index is now lower than readState.Index' (duration: 195.001µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:00:43.733899Z","caller":"traceutil/trace.go:171","msg":"trace[975948746] transaction","detail":"{read_only:false; response_revision:71; number_of_response:1; }","duration":"112.617344ms","start":"2026-09-12T01:00:43.621273Z","end":"2026-09-12T01:00:43.733891Z","steps":["trace[975948746] 'process raft request' (duration: 112.335322ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:00:43.734309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.049265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-12T01:00:43.734698Z","caller":"traceutil/trace.go:171","msg":"trace[914420500] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:71; }","duration":"111.206415ms","start":"2026-09-12T01:00:43.623187Z","end":"2026-09-12T01:00:43.734394Z","steps":["trace[914420500] 'agreement among raft nodes before linearized reading' (duration: 110.927004ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:00:44.045697Z","caller":"traceutil/trace.go:171","msg":"trace[714083021] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"303.067435ms","start":"2026-09-12T01:00:43.742598Z","end":"2026-09-12T01:00:44.045665Z","steps":["trace[714083021] 'read index received' (duration: 302.841332ms)","trace[714083021] 'applied index is now lower than readState.Index' (duration: 225.063µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:00:44.04582Z","caller":"traceutil/trace.go:171","msg":"trace[429665216] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"304.426962ms","start":"2026-09-12T01:00:43.741365Z","end":"2026-09-12T01:00:44.045792Z","steps":["trace[429665216] 'process raft request' (duration: 304.075829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:00:44.045916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.275066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-12T01:00:44.046049Z","caller":"traceutil/trace.go:171","msg":"trace[1599577853] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:72; }","duration":"303.465197ms","start":"2026-09-12T01:00:43.742493Z","end":"2026-09-12T01:00:44.045958Z","steps":["trace[1599577853] 'agreement among raft nodes before linearized reading' (duration: 303.293236ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:00:44.046149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:00:43.742467Z","time spent":"303.664048ms","remote":"127.0.0.1:34728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":26,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "} {"level":"warn","ts":"2026-09-12T01:00:44.047193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:00:43.741341Z","time spent":"304.549914ms","remote":"127.0.0.1:34748","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":36,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T01:01:35.89825Z","caller":"traceutil/trace.go:171","msg":"trace[2069687933] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"155.192135ms","start":"2026-09-12T01:01:35.743037Z","end":"2026-09-12T01:01:35.898229Z","steps":["trace[2069687933] 'process raft request' (duration: 154.76785ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:01:35.898481Z","caller":"traceutil/trace.go:171","msg":"trace[1847970179] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:643; }","duration":"102.074503ms","start":"2026-09-12T01:01:35.796351Z","end":"2026-09-12T01:01:35.898425Z","steps":["trace[1847970179] 'read index received' (duration: 102.052092ms)","trace[1847970179] 'applied index is now lower than readState.Index' (duration: 17.54µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:01:35.898849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.458435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-12T01:01:35.89895Z","caller":"traceutil/trace.go:171","msg":"trace[1212583552] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:616; }","duration":"102.654393ms","start":"2026-09-12T01:01:35.796275Z","end":"2026-09-12T01:01:35.89893Z","steps":["trace[1212583552] 'agreement among raft nodes before linearized reading' (duration: 102.316711ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:01:36.119266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.885742ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:01:36.119462Z","caller":"traceutil/trace.go:171","msg":"trace[762646427] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:643; }","duration":"129.230334ms","start":"2026-09-12T01:01:35.990213Z","end":"2026-09-12T01:01:36.119444Z","steps":["trace[762646427] 'read index received' (duration: 100.102595ms)","trace[762646427] 'applied index is now lower than readState.Index' (duration: 29.126509ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:01:36.119571Z","caller":"traceutil/trace.go:171","msg":"trace[699138] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"140.959916ms","start":"2026-09-12T01:01:35.978598Z","end":"2026-09-12T01:01:36.119558Z","steps":["trace[699138] 'process raft request' (duration: 140.7779ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:01:36.119532Z","caller":"traceutil/trace.go:171","msg":"trace[916767910] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"213.463814ms","start":"2026-09-12T01:01:35.906034Z","end":"2026-09-12T01:01:36.119498Z","steps":["trace[916767910] 'process raft request' (duration: 83.9191ms)","trace[916767910] 'compare' (duration: 128.767677ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:01:36.119838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.599276ms","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-09-12T01:01:36.12006Z","caller":"traceutil/trace.go:171","msg":"trace[1673004338] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"129.852494ms","start":"2026-09-12T01:01:35.990182Z","end":"2026-09-12T01:01:36.120034Z","steps":["trace[1673004338] 'agreement among raft nodes before linearized reading' (duration: 129.525934ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:01:36.722155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.36181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:01:36.722423Z","caller":"traceutil/trace.go:171","msg":"trace[1941303341] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"588.206052ms","start":"2026-09-12T01:01:36.134196Z","end":"2026-09-12T01:01:36.722402Z","steps":["trace[1941303341] 'read index received' (duration: 11.209191ms)","trace[1941303341] 'applied index is now lower than readState.Index' (duration: 576.995711ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:01:36.722518Z","caller":"traceutil/trace.go:171","msg":"trace[2067643980] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"596.223564ms","start":"2026-09-12T01:01:36.126276Z","end":"2026-09-12T01:01:36.722499Z","steps":["trace[2067643980] 'process raft request' (duration: 234.42462ms)","trace[2067643980] 'compare' (duration: 361.198605ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:01:36.72254Z","caller":"traceutil/trace.go:171","msg":"trace[220367647] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"579.723904ms","start":"2026-09-12T01:01:36.142803Z","end":"2026-09-12T01:01:36.722527Z","steps":["trace[220367647] 'process raft request' (duration: 579.501497ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:01:36.722609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:01:36.126248Z","time spent":"596.315438ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:01:36.722621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:01:36.142779Z","time spent":"579.796007ms","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:01:36.72275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.583634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:01:36.722802Z","caller":"traceutil/trace.go:171","msg":"trace[1585581272] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:621; }","duration":"588.658988ms","start":"2026-09-12T01:01:36.134127Z","end":"2026-09-12T01:01:36.722786Z","steps":["trace[1585581272] 'agreement among raft nodes before linearized reading' (duration: 588.587805ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:01:36.722841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:01:36.134111Z","time spent":"588.720181ms","remote":"127.0.0.1:34618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-09-12T01:01:36.722923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.778106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:01:36.72296Z","caller":"traceutil/trace.go:171","msg":"trace[2026533368] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"258.86154ms","start":"2026-09-12T01:01:36.464089Z","end":"2026-09-12T01:01:36.722951Z","steps":["trace[2026533368] 'agreement among raft nodes before linearized reading' (duration: 258.781167ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:01:37.428232Z","caller":"traceutil/trace.go:171","msg":"trace[565139567] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"132.768981ms","start":"2026-09-12T01:01:37.295408Z","end":"2026-09-12T01:01:37.428177Z","steps":["trace[565139567] 'process raft request' (duration: 108.836107ms)","trace[565139567] 'compare' (duration: 23.762538ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:02:05.400461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.852233ms","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-09-12T01:02:05.400567Z","caller":"traceutil/trace.go:171","msg":"trace[666166106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:908; }","duration":"141.019697ms","start":"2026-09-12T01:02:05.259526Z","end":"2026-09-12T01:02:05.400545Z","steps":["trace[666166106] 'range keys from in-memory index tree' (duration: 140.585756ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:05.401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.122686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-12T01:02:05.401134Z","caller":"traceutil/trace.go:171","msg":"trace[596297434] range","detail":"{range_begin:/registry/masterleases/162.253.55.57; range_end:; response_count:1; response_revision:908; }","duration":"188.2803ms","start":"2026-09-12T01:02:05.212829Z","end":"2026-09-12T01:02:05.401109Z","steps":["trace[596297434] 'range keys from in-memory index tree' (duration: 187.49698ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:05.666001Z","caller":"traceutil/trace.go:171","msg":"trace[271574400] linearizableReadLoop","detail":"{readStateIndex:944; appliedIndex:942; }","duration":"203.436768ms","start":"2026-09-12T01:02:05.462538Z","end":"2026-09-12T01:02:05.665974Z","steps":["trace[271574400] 'read index received' (duration: 78.980945ms)","trace[271574400] 'applied index is now lower than readState.Index' (duration: 124.454583ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:05.666161Z","caller":"traceutil/trace.go:171","msg":"trace[1576837156] transaction","detail":"{read_only:false; response_revision:910; number_of_response:1; }","duration":"123.15887ms","start":"2026-09-12T01:02:05.542988Z","end":"2026-09-12T01:02:05.666147Z","steps":["trace[1576837156] 'process raft request' (duration: 122.932614ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:05.666292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.743087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:02:05.666363Z","caller":"traceutil/trace.go:171","msg":"trace[2037359128] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:910; }","duration":"203.872129ms","start":"2026-09-12T01:02:05.462465Z","end":"2026-09-12T01:02:05.666337Z","steps":["trace[2037359128] 'agreement among raft nodes before linearized reading' (duration: 203.714436ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:05.666002Z","caller":"traceutil/trace.go:171","msg":"trace[995015906] transaction","detail":"{read_only:false; response_revision:909; number_of_response:1; }","duration":"260.655707ms","start":"2026-09-12T01:02:05.405328Z","end":"2026-09-12T01:02:05.665983Z","steps":["trace[995015906] 'process raft request' (duration: 225.809063ms)","trace[995015906] 'compare' (duration: 34.628158ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:02:05.666703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.248546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:02:05.666854Z","caller":"traceutil/trace.go:171","msg":"trace[743942182] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:910; }","duration":"106.490732ms","start":"2026-09-12T01:02:05.560331Z","end":"2026-09-12T01:02:05.666822Z","steps":["trace[743942182] 'agreement among raft nodes before linearized reading' (duration: 106.258185ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:05.929674Z","caller":"traceutil/trace.go:171","msg":"trace[290590169] transaction","detail":"{read_only:false; response_revision:917; number_of_response:1; }","duration":"119.604128ms","start":"2026-09-12T01:02:05.810031Z","end":"2026-09-12T01:02:05.929635Z","steps":["trace[290590169] 'process raft request' (duration: 107.97564ms)","trace[290590169] 'compare' (duration: 11.474984ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:06.044564Z","caller":"traceutil/trace.go:171","msg":"trace[960912104] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"108.972145ms","start":"2026-09-12T01:02:05.935556Z","end":"2026-09-12T01:02:06.044528Z","steps":["trace[960912104] 'process raft request' (duration: 95.236717ms)","trace[960912104] 'compare' (duration: 13.591355ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:06.306053Z","caller":"traceutil/trace.go:171","msg":"trace[1448498461] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"257.024136ms","start":"2026-09-12T01:02:06.048996Z","end":"2026-09-12T01:02:06.30602Z","steps":["trace[1448498461] 'process raft request' (duration: 208.637956ms)","trace[1448498461] 'compare' (duration: 47.915228ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:02:06.666251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.963052ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:02:06.666378Z","caller":"traceutil/trace.go:171","msg":"trace[518292148] linearizableReadLoop","detail":"{readStateIndex:956; appliedIndex:955; }","duration":"306.754832ms","start":"2026-09-12T01:02:06.359575Z","end":"2026-09-12T01:02:06.66633Z","steps":["trace[518292148] 'read index received' (duration: 125.610275ms)","trace[518292148] 'applied index is now lower than readState.Index' (duration: 181.143097ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:06.666497Z","caller":"traceutil/trace.go:171","msg":"trace[652239671] transaction","detail":"{read_only:false; response_revision:921; number_of_response:1; }","duration":"354.691371ms","start":"2026-09-12T01:02:06.311769Z","end":"2026-09-12T01:02:06.666461Z","steps":["trace[652239671] 'process raft request' (duration: 173.4017ms)","trace[652239671] 'compare' (duration: 180.816538ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:02:06.666568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.004129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-12T01:02:06.666615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:02:06.311753Z","time spent":"354.800714ms","remote":"127.0.0.1:34842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2872,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T01:02:06.666633Z","caller":"traceutil/trace.go:171","msg":"trace[2047851822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:921; }","duration":"307.121732ms","start":"2026-09-12T01:02:06.359496Z","end":"2026-09-12T01:02:06.666617Z","steps":["trace[2047851822] 'agreement among raft nodes before linearized reading' (duration: 306.913256ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:06.66668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:02:06.359468Z","time spent":"307.199983ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-12T01:02:06.667166Z","caller":"traceutil/trace.go:171","msg":"trace[317906841] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"246.342765ms","start":"2026-09-12T01:02:06.420805Z","end":"2026-09-12T01:02:06.667148Z","steps":["trace[317906841] 'process raft request' (duration: 246.256473ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:06.869477Z","caller":"traceutil/trace.go:171","msg":"trace[577053268] transaction","detail":"{read_only:false; response_revision:924; number_of_response:1; }","duration":"196.96906ms","start":"2026-09-12T01:02:06.672487Z","end":"2026-09-12T01:02:06.869456Z","steps":["trace[577053268] 'process raft request' (duration: 196.820215ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:06.992878Z","caller":"traceutil/trace.go:171","msg":"trace[2006505929] linearizableReadLoop","detail":"{readStateIndex:960; appliedIndex:958; }","duration":"149.214735ms","start":"2026-09-12T01:02:06.84362Z","end":"2026-09-12T01:02:06.992835Z","steps":["trace[2006505929] 'read index received' (duration: 25.765336ms)","trace[2006505929] 'applied index is now lower than readState.Index' (duration: 123.448409ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:06.993051Z","caller":"traceutil/trace.go:171","msg":"trace[653486151] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"316.423587ms","start":"2026-09-12T01:02:06.676617Z","end":"2026-09-12T01:02:06.99304Z","steps":["trace[653486151] 'process raft request' (duration: 314.229721ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:06.99325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:02:06.676604Z","time spent":"316.480438ms","remote":"127.0.0.1:34458","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12740,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:02:06.993318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.691317ms","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-09-12T01:02:06.993424Z","caller":"traceutil/trace.go:171","msg":"trace[178190343] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:925; }","duration":"149.81039ms","start":"2026-09-12T01:02:06.843597Z","end":"2026-09-12T01:02:06.993407Z","steps":["trace[178190343] 'agreement among raft nodes before linearized reading' (duration: 149.582114ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:07.042495Z","caller":"traceutil/trace.go:171","msg":"trace[838484629] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"168.563818ms","start":"2026-09-12T01:02:06.873893Z","end":"2026-09-12T01:02:07.042456Z","steps":["trace[838484629] 'process raft request' (duration: 168.24369ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:07.042601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.936212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:02:07.042723Z","caller":"traceutil/trace.go:171","msg":"trace[1340256256] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"167.604753ms","start":"2026-09-12T01:02:06.875088Z","end":"2026-09-12T01:02:07.042693Z","steps":["trace[1340256256] 'process raft request' (duration: 167.290015ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:07.04274Z","caller":"traceutil/trace.go:171","msg":"trace[1366919988] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:927; }","duration":"168.128857ms","start":"2026-09-12T01:02:06.874578Z","end":"2026-09-12T01:02:07.042707Z","steps":["trace[1366919988] 'agreement among raft nodes before linearized reading' (duration: 167.922602ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.56324Z","caller":"traceutil/trace.go:171","msg":"trace[1699489872] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"115.83408ms","start":"2026-09-12T01:02:15.44734Z","end":"2026-09-12T01:02:15.563174Z","steps":["trace[1699489872] 'process raft request' (duration: 110.147437ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.563457Z","caller":"traceutil/trace.go:171","msg":"trace[171149423] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"115.729388ms","start":"2026-09-12T01:02:15.447674Z","end":"2026-09-12T01:02:15.563404Z","steps":["trace[171149423] 'process raft request' (duration: 115.530623ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.563433Z","caller":"traceutil/trace.go:171","msg":"trace[457674896] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"115.785939ms","start":"2026-09-12T01:02:15.447591Z","end":"2026-09-12T01:02:15.563377Z","steps":["trace[457674896] 'process raft request' (duration: 115.523333ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.563253Z","caller":"traceutil/trace.go:171","msg":"trace[515944893] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"115.690656ms","start":"2026-09-12T01:02:15.447524Z","end":"2026-09-12T01:02:15.563214Z","steps":["trace[515944893] 'process raft request' (duration: 115.551293ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.563527Z","caller":"traceutil/trace.go:171","msg":"trace[1032895925] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"115.751068ms","start":"2026-09-12T01:02:15.447626Z","end":"2026-09-12T01:02:15.563377Z","steps":["trace[1032895925] 'process raft request' (duration: 115.539403ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.563771Z","caller":"traceutil/trace.go:171","msg":"trace[1019373082] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"115.918962ms","start":"2026-09-12T01:02:15.447821Z","end":"2026-09-12T01:02:15.56374Z","steps":["trace[1019373082] 'process raft request' (duration: 115.507313ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.563816Z","caller":"traceutil/trace.go:171","msg":"trace[1828608026] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"115.636895ms","start":"2026-09-12T01:02:15.447783Z","end":"2026-09-12T01:02:15.56342Z","steps":["trace[1828608026] 'process raft request' (duration: 115.464981ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.563836Z","caller":"traceutil/trace.go:171","msg":"trace[1818341698] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"115.947772ms","start":"2026-09-12T01:02:15.447872Z","end":"2026-09-12T01:02:15.56382Z","steps":["trace[1818341698] 'process raft request' (duration: 115.505612ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.563903Z","caller":"traceutil/trace.go:171","msg":"trace[329037906] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"112.48237ms","start":"2026-09-12T01:02:15.451412Z","end":"2026-09-12T01:02:15.563895Z","steps":["trace[329037906] 'process raft request' (duration: 112.257795ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.564069Z","caller":"traceutil/trace.go:171","msg":"trace[1620769480] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"112.4991ms","start":"2026-09-12T01:02:15.451557Z","end":"2026-09-12T01:02:15.564056Z","steps":["trace[1620769480] 'process raft request' (duration: 112.191853ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.564146Z","caller":"traceutil/trace.go:171","msg":"trace[1264401962] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"112.528931ms","start":"2026-09-12T01:02:15.451608Z","end":"2026-09-12T01:02:15.564137Z","steps":["trace[1264401962] 'process raft request' (duration: 112.242495ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.564409Z","caller":"traceutil/trace.go:171","msg":"trace[178572865] linearizableReadLoop","detail":"{readStateIndex:1055; appliedIndex:1042; }","duration":"101.159005ms","start":"2026-09-12T01:02:15.463217Z","end":"2026-09-12T01:02:15.564376Z","steps":["trace[178572865] 'read index received' (duration: 3.715608ms)","trace[178572865] 'applied index is now lower than readState.Index' (duration: 97.441847ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:15.564528Z","caller":"traceutil/trace.go:171","msg":"trace[1588474874] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"100.941639ms","start":"2026-09-12T01:02:15.463569Z","end":"2026-09-12T01:02:15.564511Z","steps":["trace[1588474874] 'process raft request' (duration: 100.453067ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.56467Z","caller":"traceutil/trace.go:171","msg":"trace[402207888] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"101.01054ms","start":"2026-09-12T01:02:15.463641Z","end":"2026-09-12T01:02:15.564652Z","steps":["trace[402207888] 'process raft request' (duration: 100.567069ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:15.56482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.457022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:02:15.564879Z","caller":"traceutil/trace.go:171","msg":"trace[1789237023] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1020; }","duration":"101.692617ms","start":"2026-09-12T01:02:15.463169Z","end":"2026-09-12T01:02:15.564862Z","steps":["trace[1789237023] 'agreement among raft nodes before linearized reading' (duration: 101.338779ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.72889Z","caller":"traceutil/trace.go:171","msg":"trace[928795384] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"138.458033ms","start":"2026-09-12T01:02:15.590399Z","end":"2026-09-12T01:02:15.728857Z","steps":["trace[928795384] 'process raft request' (duration: 83.701873ms)","trace[928795384] 'compare' (duration: 54.328991ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:15.729062Z","caller":"traceutil/trace.go:171","msg":"trace[1071539268] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"135.017571ms","start":"2026-09-12T01:02:15.594032Z","end":"2026-09-12T01:02:15.72905Z","steps":["trace[1071539268] 'process raft request' (duration: 134.676963ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.72917Z","caller":"traceutil/trace.go:171","msg":"trace[2124911259] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"138.653477ms","start":"2026-09-12T01:02:15.590509Z","end":"2026-09-12T01:02:15.729162Z","steps":["trace[2124911259] 'process raft request' (duration: 138.109585ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.729234Z","caller":"traceutil/trace.go:171","msg":"trace[407840345] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"138.3785ms","start":"2026-09-12T01:02:15.590839Z","end":"2026-09-12T01:02:15.729217Z","steps":["trace[407840345] 'process raft request' (duration: 137.829937ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.72946Z","caller":"traceutil/trace.go:171","msg":"trace[1818122394] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"133.18773ms","start":"2026-09-12T01:02:15.596253Z","end":"2026-09-12T01:02:15.729441Z","steps":["trace[1818122394] 'process raft request' (duration: 132.532664ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.873483Z","caller":"traceutil/trace.go:171","msg":"trace[2072484291] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"139.335653ms","start":"2026-09-12T01:02:15.73412Z","end":"2026-09-12T01:02:15.873456Z","steps":["trace[2072484291] 'process raft request' (duration: 129.700155ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.873698Z","caller":"traceutil/trace.go:171","msg":"trace[1675343125] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"138.950325ms","start":"2026-09-12T01:02:15.734727Z","end":"2026-09-12T01:02:15.873678Z","steps":["trace[1675343125] 'process raft request' (duration: 138.690878ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.873796Z","caller":"traceutil/trace.go:171","msg":"trace[103357680] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"139.60669ms","start":"2026-09-12T01:02:15.734174Z","end":"2026-09-12T01:02:15.873781Z","steps":["trace[103357680] 'process raft request' (duration: 139.20358ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:15.874251Z","caller":"traceutil/trace.go:171","msg":"trace[1077497959] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1080; }","duration":"136.318522ms","start":"2026-09-12T01:02:15.73792Z","end":"2026-09-12T01:02:15.874238Z","steps":["trace[1077497959] 'read index received' (duration: 60.833613ms)","trace[1077497959] 'applied index is now lower than readState.Index' (duration: 75.484019ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:15.874493Z","caller":"traceutil/trace.go:171","msg":"trace[808687143] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"119.414453ms","start":"2026-09-12T01:02:15.755067Z","end":"2026-09-12T01:02:15.874481Z","steps":["trace[808687143] 'process raft request' (duration: 118.43408ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:15.874743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.807194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:1 size:3944"} {"level":"info","ts":"2026-09-12T01:02:15.87478Z","caller":"traceutil/trace.go:171","msg":"trace[413094041] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:1; response_revision:1048; }","duration":"136.891025ms","start":"2026-09-12T01:02:15.737879Z","end":"2026-09-12T01:02:15.87477Z","steps":["trace[413094041] 'agreement among raft nodes before linearized reading' (duration: 136.408614ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:16.110787Z","caller":"traceutil/trace.go:171","msg":"trace[1832645431] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"101.590176ms","start":"2026-09-12T01:02:16.009162Z","end":"2026-09-12T01:02:16.110752Z","steps":["trace[1832645431] 'process raft request' (duration: 94.405478ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:16.110967Z","caller":"traceutil/trace.go:171","msg":"trace[1831904266] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"100.727905ms","start":"2026-09-12T01:02:16.010213Z","end":"2026-09-12T01:02:16.110941Z","steps":["trace[1831904266] 'process raft request' (duration: 100.485459ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:16.556648Z","caller":"traceutil/trace.go:171","msg":"trace[1925136431] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"221.832034ms","start":"2026-09-12T01:02:16.334786Z","end":"2026-09-12T01:02:16.556618Z","steps":["trace[1925136431] 'process raft request' (duration: 143.192296ms)","trace[1925136431] 'compare' (duration: 78.440773ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:16.557142Z","caller":"traceutil/trace.go:171","msg":"trace[1471776869] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"221.050327ms","start":"2026-09-12T01:02:16.336042Z","end":"2026-09-12T01:02:16.557092Z","steps":["trace[1471776869] 'process raft request' (duration: 220.527934ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:16.558056Z","caller":"traceutil/trace.go:171","msg":"trace[1132850445] linearizableReadLoop","detail":"{readStateIndex:1131; appliedIndex:1125; }","duration":"160.305126ms","start":"2026-09-12T01:02:16.39773Z","end":"2026-09-12T01:02:16.558035Z","steps":["trace[1132850445] 'read index received' (duration: 80.336117ms)","trace[1132850445] 'applied index is now lower than readState.Index' (duration: 79.967659ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:16.558329Z","caller":"traceutil/trace.go:171","msg":"trace[1039366599] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"216.233723ms","start":"2026-09-12T01:02:16.342071Z","end":"2026-09-12T01:02:16.558305Z","steps":["trace[1039366599] 'process raft request' (duration: 215.384034ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:16.558422Z","caller":"traceutil/trace.go:171","msg":"trace[459434073] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"216.070331ms","start":"2026-09-12T01:02:16.342336Z","end":"2026-09-12T01:02:16.558407Z","steps":["trace[459434073] 'process raft request' (duration: 215.225421ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:16.558466Z","caller":"traceutil/trace.go:171","msg":"trace[1544417566] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"214.982216ms","start":"2026-09-12T01:02:16.343473Z","end":"2026-09-12T01:02:16.558455Z","steps":["trace[1544417566] 'process raft request' (duration: 214.137786ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:16.558973Z","caller":"traceutil/trace.go:171","msg":"trace[509120864] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"213.613683ms","start":"2026-09-12T01:02:16.345337Z","end":"2026-09-12T01:02:16.55895Z","steps":["trace[509120864] 'process raft request' (duration: 212.335813ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:16.559036Z","caller":"traceutil/trace.go:171","msg":"trace[356482727] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"104.398481ms","start":"2026-09-12T01:02:16.454628Z","end":"2026-09-12T01:02:16.559027Z","steps":["trace[356482727] 'process raft request' (duration: 103.166232ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:16.559215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.479104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-12T01:02:16.563034Z","caller":"traceutil/trace.go:171","msg":"trace[18601118] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1095; }","duration":"165.343815ms","start":"2026-09-12T01:02:16.397665Z","end":"2026-09-12T01:02:16.563009Z","steps":["trace[18601118] 'agreement among raft nodes before linearized reading' (duration: 161.414443ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:19.012514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.371486ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:02:19.012634Z","caller":"traceutil/trace.go:171","msg":"trace[1324231689] transaction","detail":"{read_only:false; response_revision:1137; number_of_response:1; }","duration":"130.395029ms","start":"2026-09-12T01:02:18.882216Z","end":"2026-09-12T01:02:19.012611Z","steps":["trace[1324231689] 'process raft request' (duration: 13.846399ms)","trace[1324231689] 'compare' (duration: 116.233263ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:20.879287Z","caller":"traceutil/trace.go:171","msg":"trace[215428628] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"205.624315ms","start":"2026-09-12T01:02:20.673627Z","end":"2026-09-12T01:02:20.879252Z","steps":["trace[215428628] 'process raft request' (duration: 205.41254ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:20.991318Z","caller":"traceutil/trace.go:171","msg":"trace[1224127083] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"187.829013ms","start":"2026-09-12T01:02:20.803449Z","end":"2026-09-12T01:02:20.991278Z","steps":["trace[1224127083] 'process raft request' (duration: 137.81376ms)","trace[1224127083] 'compare' (duration: 49.665024ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:21.297237Z","caller":"traceutil/trace.go:171","msg":"trace[804979785] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"107.179407ms","start":"2026-09-12T01:02:21.190019Z","end":"2026-09-12T01:02:21.297199Z","steps":["trace[804979785] 'process raft request' (duration: 37.782539ms)","trace[804979785] 'compare' (duration: 69.130062ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:33.209128Z","caller":"traceutil/trace.go:171","msg":"trace[1157764705] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"175.155988ms","start":"2026-09-12T01:02:33.033944Z","end":"2026-09-12T01:02:33.2091Z","steps":["trace[1157764705] 'process raft request' (duration: 173.004224ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:36.288065Z","caller":"traceutil/trace.go:171","msg":"trace[1512247304] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"160.482308ms","start":"2026-09-12T01:02:36.127531Z","end":"2026-09-12T01:02:36.288013Z","steps":["trace[1512247304] 'process raft request' (duration: 160.177052ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:36.698778Z","caller":"traceutil/trace.go:171","msg":"trace[1009786986] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"215.320742ms","start":"2026-09-12T01:02:36.483432Z","end":"2026-09-12T01:02:36.698753Z","steps":["trace[1009786986] 'process raft request' (duration: 215.162529ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:56.198903Z","caller":"traceutil/trace.go:171","msg":"trace[2026913500] transaction","detail":"{read_only:false; response_revision:1477; number_of_response:1; }","duration":"154.719104ms","start":"2026-09-12T01:02:56.044147Z","end":"2026-09-12T01:02:56.198866Z","steps":["trace[2026913500] 'process raft request' (duration: 154.591151ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:59.291533Z","caller":"traceutil/trace.go:171","msg":"trace[703809499] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"123.320481ms","start":"2026-09-12T01:02:59.168189Z","end":"2026-09-12T01:02:59.291509Z","steps":["trace[703809499] 'process raft request' (duration: 123.172919ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:59.518411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.112808ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:02:59.51848Z","caller":"traceutil/trace.go:171","msg":"trace[1552322469] linearizableReadLoop","detail":"{readStateIndex:1543; appliedIndex:1542; }","duration":"170.545523ms","start":"2026-09-12T01:02:59.347924Z","end":"2026-09-12T01:02:59.51847Z","steps":["trace[1552322469] 'read index received' (duration: 36.218621ms)","trace[1552322469] 'applied index is now lower than readState.Index' (duration: 134.326292ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:59.518613Z","caller":"traceutil/trace.go:171","msg":"trace[404027835] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"228.304272ms","start":"2026-09-12T01:02:59.290276Z","end":"2026-09-12T01:02:59.518581Z","steps":["trace[404027835] 'process raft request' (duration: 93.96916ms)","trace[404027835] 'compare' (duration: 133.920195ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:02:59.518714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.760528ms","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-09-12T01:02:59.51881Z","caller":"traceutil/trace.go:171","msg":"trace[435172209] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1493; }","duration":"170.900421ms","start":"2026-09-12T01:02:59.347887Z","end":"2026-09-12T01:02:59.518787Z","steps":["trace[435172209] 'agreement among raft nodes before linearized reading' (duration: 170.644645ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:59.741943Z","caller":"traceutil/trace.go:171","msg":"trace[308410302] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"219.009839ms","start":"2026-09-12T01:02:59.522904Z","end":"2026-09-12T01:02:59.741914Z","steps":["trace[308410302] 'process raft request' (duration: 218.845757ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:02:59.744297Z","caller":"traceutil/trace.go:171","msg":"trace[2114619880] linearizableReadLoop","detail":"{readStateIndex:1545; appliedIndex:1544; }","duration":"183.041353ms","start":"2026-09-12T01:02:59.561231Z","end":"2026-09-12T01:02:59.744272Z","steps":["trace[2114619880] 'read index received' (duration: 180.666531ms)","trace[2114619880] 'applied index is now lower than readState.Index' (duration: 2.373672ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:02:59.74433Z","caller":"traceutil/trace.go:171","msg":"trace[1874022362] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"221.200838ms","start":"2026-09-12T01:02:59.523107Z","end":"2026-09-12T01:02:59.744308Z","steps":["trace[1874022362] 'process raft request' (duration: 220.965665ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:02:59.744506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.251726ms","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-09-12T01:02:59.744552Z","caller":"traceutil/trace.go:171","msg":"trace[730316009] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1496; }","duration":"183.379308ms","start":"2026-09-12T01:02:59.561159Z","end":"2026-09-12T01:02:59.744539Z","steps":["trace[730316009] 'agreement among raft nodes before linearized reading' (duration: 183.213006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:03:25.647546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.054801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-12T01:03:25.647624Z","caller":"traceutil/trace.go:171","msg":"trace[1641090643] range","detail":"{range_begin:/registry/masterleases/162.253.55.57; range_end:; response_count:1; response_revision:1917; }","duration":"429.178122ms","start":"2026-09-12T01:03:25.218429Z","end":"2026-09-12T01:03:25.647607Z","steps":["trace[1641090643] 'range keys from in-memory index tree' (duration: 428.880188ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:03:25.647659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.218407Z","time spent":"429.243664ms","remote":"127.0.0.1:34414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/162.253.55.57\" "} {"level":"warn","ts":"2026-09-12T01:03:25.647682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.097477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-12T01:03:25.647778Z","caller":"traceutil/trace.go:171","msg":"trace[152624514] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1917; }","duration":"495.224738ms","start":"2026-09-12T01:03:25.152526Z","end":"2026-09-12T01:03:25.647751Z","steps":["trace[152624514] 'range keys from in-memory index tree' (duration: 494.955824ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:25.647988Z","caller":"traceutil/trace.go:171","msg":"trace[821946506] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1993; }","duration":"228.510446ms","start":"2026-09-12T01:03:25.419458Z","end":"2026-09-12T01:03:25.647969Z","steps":["trace[821946506] 'read index received' (duration: 214.614092ms)","trace[821946506] 'applied index is now lower than readState.Index' (duration: 13.895204ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:03:25.648091Z","caller":"traceutil/trace.go:171","msg":"trace[546258046] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"385.310749ms","start":"2026-09-12T01:03:25.262765Z","end":"2026-09-12T01:03:25.648076Z","steps":["trace[546258046] 'process raft request' (duration: 371.234322ms)","trace[546258046] 'compare' (duration: 13.088741ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:03:25.648167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.705579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-09-12T01:03:25.648178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.262748Z","time spent":"385.374539ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:03:25.648218Z","caller":"traceutil/trace.go:171","msg":"trace[1572148272] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1918; }","duration":"228.794291ms","start":"2026-09-12T01:03:25.41941Z","end":"2026-09-12T01:03:25.648204Z","steps":["trace[1572148272] 'agreement among raft nodes before linearized reading' (duration: 228.654219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:03:25.648863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.15251Z","time spent":"496.064841ms","remote":"127.0.0.1:53004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-09-12T01:03:25.660718Z","caller":"traceutil/trace.go:171","msg":"trace[1055287086] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"191.180112ms","start":"2026-09-12T01:03:25.469518Z","end":"2026-09-12T01:03:25.660698Z","steps":["trace[1055287086] 'process raft request' (duration: 191.0751ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:25.7791Z","caller":"traceutil/trace.go:171","msg":"trace[721796995] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"107.068146ms","start":"2026-09-12T01:03:25.672004Z","end":"2026-09-12T01:03:25.779072Z","steps":["trace[721796995] 'process raft request' (duration: 78.488917ms)","trace[721796995] 'compare' (duration: 28.366756ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:03:26.294622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.797634ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:03:26.294793Z","caller":"traceutil/trace.go:171","msg":"trace[110978298] linearizableReadLoop","detail":"{readStateIndex:2000; appliedIndex:1999; }","duration":"513.683484ms","start":"2026-09-12T01:03:25.781093Z","end":"2026-09-12T01:03:26.294777Z","steps":["trace[110978298] 'read index received' (duration: 256.638666ms)","trace[110978298] 'applied index is now lower than readState.Index' (duration: 257.043878ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:03:26.294815Z","caller":"traceutil/trace.go:171","msg":"trace[2130038108] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"539.500601ms","start":"2026-09-12T01:03:25.755283Z","end":"2026-09-12T01:03:26.294784Z","steps":["trace[2130038108] 'process raft request' (duration: 282.452073ms)","trace[2130038108] 'compare' (duration: 255.369722ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:03:26.295125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.755259Z","time spent":"539.696215ms","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:03:26.295513Z","caller":"traceutil/trace.go:171","msg":"trace[1562853638] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"418.666652ms","start":"2026-09-12T01:03:25.876831Z","end":"2026-09-12T01:03:26.295497Z","steps":["trace[1562853638] 'process raft request' (duration: 417.891219ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:03:26.295618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.876798Z","time spent":"418.784824ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:03:26.295823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.729219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-09-12T01:03:26.296585Z","caller":"traceutil/trace.go:171","msg":"trace[541934070] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1924; }","duration":"515.499602ms","start":"2026-09-12T01:03:25.78105Z","end":"2026-09-12T01:03:26.296549Z","steps":["trace[541934070] 'agreement among raft nodes before linearized reading' (duration: 513.787006ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:03:26.296657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.781037Z","time spent":"515.601063ms","remote":"127.0.0.1:34546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":443,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-09-12T01:03:26.30556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.195339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-09-12T01:03:26.305587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.666114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7721fe49-39d7-4cb7-b253-ffe7f87bb037\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-09-12T01:03:26.305623Z","caller":"traceutil/trace.go:171","msg":"trace[1300341969] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1925; }","duration":"393.295791ms","start":"2026-09-12T01:03:25.912312Z","end":"2026-09-12T01:03:26.305608Z","steps":["trace[1300341969] 'agreement among raft nodes before linearized reading' (duration: 393.140579ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:26.305634Z","caller":"traceutil/trace.go:171","msg":"trace[795139362] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7721fe49-39d7-4cb7-b253-ffe7f87bb037; range_end:; response_count:1; response_revision:1925; }","duration":"504.737045ms","start":"2026-09-12T01:03:25.800884Z","end":"2026-09-12T01:03:26.305621Z","steps":["trace[795139362] 'agreement among raft nodes before linearized reading' (duration: 504.663124ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:03:26.305657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.912294Z","time spent":"393.354712ms","remote":"127.0.0.1:34638","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-09-12T01:03:26.305665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.800873Z","time spent":"504.784046ms","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3765,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7721fe49-39d7-4cb7-b253-ffe7f87bb037\" "} {"level":"warn","ts":"2026-09-12T01:03:26.305624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.756724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-09-12T01:03:26.305861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.369411ms","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-09-12T01:03:26.305886Z","caller":"traceutil/trace.go:171","msg":"trace[1261782285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1925; }","duration":"391.415511ms","start":"2026-09-12T01:03:25.914463Z","end":"2026-09-12T01:03:26.305878Z","steps":["trace[1261782285] 'agreement among raft nodes before linearized reading' (duration: 391.34027ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:03:26.305911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.914453Z","time spent":"391.453233ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-09-12T01:03:26.305925Z","caller":"traceutil/trace.go:171","msg":"trace[1028581762] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1925; }","duration":"384.076109ms","start":"2026-09-12T01:03:25.921829Z","end":"2026-09-12T01:03:26.305905Z","steps":["trace[1028581762] 'agreement among raft nodes before linearized reading' (duration: 383.649702ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:26.306184Z","caller":"traceutil/trace.go:171","msg":"trace[1469963924] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"124.944735ms","start":"2026-09-12T01:03:26.181229Z","end":"2026-09-12T01:03:26.306174Z","steps":["trace[1469963924] 'process raft request' (duration: 124.044221ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:03:26.306176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:03:25.921819Z","time spent":"384.279153ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-12T01:03:37.926142Z","caller":"traceutil/trace.go:171","msg":"trace[1979892969] transaction","detail":"{read_only:false; response_revision:2022; number_of_response:1; }","duration":"105.389397ms","start":"2026-09-12T01:03:37.820725Z","end":"2026-09-12T01:03:37.926114Z","steps":["trace[1979892969] 'process raft request' (duration: 105.182494ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:37.932754Z","caller":"traceutil/trace.go:171","msg":"trace[1035796722] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"108.476113ms","start":"2026-09-12T01:03:37.82422Z","end":"2026-09-12T01:03:37.932696Z","steps":["trace[1035796722] 'process raft request' (duration: 108.290279ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:52.095337Z","caller":"traceutil/trace.go:171","msg":"trace[2043349432] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"105.548007ms","start":"2026-09-12T01:03:51.989761Z","end":"2026-09-12T01:03:52.095309Z","steps":["trace[2043349432] 'process raft request' (duration: 103.801533ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:52.803612Z","caller":"traceutil/trace.go:171","msg":"trace[459054923] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"252.071232ms","start":"2026-09-12T01:03:52.551499Z","end":"2026-09-12T01:03:52.80357Z","steps":["trace[459054923] 'process raft request' (duration: 251.809958ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:52.82977Z","caller":"traceutil/trace.go:171","msg":"trace[293081780] linearizableReadLoop","detail":"{readStateIndex:2196; appliedIndex:2194; }","duration":"163.732558ms","start":"2026-09-12T01:03:52.666021Z","end":"2026-09-12T01:03:52.829753Z","steps":["trace[293081780] 'read index received' (duration: 137.378651ms)","trace[293081780] 'applied index is now lower than readState.Index' (duration: 26.353147ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:03:52.82995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.911761ms","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-09-12T01:03:52.829986Z","caller":"traceutil/trace.go:171","msg":"trace[1180616301] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2114; }","duration":"163.989182ms","start":"2026-09-12T01:03:52.665985Z","end":"2026-09-12T01:03:52.829974Z","steps":["trace[1180616301] 'agreement among raft nodes before linearized reading' (duration: 163.86079ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:52.830065Z","caller":"traceutil/trace.go:171","msg":"trace[1296489213] transaction","detail":"{read_only:false; response_revision:2114; number_of_response:1; }","duration":"126.870503ms","start":"2026-09-12T01:03:52.703175Z","end":"2026-09-12T01:03:52.830045Z","steps":["trace[1296489213] 'process raft request' (duration: 126.527288ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:52.830065Z","caller":"traceutil/trace.go:171","msg":"trace[1358890642] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"278.33445ms","start":"2026-09-12T01:03:52.551696Z","end":"2026-09-12T01:03:52.830031Z","steps":["trace[1358890642] 'process raft request' (duration: 277.923514ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:03:54.240665Z","caller":"traceutil/trace.go:171","msg":"trace[1166941367] transaction","detail":"{read_only:false; response_revision:2122; number_of_response:1; }","duration":"139.198324ms","start":"2026-09-12T01:03:54.101446Z","end":"2026-09-12T01:03:54.240644Z","steps":["trace[1166941367] 'process raft request' (duration: 139.071672ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:04:04.046503Z","caller":"traceutil/trace.go:171","msg":"trace[204842534] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"241.052606ms","start":"2026-09-12T01:04:03.805426Z","end":"2026-09-12T01:04:04.046479Z","steps":["trace[204842534] 'process raft request' (duration: 240.874973ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:04:04.05622Z","caller":"traceutil/trace.go:171","msg":"trace[1275353749] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"242.588657ms","start":"2026-09-12T01:04:03.813615Z","end":"2026-09-12T01:04:04.056204Z","steps":["trace[1275353749] 'process raft request' (duration: 242.236961ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:04:04.399302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.343487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-12T01:04:04.39936Z","caller":"traceutil/trace.go:171","msg":"trace[446978810] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2179; }","duration":"103.58985ms","start":"2026-09-12T01:04:04.295757Z","end":"2026-09-12T01:04:04.399347Z","steps":["trace[446978810] 'range keys from in-memory index tree' (duration: 102.667538ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:04:04.859796Z","caller":"traceutil/trace.go:171","msg":"trace[471887810] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"226.327549ms","start":"2026-09-12T01:04:04.633442Z","end":"2026-09-12T01:04:04.859769Z","steps":["trace[471887810] 'process raft request' (duration: 226.129026ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:04:05.424349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.554305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.57\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-09-12T01:04:05.424444Z","caller":"traceutil/trace.go:171","msg":"trace[833345628] range","detail":"{range_begin:/registry/masterleases/162.253.55.57; range_end:; response_count:1; response_revision:2185; }","duration":"203.717427ms","start":"2026-09-12T01:04:05.220708Z","end":"2026-09-12T01:04:05.424425Z","steps":["trace[833345628] 'range keys from in-memory index tree' (duration: 203.329663ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:04:05.61923Z","caller":"traceutil/trace.go:171","msg":"trace[64188466] linearizableReadLoop","detail":"{readStateIndex:2271; appliedIndex:2270; }","duration":"184.953354ms","start":"2026-09-12T01:04:05.434241Z","end":"2026-09-12T01:04:05.619194Z","steps":["trace[64188466] 'read index received' (duration: 184.550279ms)","trace[64188466] 'applied index is now lower than readState.Index' (duration: 401.055µs)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:04:05.619428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.196796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T01:04:05.619516Z","caller":"traceutil/trace.go:171","msg":"trace[1151084382] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2185; }","duration":"185.337209ms","start":"2026-09-12T01:04:05.434159Z","end":"2026-09-12T01:04:05.619497Z","steps":["trace[1151084382] 'agreement among raft nodes before linearized reading' (duration: 185.157996ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:04:05.6197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.905891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:04:05.619741Z","caller":"traceutil/trace.go:171","msg":"trace[1564345738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2185; }","duration":"156.177945ms","start":"2026-09-12T01:04:05.463552Z","end":"2026-09-12T01:04:05.61973Z","steps":["trace[1564345738] 'agreement among raft nodes before linearized reading' (duration: 155.923581ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:04:05.876597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.370083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:04:05.876746Z","caller":"traceutil/trace.go:171","msg":"trace[296147730] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"255.82941ms","start":"2026-09-12T01:04:05.620891Z","end":"2026-09-12T01:04:05.87672Z","steps":["trace[296147730] 'process raft request' (duration: 43.242654ms)","trace[296147730] 'compare' (duration: 212.202581ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:04:06.316687Z","caller":"traceutil/trace.go:171","msg":"trace[1789935947] linearizableReadLoop","detail":"{readStateIndex:2274; appliedIndex:2273; }","duration":"245.445441ms","start":"2026-09-12T01:04:06.071219Z","end":"2026-09-12T01:04:06.316664Z","steps":["trace[1789935947] 'read index received' (duration: 4.47579ms)","trace[1789935947] 'applied index is now lower than readState.Index' (duration: 240.968621ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:04:06.317018Z","caller":"traceutil/trace.go:171","msg":"trace[839858363] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"254.663935ms","start":"2026-09-12T01:04:06.062248Z","end":"2026-09-12T01:04:06.316912Z","steps":["trace[839858363] 'process raft request' (duration: 254.202119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:04:06.317231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.989388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-12T01:04:06.317334Z","caller":"traceutil/trace.go:171","msg":"trace[371236149] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2188; }","duration":"246.16569ms","start":"2026-09-12T01:04:06.071145Z","end":"2026-09-12T01:04:06.31731Z","steps":["trace[371236149] 'agreement among raft nodes before linearized reading' (duration: 245.788535ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:04:06.31807Z","caller":"traceutil/trace.go:171","msg":"trace[87602837] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"178.752274ms","start":"2026-09-12T01:04:06.139292Z","end":"2026-09-12T01:04:06.318045Z","steps":["trace[87602837] 'process raft request' (duration: 178.458501ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:05:08.676474Z","caller":"traceutil/trace.go:171","msg":"trace[1308780689] transaction","detail":"{read_only:false; response_revision:2524; number_of_response:1; }","duration":"109.209735ms","start":"2026-09-12T01:05:08.567223Z","end":"2026-09-12T01:05:08.676433Z","steps":["trace[1308780689] 'process raft request' (duration: 92.277969ms)","trace[1308780689] 'compare' (duration: 16.759951ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:05:13.291028Z","caller":"traceutil/trace.go:171","msg":"trace[1838492118] linearizableReadLoop","detail":"{readStateIndex:2654; appliedIndex:2649; }","duration":"101.513841ms","start":"2026-09-12T01:05:13.18949Z","end":"2026-09-12T01:05:13.291004Z","steps":["trace[1838492118] 'read index received' (duration: 19.435392ms)","trace[1838492118] 'applied index is now lower than readState.Index' (duration: 82.077529ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:05:13.291202Z","caller":"traceutil/trace.go:171","msg":"trace[1001143569] transaction","detail":"{read_only:false; response_revision:2553; number_of_response:1; }","duration":"108.538878ms","start":"2026-09-12T01:05:13.1826Z","end":"2026-09-12T01:05:13.291139Z","steps":["trace[1001143569] 'process raft request' (duration: 108.146876ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:05:13.291382Z","caller":"traceutil/trace.go:171","msg":"trace[1552751662] transaction","detail":"{read_only:false; response_revision:2551; number_of_response:1; }","duration":"109.172888ms","start":"2026-09-12T01:05:13.182144Z","end":"2026-09-12T01:05:13.291317Z","steps":["trace[1552751662] 'process raft request' (duration: 26.842541ms)","trace[1552751662] 'compare' (duration: 80.263773ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:05:13.291377Z","caller":"traceutil/trace.go:171","msg":"trace[132012842] transaction","detail":"{read_only:false; response_revision:2552; number_of_response:1; }","duration":"108.799577ms","start":"2026-09-12T01:05:13.182534Z","end":"2026-09-12T01:05:13.291334Z","steps":["trace[132012842] 'process raft request' (duration: 108.111585ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:05:13.291698Z","caller":"traceutil/trace.go:171","msg":"trace[1689594420] transaction","detail":"{read_only:false; response_revision:2555; number_of_response:1; }","duration":"107.813586ms","start":"2026-09-12T01:05:13.183872Z","end":"2026-09-12T01:05:13.291686Z","steps":["trace[1689594420] 'process raft request' (duration: 106.955579ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:05:13.292327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.80144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-12T01:05:13.292583Z","caller":"traceutil/trace.go:171","msg":"trace[761915433] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2556; }","duration":"102.967266ms","start":"2026-09-12T01:05:13.189448Z","end":"2026-09-12T01:05:13.292415Z","steps":["trace[761915433] 'agreement among raft nodes before linearized reading' (duration: 102.764399ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:05:13.296101Z","caller":"traceutil/trace.go:171","msg":"trace[1919989996] transaction","detail":"{read_only:false; response_revision:2554; number_of_response:1; }","duration":"113.273736ms","start":"2026-09-12T01:05:13.182742Z","end":"2026-09-12T01:05:13.296016Z","steps":["trace[1919989996] 'process raft request' (duration: 108.048493ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:05:13.465087Z","caller":"traceutil/trace.go:171","msg":"trace[1629685369] transaction","detail":"{read_only:false; response_revision:2558; number_of_response:1; }","duration":"115.597488ms","start":"2026-09-12T01:05:13.349457Z","end":"2026-09-12T01:05:13.465055Z","steps":["trace[1629685369] 'process raft request' (duration: 57.870291ms)","trace[1629685369] 'compare' (duration: 57.51508ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:05:39.322297Z","caller":"traceutil/trace.go:171","msg":"trace[236786304] transaction","detail":"{read_only:false; response_revision:2781; number_of_response:1; }","duration":"302.724533ms","start":"2026-09-12T01:05:39.019548Z","end":"2026-09-12T01:05:39.322272Z","steps":["trace[236786304] 'process raft request' (duration: 302.580709ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:05:39.322508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:05:39.019523Z","time spent":"302.874908ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:05:39.323851Z","caller":"traceutil/trace.go:171","msg":"trace[39460526] linearizableReadLoop","detail":"{readStateIndex:2888; appliedIndex:2886; }","duration":"137.685052ms","start":"2026-09-12T01:05:39.186144Z","end":"2026-09-12T01:05:39.323829Z","steps":["trace[39460526] 'read index received' (duration: 135.985605ms)","trace[39460526] 'applied index is now lower than readState.Index' (duration: 1.697827ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:05:39.324007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.848737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-12T01:05:39.324034Z","caller":"traceutil/trace.go:171","msg":"trace[931684499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2782; }","duration":"137.916578ms","start":"2026-09-12T01:05:39.18611Z","end":"2026-09-12T01:05:39.324027Z","steps":["trace[931684499] 'agreement among raft nodes before linearized reading' (duration: 137.790524ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:05:39.324235Z","caller":"traceutil/trace.go:171","msg":"trace[1149713467] transaction","detail":"{read_only:false; response_revision:2782; number_of_response:1; }","duration":"228.191775ms","start":"2026-09-12T01:05:39.096035Z","end":"2026-09-12T01:05:39.324227Z","steps":["trace[1149713467] 'process raft request' (duration: 227.68206ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:06:13.10936Z","caller":"traceutil/trace.go:171","msg":"trace[1542624482] transaction","detail":"{read_only:false; response_revision:2971; number_of_response:1; }","duration":"106.029184ms","start":"2026-09-12T01:06:13.003293Z","end":"2026-09-12T01:06:13.109322Z","steps":["trace[1542624482] 'process raft request' (duration: 85.942103ms)","trace[1542624482] 'compare' (duration: 19.717542ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:06:13.598733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.516011ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:06:13.598855Z","caller":"traceutil/trace.go:171","msg":"trace[453565502] transaction","detail":"{read_only:false; response_revision:2972; number_of_response:1; }","duration":"350.149417ms","start":"2026-09-12T01:06:13.248682Z","end":"2026-09-12T01:06:13.598831Z","steps":["trace[453565502] 'process raft request' (duration: 130.438351ms)","trace[453565502] 'compare' (duration: 219.299576ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:06:13.599124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:06:13.248654Z","time spent":"350.434014ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:06:14.018837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.325776ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:06:14.01901Z","caller":"traceutil/trace.go:171","msg":"trace[89364929] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2972; }","duration":"114.508731ms","start":"2026-09-12T01:06:13.904478Z","end":"2026-09-12T01:06:14.018987Z","steps":["trace[89364929] 'range keys from in-memory index tree' (duration: 114.307226ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:06:14.019727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.127415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:06:14.019904Z","caller":"traceutil/trace.go:171","msg":"trace[2097210594] transaction","detail":"{read_only:false; response_revision:2973; number_of_response:1; }","duration":"573.104331ms","start":"2026-09-12T01:06:13.446776Z","end":"2026-09-12T01:06:14.019881Z","steps":["trace[2097210594] 'process raft request' (duration: 354.75411ms)","trace[2097210594] 'compare' (duration: 217.51905ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:06:14.019976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:06:13.44675Z","time spent":"573.184703ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:06:14.020015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.376457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:06:14.020059Z","caller":"traceutil/trace.go:171","msg":"trace[589358560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2973; }","duration":"555.461559ms","start":"2026-09-12T01:06:13.464587Z","end":"2026-09-12T01:06:14.020048Z","steps":["trace[589358560] 'agreement among raft nodes before linearized reading' (duration: 555.391207ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:06:14.02009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:06:13.464564Z","time spent":"555.519071ms","remote":"127.0.0.1:34352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-12T01:06:14.019854Z","caller":"traceutil/trace.go:171","msg":"trace[1541730018] linearizableReadLoop","detail":"{readStateIndex:3086; appliedIndex:3085; }","duration":"555.201673ms","start":"2026-09-12T01:06:13.464633Z","end":"2026-09-12T01:06:14.019835Z","steps":["trace[1541730018] 'read index received' (duration: 336.816961ms)","trace[1541730018] 'applied index is now lower than readState.Index' (duration: 218.383372ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:06:14.020634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.780444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-09-12T01:06:14.020712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.699819ms","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-09-12T01:06:14.020733Z","caller":"traceutil/trace.go:171","msg":"trace[1871222516] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2973; }","duration":"395.774481ms","start":"2026-09-12T01:06:13.624952Z","end":"2026-09-12T01:06:14.020727Z","steps":["trace[1871222516] 'agreement among raft nodes before linearized reading' (duration: 395.72289ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:06:14.020752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:06:13.624921Z","time spent":"395.823702ms","remote":"127.0.0.1:34638","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-09-12T01:06:14.020846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.671987ms","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":"warn","ts":"2026-09-12T01:06:14.020891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.781975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-12T01:06:14.020652Z","caller":"traceutil/trace.go:171","msg":"trace[1032402224] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2973; }","duration":"523.855915ms","start":"2026-09-12T01:06:13.49679Z","end":"2026-09-12T01:06:14.020646Z","steps":["trace[1032402224] 'agreement among raft nodes before linearized reading' (duration: 523.768523ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:06:14.020844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.893307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-09-12T01:06:14.020925Z","caller":"traceutil/trace.go:171","msg":"trace[1896475599] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2973; }","duration":"211.81029ms","start":"2026-09-12T01:06:13.809096Z","end":"2026-09-12T01:06:14.020907Z","steps":["trace[1896475599] 'agreement among raft nodes before linearized reading' (duration: 211.566154ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:06:14.020943Z","caller":"traceutil/trace.go:171","msg":"trace[885721285] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2973; }","duration":"181.853297ms","start":"2026-09-12T01:06:13.839073Z","end":"2026-09-12T01:06:14.020926Z","steps":["trace[885721285] 'agreement among raft nodes before linearized reading' (duration: 181.56752ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:06:14.020933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:06:13.49676Z","time spent":"524.168333ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-09-12T01:06:14.020992Z","caller":"traceutil/trace.go:171","msg":"trace[730377199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2973; }","duration":"204.091302ms","start":"2026-09-12T01:06:13.816876Z","end":"2026-09-12T01:06:14.020967Z","steps":["trace[730377199] 'agreement among raft nodes before linearized reading' (duration: 203.706232ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:33.243999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.507992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60485"} {"level":"info","ts":"2026-09-12T01:10:33.244141Z","caller":"traceutil/trace.go:171","msg":"trace[1809144005] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5017; }","duration":"103.609173ms","start":"2026-09-12T01:10:33.140451Z","end":"2026-09-12T01:10:33.24406Z","steps":["trace[1809144005] 'range keys from in-memory index tree' (duration: 103.104955ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.01756ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:10:40.142229Z","caller":"traceutil/trace.go:171","msg":"trace[1628193624] linearizableReadLoop","detail":"{readStateIndex:5321; appliedIndex:5320; }","duration":"559.090118ms","start":"2026-09-12T01:10:39.583118Z","end":"2026-09-12T01:10:40.142208Z","steps":["trace[1628193624] 'read index received' (duration: 120.778185ms)","trace[1628193624] 'applied index is now lower than readState.Index' (duration: 438.310813ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:10:40.142274Z","caller":"traceutil/trace.go:171","msg":"trace[1765877628] transaction","detail":"{read_only:false; response_revision:5129; number_of_response:1; }","duration":"519.576555ms","start":"2026-09-12T01:10:39.622676Z","end":"2026-09-12T01:10:40.142252Z","steps":["trace[1765877628] 'process raft request' (duration: 519.474064ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.14249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:39.622652Z","time spent":"519.668706ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:10:40.143859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.718473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:61061"} {"level":"info","ts":"2026-09-12T01:10:40.143909Z","caller":"traceutil/trace.go:171","msg":"trace[148235013] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:5129; }","duration":"560.795024ms","start":"2026-09-12T01:10:39.583103Z","end":"2026-09-12T01:10:40.143898Z","steps":["trace[148235013] 'agreement among raft nodes before linearized reading' (duration: 559.20402ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.144189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:39.583096Z","time spent":"560.837714ms","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":6,"response size":61083,"request content":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" "} {"level":"info","ts":"2026-09-12T01:10:40.144168Z","caller":"traceutil/trace.go:171","msg":"trace[1980007976] transaction","detail":"{read_only:false; response_revision:5128; number_of_response:1; }","duration":"561.685828ms","start":"2026-09-12T01:10:39.580474Z","end":"2026-09-12T01:10:40.14216Z","steps":["trace[1980007976] 'process raft request' (duration: 123.410064ms)","trace[1980007976] 'compare' (duration: 437.889748ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:10:40.144716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:39.580452Z","time spent":"564.116704ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":736,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:10:40.148992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.978691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-12T01:10:40.149177Z","caller":"traceutil/trace.go:171","msg":"trace[908763762] transaction","detail":"{read_only:false; response_revision:5130; number_of_response:1; }","duration":"331.373757ms","start":"2026-09-12T01:10:39.817776Z","end":"2026-09-12T01:10:40.14915Z","steps":["trace[908763762] 'process raft request' (duration: 329.939595ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.149257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.854397ms","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-09-12T01:10:40.149319Z","caller":"traceutil/trace.go:171","msg":"trace[2136402111] 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:5133; }","duration":"250.925818ms","start":"2026-09-12T01:10:39.898371Z","end":"2026-09-12T01:10:40.149297Z","steps":["trace[2136402111] 'agreement among raft nodes before linearized reading' (duration: 250.731775ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.149325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:39.817743Z","time spent":"331.524699ms","remote":"127.0.0.1:34440","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-12T01:10:40.149333Z","caller":"traceutil/trace.go:171","msg":"trace[415227875] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5133; }","duration":"502.296845ms","start":"2026-09-12T01:10:39.646947Z","end":"2026-09-12T01:10:40.149243Z","steps":["trace[415227875] 'agreement among raft nodes before linearized reading' (duration: 501.062366ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.149677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:39.646926Z","time spent":"502.730461ms","remote":"127.0.0.1:34470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207433,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"warn","ts":"2026-09-12T01:10:40.14985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.66837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"} {"level":"info","ts":"2026-09-12T01:10:40.149913Z","caller":"traceutil/trace.go:171","msg":"trace[344588943] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:5133; }","duration":"478.754381ms","start":"2026-09-12T01:10:39.671142Z","end":"2026-09-12T01:10:40.149897Z","steps":["trace[344588943] 'agreement among raft nodes before linearized reading' (duration: 478.574088ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.149702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.520573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"warn","ts":"2026-09-12T01:10:40.149954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:39.671097Z","time spent":"478.845503ms","remote":"127.0.0.1:34576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":919,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"info","ts":"2026-09-12T01:10:40.149966Z","caller":"traceutil/trace.go:171","msg":"trace[2037049693] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5133; }","duration":"332.813589ms","start":"2026-09-12T01:10:39.817135Z","end":"2026-09-12T01:10:40.149949Z","steps":["trace[2037049693] 'agreement among raft nodes before linearized reading' (duration: 332.455453ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.150008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:39.817115Z","time spent":"332.88016ms","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":12995,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-09-12T01:10:40.722482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.726914ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-12T01:10:40.722727Z","caller":"traceutil/trace.go:171","msg":"trace[585107337] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"377.480568ms","start":"2026-09-12T01:10:40.345216Z","end":"2026-09-12T01:10:40.722697Z","steps":["trace[585107337] 'process raft request' (duration: 90.459309ms)","trace[585107337] 'compare' (duration: 286.44556ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:10:40.722837Z","caller":"traceutil/trace.go:171","msg":"trace[1968624311] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"261.320264ms","start":"2026-09-12T01:10:40.461498Z","end":"2026-09-12T01:10:40.722818Z","steps":["trace[1968624311] 'process raft request' (duration: 261.078871ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.722919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:40.345196Z","time spent":"377.60267ms","remote":"127.0.0.1:36200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7566,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:10:40.722981Z","caller":"traceutil/trace.go:171","msg":"trace[697350405] linearizableReadLoop","detail":"{readStateIndex:5334; appliedIndex:5332; }","duration":"260.240848ms","start":"2026-09-12T01:10:40.462615Z","end":"2026-09-12T01:10:40.722856Z","steps":["trace[697350405] 'read index received' (duration: 229.030739ms)","trace[697350405] 'applied index is now lower than readState.Index' (duration: 31.207209ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:10:40.750088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.442585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-12T01:10:40.750238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.155556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-08848072-43bb-4eb6-a20f-b84d9686d18a\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-12T01:10:40.750325Z","caller":"traceutil/trace.go:171","msg":"trace[1771098710] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-08848072-43bb-4eb6-a20f-b84d9686d18a; range_end:; response_count:1; response_revision:5141; }","duration":"270.279318ms","start":"2026-09-12T01:10:40.480021Z","end":"2026-09-12T01:10:40.7503Z","steps":["trace[1771098710] 'agreement among raft nodes before linearized reading' (duration: 270.029604ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.750315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.881135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:10:40.750365Z","caller":"traceutil/trace.go:171","msg":"trace[113616314] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5141; }","duration":"287.573558ms","start":"2026-09-12T01:10:40.462574Z","end":"2026-09-12T01:10:40.750148Z","steps":["trace[113616314] 'agreement among raft nodes before linearized reading' (duration: 260.554543ms)","trace[113616314] 'range keys from in-memory index tree' (duration: 26.875123ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:10:40.750405Z","caller":"traceutil/trace.go:171","msg":"trace[1086781303] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:5141; }","duration":"249.013908ms","start":"2026-09-12T01:10:40.501372Z","end":"2026-09-12T01:10:40.750386Z","steps":["trace[1086781303] 'agreement among raft nodes before linearized reading' (duration: 248.845506ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:40.750972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.874005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-12T01:10:40.751074Z","caller":"traceutil/trace.go:171","msg":"trace[751513141] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5141; }","duration":"145.014888ms","start":"2026-09-12T01:10:40.606043Z","end":"2026-09-12T01:10:40.751058Z","steps":["trace[751513141] 'agreement among raft nodes before linearized reading' (duration: 144.107194ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:41.091517Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2793} {"level":"info","ts":"2026-09-12T01:10:41.163666Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2793,"took":"70.735311ms","hash":3882904001,"current-db-size-bytes":51322880,"current-db-size":"51 MB","current-db-size-in-use-bytes":26959872,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-09-12T01:10:41.163736Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3882904001,"revision":2793,"compact-revision":-1} {"level":"info","ts":"2026-09-12T01:10:44.291548Z","caller":"traceutil/trace.go:171","msg":"trace[759165339] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"133.774043ms","start":"2026-09-12T01:10:44.157752Z","end":"2026-09-12T01:10:44.291526Z","steps":["trace[759165339] 'process raft request' (duration: 133.642021ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:44.294808Z","caller":"traceutil/trace.go:171","msg":"trace[1383187926] transaction","detail":"{read_only:false; response_revision:5184; number_of_response:1; }","duration":"134.310991ms","start":"2026-09-12T01:10:44.160476Z","end":"2026-09-12T01:10:44.294787Z","steps":["trace[1383187926] 'process raft request' (duration: 134.150369ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:44.295064Z","caller":"traceutil/trace.go:171","msg":"trace[1389794156] transaction","detail":"{read_only:false; response_revision:5185; number_of_response:1; }","duration":"130.20234ms","start":"2026-09-12T01:10:44.164826Z","end":"2026-09-12T01:10:44.295029Z","steps":["trace[1389794156] 'process raft request' (duration: 129.921656ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:54.553134Z","caller":"traceutil/trace.go:171","msg":"trace[1298186526] transaction","detail":"{read_only:false; response_revision:5310; number_of_response:1; }","duration":"222.839365ms","start":"2026-09-12T01:10:54.330271Z","end":"2026-09-12T01:10:54.553111Z","steps":["trace[1298186526] 'process raft request' (duration: 222.655112ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:54.927352Z","caller":"traceutil/trace.go:171","msg":"trace[1223140016] transaction","detail":"{read_only:false; response_revision:5312; number_of_response:1; }","duration":"591.433348ms","start":"2026-09-12T01:10:54.335897Z","end":"2026-09-12T01:10:54.92733Z","steps":["trace[1223140016] 'process raft request' (duration: 591.351717ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:54.927496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.335886Z","time spent":"591.534619ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:10:54.92755Z","caller":"traceutil/trace.go:171","msg":"trace[1650992589] transaction","detail":"{read_only:false; response_revision:5313; number_of_response:1; }","duration":"590.130799ms","start":"2026-09-12T01:10:54.337402Z","end":"2026-09-12T01:10:54.927533Z","steps":["trace[1650992589] 'process raft request' (duration: 589.882015ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:54.927599Z","caller":"traceutil/trace.go:171","msg":"trace[1352346711] transaction","detail":"{read_only:false; response_revision:5311; number_of_response:1; }","duration":"592.128699ms","start":"2026-09-12T01:10:54.335425Z","end":"2026-09-12T01:10:54.927554Z","steps":["trace[1352346711] 'process raft request' (duration: 591.682873ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:54.927654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.337387Z","time spent":"590.21197ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:10:54.927747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.335411Z","time spent":"592.258431ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:10:54.927939Z","caller":"traceutil/trace.go:171","msg":"trace[456672876] linearizableReadLoop","detail":"{readStateIndex:5513; appliedIndex:5509; }","duration":"479.695315ms","start":"2026-09-12T01:10:54.448236Z","end":"2026-09-12T01:10:54.927932Z","steps":["trace[456672876] 'read index received' (duration: 104.753108ms)","trace[456672876] 'applied index is now lower than readState.Index' (duration: 374.941167ms)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:10:54.927979Z","caller":"traceutil/trace.go:171","msg":"trace[711047865] transaction","detail":"{read_only:false; response_revision:5314; number_of_response:1; }","duration":"434.96805ms","start":"2026-09-12T01:10:54.493006Z","end":"2026-09-12T01:10:54.927974Z","steps":["trace[711047865] 'process raft request' (duration: 434.472213ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:54.92806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.492983Z","time spent":"435.052582ms","remote":"127.0.0.1:34638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:10:54.929298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.046145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-09-12T01:10:54.929397Z","caller":"traceutil/trace.go:171","msg":"trace[1010084715] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5314; }","duration":"481.207408ms","start":"2026-09-12T01:10:54.44817Z","end":"2026-09-12T01:10:54.929377Z","steps":["trace[1010084715] 'agreement among raft nodes before linearized reading' (duration: 479.814657ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:54.929445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.448148Z","time spent":"481.287969ms","remote":"127.0.0.1:53900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3338,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-09-12T01:10:54.945007Z","caller":"traceutil/trace.go:171","msg":"trace[166787117] transaction","detail":"{read_only:false; response_revision:5315; number_of_response:1; }","duration":"383.961263ms","start":"2026-09-12T01:10:54.561018Z","end":"2026-09-12T01:10:54.94498Z","steps":["trace[166787117] 'process raft request' (duration: 383.711648ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:54.945325Z","caller":"traceutil/trace.go:171","msg":"trace[944167760] transaction","detail":"{read_only:false; response_revision:5316; number_of_response:1; }","duration":"383.026978ms","start":"2026-09-12T01:10:54.562283Z","end":"2026-09-12T01:10:54.945309Z","steps":["trace[944167760] 'process raft request' (duration: 382.608692ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:54.945409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.562271Z","time spent":"383.090539ms","remote":"127.0.0.1:34642","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1950,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:10:54.945637Z","caller":"traceutil/trace.go:171","msg":"trace[570394212] transaction","detail":"{read_only:false; response_revision:5317; number_of_response:1; }","duration":"378.903727ms","start":"2026-09-12T01:10:54.566697Z","end":"2026-09-12T01:10:54.945601Z","steps":["trace[570394212] 'process raft request' (duration: 378.607542ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:54.947226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.566669Z","time spent":"380.507291ms","remote":"127.0.0.1:34870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8237,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-12T01:10:54.945776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.051222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-667d4c49c6-hrbfl\" ","response":"range_response_count:1 size:11847"} {"level":"info","ts":"2026-09-12T01:10:54.947437Z","caller":"traceutil/trace.go:171","msg":"trace[1908195920] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-grafana-667d4c49c6-hrbfl; range_end:; response_count:1; response_revision:5317; }","duration":"389.799468ms","start":"2026-09-12T01:10:54.557617Z","end":"2026-09-12T01:10:54.947417Z","steps":["trace[1908195920] 'agreement among raft nodes before linearized reading' (duration: 387.983722ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:54.947484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.557597Z","time spent":"389.872979ms","remote":"127.0.0.1:34560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":11869,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-grafana-667d4c49c6-hrbfl\" "} {"level":"warn","ts":"2026-09-12T01:10:54.945893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.052751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:10:54.947684Z","caller":"traceutil/trace.go:171","msg":"trace[2141503584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5317; }","duration":"483.878888ms","start":"2026-09-12T01:10:54.463796Z","end":"2026-09-12T01:10:54.947674Z","steps":["trace[2141503584] 'agreement among raft nodes before linearized reading' (duration: 482.069051ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:54.947713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.463778Z","time spent":"483.927089ms","remote":"127.0.0.1:34352","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-12T01:10:54.945264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-12T01:10:54.56099Z","time spent":"384.106164ms","remote":"127.0.0.1:34546","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1328,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-12T01:10:55.109783Z","caller":"traceutil/trace.go:171","msg":"trace[1613174124] linearizableReadLoop","detail":"{readStateIndex:5518; appliedIndex:5517; }","duration":"151.346701ms","start":"2026-09-12T01:10:54.95841Z","end":"2026-09-12T01:10:55.109757Z","steps":["trace[1613174124] 'read index received' (duration: 151.031046ms)","trace[1613174124] 'applied index is now lower than readState.Index' (duration: 314.805µs)"],"step_count":2} {"level":"info","ts":"2026-09-12T01:10:55.109825Z","caller":"traceutil/trace.go:171","msg":"trace[1154305979] transaction","detail":"{read_only:false; response_revision:5318; number_of_response:1; }","duration":"152.738871ms","start":"2026-09-12T01:10:54.957057Z","end":"2026-09-12T01:10:55.109796Z","steps":["trace[1154305979] 'process raft request' (duration: 152.474137ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:55.110034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.598934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"} {"level":"info","ts":"2026-09-12T01:10:55.110075Z","caller":"traceutil/trace.go:171","msg":"trace[1941316935] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5318; }","duration":"151.659575ms","start":"2026-09-12T01:10:54.958403Z","end":"2026-09-12T01:10:55.110062Z","steps":["trace[1941316935] 'agreement among raft nodes before linearized reading' (duration: 151.471522ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:55.11014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.653635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18d46d952e7c1b78\" ","response":"range_response_count:1 size:746"} {"level":"info","ts":"2026-09-12T01:10:55.110176Z","caller":"traceutil/trace.go:171","msg":"trace[635211846] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18d46d952e7c1b78; range_end:; response_count:1; response_revision:5318; }","duration":"151.708866ms","start":"2026-09-12T01:10:54.958458Z","end":"2026-09-12T01:10:55.110167Z","steps":["trace[635211846] 'agreement among raft nodes before linearized reading' (duration: 151.554493ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:55.110266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.388025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-12T01:10:55.110347Z","caller":"traceutil/trace.go:171","msg":"trace[1766679796] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5318; }","duration":"117.517988ms","start":"2026-09-12T01:10:54.992806Z","end":"2026-09-12T01:10:55.110324Z","steps":["trace[1766679796] 'agreement among raft nodes before linearized reading' (duration: 117.298513ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:55.262962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.269428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-keystone.18d46d952ed8eb8e\" ","response":"range_response_count:1 size:740"} {"level":"info","ts":"2026-09-12T01:10:55.26305Z","caller":"traceutil/trace.go:171","msg":"trace[841942990] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-keystone.18d46d952ed8eb8e; range_end:; response_count:1; response_revision:5324; }","duration":"120.45003ms","start":"2026-09-12T01:10:55.14257Z","end":"2026-09-12T01:10:55.26302Z","steps":["trace[841942990] 'agreement among raft nodes before linearized reading' (duration: 120.108575ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:55.26308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.06414ms","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-09-12T01:10:55.26317Z","caller":"traceutil/trace.go:171","msg":"trace[280377739] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5324; }","duration":"121.177382ms","start":"2026-09-12T01:10:55.141971Z","end":"2026-09-12T01:10:55.263149Z","steps":["trace[280377739] 'agreement among raft nodes before linearized reading' (duration: 120.886518ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:55.302782Z","caller":"traceutil/trace.go:171","msg":"trace[1849400815] transaction","detail":"{read_only:false; response_revision:5325; number_of_response:1; }","duration":"102.574875ms","start":"2026-09-12T01:10:55.200184Z","end":"2026-09-12T01:10:55.302759Z","steps":["trace[1849400815] 'process raft request' (duration: 102.080708ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:55.30351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.34017ms","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-09-12T01:10:55.303708Z","caller":"traceutil/trace.go:171","msg":"trace[530136029] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5326; }","duration":"112.558194ms","start":"2026-09-12T01:10:55.191055Z","end":"2026-09-12T01:10:55.303613Z","steps":["trace[530136029] 'agreement among raft nodes before linearized reading' (duration: 112.193798ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:10:55.570477Z","caller":"traceutil/trace.go:171","msg":"trace[1642181377] linearizableReadLoop","detail":"{readStateIndex:5528; appliedIndex:5527; }","duration":"228.330245ms","start":"2026-09-12T01:10:55.342128Z","end":"2026-09-12T01:10:55.570458Z","steps":["trace[1642181377] 'read index received' (duration: 169.271707ms)","trace[1642181377] 'applied index is now lower than readState.Index' (duration: 59.057358ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:10:55.570596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.966592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-12T01:10:55.570621Z","caller":"traceutil/trace.go:171","msg":"trace[1736548882] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:5327; }","duration":"239.035323ms","start":"2026-09-12T01:10:55.331576Z","end":"2026-09-12T01:10:55.570611Z","steps":["trace[1736548882] 'agreement among raft nodes before linearized reading' (duration: 238.979192ms)"],"step_count":1} {"level":"warn","ts":"2026-09-12T01:10:55.570822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.812155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9639"} {"level":"info","ts":"2026-09-12T01:10:55.570947Z","caller":"traceutil/trace.go:171","msg":"trace[74968535] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:5327; }","duration":"253.895325ms","start":"2026-09-12T01:10:55.316971Z","end":"2026-09-12T01:10:55.570866Z","steps":["trace[74968535] 'agreement among raft nodes before linearized reading' (duration: 253.716242ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:11:43.534934Z","caller":"traceutil/trace.go:171","msg":"trace[1401779226] transaction","detail":"{read_only:false; response_revision:5710; number_of_response:1; }","duration":"116.467218ms","start":"2026-09-12T01:11:43.418407Z","end":"2026-09-12T01:11:43.534874Z","steps":["trace[1401779226] 'process raft request' (duration: 89.589629ms)","trace[1401779226] 'compare' (duration: 26.062428ms)"],"step_count":2} {"level":"warn","ts":"2026-09-12T01:11:43.536077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.029768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-09-12T01:11:43.536162Z","caller":"traceutil/trace.go:171","msg":"trace[146679664] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5709; }","duration":"193.16933ms","start":"2026-09-12T01:11:43.342974Z","end":"2026-09-12T01:11:43.536143Z","steps":["trace[146679664] 'range keys from in-memory index tree' (duration: 191.228982ms)"],"step_count":1} {"level":"info","ts":"2026-09-12T01:15:41.097596Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5151} {"level":"info","ts":"2026-09-12T01:15:41.177901Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5151,"took":"78.562819ms","hash":2217923052,"current-db-size-bytes":51322880,"current-db-size":"51 MB","current-db-size-in-use-bytes":19525632,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-12T01:15:41.17797Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2217923052,"revision":5151,"compact-revision":2793}