{"level":"warn","ts":"2026-09-07T03:22:01.45386Z","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-07T03:22:01.453987Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.34: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.34:2380","--initial-cluster=instance=https://162.253.55.34:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.34:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.34: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-07T03:22:01.45417Z","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-07T03:22:01.454251Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.34:2380"]} {"level":"info","ts":"2026-09-07T03:22:01.454325Z","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-07T03:22:01.455127Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"]} {"level":"info","ts":"2026-09-07T03:22:01.45532Z","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.34:2380"],"listen-peer-urls":["https://162.253.55.34:2380"],"advertise-client-urls":["https://162.253.55.34:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.34: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-07T03:22:01.460596Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.936289ms"} {"level":"info","ts":"2026-09-07T03:22:01.468355Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ce80082388a7ba5","cluster-id":"32cae298a1245280"} {"level":"info","ts":"2026-09-07T03:22:01.468449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T03:22:01.46847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became follower at term 0"} {"level":"info","ts":"2026-09-07T03:22:01.468479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ce80082388a7ba5 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T03:22:01.468489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became follower at term 1"} {"level":"info","ts":"2026-09-07T03:22:01.468552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 switched to configuration voters=(4388758396166896549)"} {"level":"warn","ts":"2026-09-07T03:22:01.474849Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T03:22:01.47617Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T03:22:01.477307Z","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-07T03:22:01.479331Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ce80082388a7ba5","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T03:22:01.480391Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ce80082388a7ba5","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T03:22:01.482123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 switched to configuration voters=(4388758396166896549)"} {"level":"info","ts":"2026-09-07T03:22:01.482128Z","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-07T03:22:01.482203Z","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-07T03:22:01.482225Z","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-07T03:22:01.482431Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"32cae298a1245280","local-member-id":"3ce80082388a7ba5","added-peer-id":"3ce80082388a7ba5","added-peer-peer-urls":["https://162.253.55.34:2380"]} {"level":"info","ts":"2026-09-07T03:22:01.483733Z","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-07T03:22:01.483765Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.34:2380"} {"level":"info","ts":"2026-09-07T03:22:01.483825Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.34:2380"} {"level":"info","ts":"2026-09-07T03:22:01.484135Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ce80082388a7ba5","initial-advertise-peer-urls":["https://162.253.55.34:2380"],"listen-peer-urls":["https://162.253.55.34:2380"],"advertise-client-urls":["https://162.253.55.34:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.34:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T03:22:01.484186Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T03:22:02.269397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T03:22:02.269453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T03:22:02.269496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 received MsgPreVoteResp from 3ce80082388a7ba5 at term 1"} {"level":"info","ts":"2026-09-07T03:22:02.269513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became candidate at term 2"} {"level":"info","ts":"2026-09-07T03:22:02.269524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 received MsgVoteResp from 3ce80082388a7ba5 at term 2"} {"level":"info","ts":"2026-09-07T03:22:02.269539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ce80082388a7ba5 became leader at term 2"} {"level":"info","ts":"2026-09-07T03:22:02.269552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ce80082388a7ba5 elected leader 3ce80082388a7ba5 at term 2"} {"level":"info","ts":"2026-09-07T03:22:02.271013Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ce80082388a7ba5","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.34:2379]}","request-path":"/0/members/3ce80082388a7ba5/attributes","cluster-id":"32cae298a1245280","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T03:22:02.27106Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T03:22:02.271074Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:22:02.271023Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T03:22:02.272408Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"32cae298a1245280","local-member-id":"3ce80082388a7ba5","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:22:02.272492Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:22:02.272518Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T03:22:02.272667Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.34:2379"} {"level":"info","ts":"2026-09-07T03:22:02.273926Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T03:22:02.277315Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T03:22:02.277442Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T03:22:16.471649Z","caller":"traceutil/trace.go:171","msg":"trace[630254443] linearizableReadLoop","detail":"{readStateIndex:370; appliedIndex:369; }","duration":"136.443242ms","start":"2026-09-07T03:22:16.335166Z","end":"2026-09-07T03:22:16.47161Z","steps":["trace[630254443] 'read index received' (duration: 136.093352ms)","trace[630254443] 'applied index is now lower than readState.Index' (duration: 348.35µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:22:16.471993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.720562ms","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-07T03:22:16.472064Z","caller":"traceutil/trace.go:171","msg":"trace[1765084202] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:359; }","duration":"136.936068ms","start":"2026-09-07T03:22:16.335108Z","end":"2026-09-07T03:22:16.472044Z","steps":["trace[1765084202] 'agreement among raft nodes before linearized reading' (duration: 136.67288ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:16.472652Z","caller":"traceutil/trace.go:171","msg":"trace[1761187415] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"192.340089ms","start":"2026-09-07T03:22:16.280292Z","end":"2026-09-07T03:22:16.472632Z","steps":["trace[1761187415] 'process raft request' (duration: 191.10982ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:22:16.715935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.040341ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:22:16.716079Z","caller":"traceutil/trace.go:171","msg":"trace[2072102954] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:370; }","duration":"238.447976ms","start":"2026-09-07T03:22:16.477615Z","end":"2026-09-07T03:22:16.716063Z","steps":["trace[2072102954] 'read index received' (duration: 137.499155ms)","trace[2072102954] 'applied index is now lower than readState.Index' (duration: 100.947581ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:22:16.716176Z","caller":"traceutil/trace.go:171","msg":"trace[452499762] transaction","detail":"{read_only:false; response_revision:360; number_of_response:1; }","duration":"239.567052ms","start":"2026-09-07T03:22:16.476557Z","end":"2026-09-07T03:22:16.716124Z","steps":["trace[452499762] 'process raft request' (duration: 138.509368ms)","trace[452499762] 'compare' (duration: 99.901087ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:22:16.716246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.632782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6961"} {"level":"info","ts":"2026-09-07T03:22:16.716282Z","caller":"traceutil/trace.go:171","msg":"trace[976908992] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:360; }","duration":"238.699904ms","start":"2026-09-07T03:22:16.477571Z","end":"2026-09-07T03:22:16.71627Z","steps":["trace[976908992] 'agreement among raft nodes before linearized reading' (duration: 238.616992ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.016009Z","caller":"traceutil/trace.go:171","msg":"trace[690121691] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"127.93816ms","start":"2026-09-07T03:22:39.888045Z","end":"2026-09-07T03:22:40.015983Z","steps":["trace[690121691] 'process raft request' (duration: 124.235163ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.016199Z","caller":"traceutil/trace.go:171","msg":"trace[1283198018] transaction","detail":"{read_only:false; number_of_response:1; response_revision:490; }","duration":"124.385997ms","start":"2026-09-07T03:22:39.89178Z","end":"2026-09-07T03:22:40.016166Z","steps":["trace[1283198018] 'process raft request' (duration: 124.302415ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.016271Z","caller":"traceutil/trace.go:171","msg":"trace[1080251381] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"124.531771ms","start":"2026-09-07T03:22:39.891714Z","end":"2026-09-07T03:22:40.016246Z","steps":["trace[1080251381] 'process raft request' (duration: 124.307665ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.016269Z","caller":"traceutil/trace.go:171","msg":"trace[1577887042] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"124.5285ms","start":"2026-09-07T03:22:39.891653Z","end":"2026-09-07T03:22:40.016182Z","steps":["trace[1577887042] 'process raft request' (duration: 124.287664ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.020768Z","caller":"traceutil/trace.go:171","msg":"trace[1065088529] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"124.960452ms","start":"2026-09-07T03:22:39.895789Z","end":"2026-09-07T03:22:40.020749Z","steps":["trace[1065088529] 'process raft request' (duration: 124.688794ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.020938Z","caller":"traceutil/trace.go:171","msg":"trace[1478447257] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"120.952246ms","start":"2026-09-07T03:22:39.899977Z","end":"2026-09-07T03:22:40.020929Z","steps":["trace[1478447257] 'process raft request' (duration: 120.717518ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.021529Z","caller":"traceutil/trace.go:171","msg":"trace[499314221] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"117.892184ms","start":"2026-09-07T03:22:39.903627Z","end":"2026-09-07T03:22:40.021519Z","steps":["trace[499314221] 'process raft request' (duration: 117.174335ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.021691Z","caller":"traceutil/trace.go:171","msg":"trace[1550744711] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"113.96908ms","start":"2026-09-07T03:22:39.907711Z","end":"2026-09-07T03:22:40.02168Z","steps":["trace[1550744711] 'process raft request' (duration: 113.359234ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.0218Z","caller":"traceutil/trace.go:171","msg":"trace[243882724] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"118.022078ms","start":"2026-09-07T03:22:39.903769Z","end":"2026-09-07T03:22:40.021791Z","steps":["trace[243882724] 'process raft request' (duration: 117.115274ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:40.021965Z","caller":"traceutil/trace.go:171","msg":"trace[1539746094] linearizableReadLoop","detail":"{readStateIndex:512; appliedIndex:503; }","duration":"108.008463ms","start":"2026-09-07T03:22:39.913908Z","end":"2026-09-07T03:22:40.021917Z","steps":["trace[1539746094] 'read index received' (duration: 98.454793ms)","trace[1539746094] 'applied index is now lower than readState.Index' (duration: 9.55221ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:22:40.022296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.325732ms","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-07T03:22:40.022652Z","caller":"traceutil/trace.go:171","msg":"trace[1966815926] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:499; }","duration":"108.470765ms","start":"2026-09-07T03:22:39.913878Z","end":"2026-09-07T03:22:40.022348Z","steps":["trace[1966815926] 'agreement among raft nodes before linearized reading' (duration: 108.188177ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:46.798018Z","caller":"traceutil/trace.go:171","msg":"trace[184975012] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"202.975166ms","start":"2026-09-07T03:22:46.595014Z","end":"2026-09-07T03:22:46.797989Z","steps":["trace[184975012] 'process raft request' (duration: 202.37782ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:47.264805Z","caller":"traceutil/trace.go:171","msg":"trace[544453046] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"316.023832ms","start":"2026-09-07T03:22:46.948762Z","end":"2026-09-07T03:22:47.264786Z","steps":["trace[544453046] 'read index received' (duration: 315.884418ms)","trace[544453046] 'applied index is now lower than readState.Index' (duration: 138.764µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:22:47.264886Z","caller":"traceutil/trace.go:171","msg":"trace[472701586] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"376.934157ms","start":"2026-09-07T03:22:46.887945Z","end":"2026-09-07T03:22:47.264879Z","steps":["trace[472701586] 'process raft request' (duration: 376.735532ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:22:47.264966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:22:46.88792Z","time spent":"376.991889ms","remote":"127.0.0.1:52022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T03:22:47.265136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.617492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dw2nr\" ","response":"range_response_count:1 size:16961"} {"level":"warn","ts":"2026-09-07T03:22:47.265166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.530322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-09-07T03:22:47.265197Z","caller":"traceutil/trace.go:171","msg":"trace[655476437] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dw2nr; range_end:; response_count:1; response_revision:586; }","duration":"290.755765ms","start":"2026-09-07T03:22:46.974422Z","end":"2026-09-07T03:22:47.265177Z","steps":["trace[655476437] 'agreement among raft nodes before linearized reading' (duration: 290.495088ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:47.265222Z","caller":"traceutil/trace.go:171","msg":"trace[1813732727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:586; }","duration":"220.622475ms","start":"2026-09-07T03:22:47.044584Z","end":"2026-09-07T03:22:47.265206Z","steps":["trace[1813732727] 'agreement among raft nodes before linearized reading' (duration: 220.415059ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:22:47.265371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.566496ms","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-07T03:22:47.265473Z","caller":"traceutil/trace.go:171","msg":"trace[1641388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:586; }","duration":"316.74076ms","start":"2026-09-07T03:22:46.948709Z","end":"2026-09-07T03:22:47.26545Z","steps":["trace[1641388] 'agreement among raft nodes before linearized reading' (duration: 316.383721ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:22:47.265539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:22:46.948683Z","time spent":"316.847293ms","remote":"127.0.0.1:51974","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-07T03:22:47.421845Z","caller":"traceutil/trace.go:171","msg":"trace[390198898] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"151.79451ms","start":"2026-09-07T03:22:47.270003Z","end":"2026-09-07T03:22:47.421798Z","steps":["trace[390198898] 'process raft request' (duration: 123.512522ms)","trace[390198898] 'compare' (duration: 28.076233ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:22:47.425529Z","caller":"traceutil/trace.go:171","msg":"trace[1573288759] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"150.417385ms","start":"2026-09-07T03:22:47.275089Z","end":"2026-09-07T03:22:47.425507Z","steps":["trace[1573288759] 'process raft request' (duration: 150.1809ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:47.425784Z","caller":"traceutil/trace.go:171","msg":"trace[1389516216] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"146.893518ms","start":"2026-09-07T03:22:47.278869Z","end":"2026-09-07T03:22:47.425762Z","steps":["trace[1389516216] 'read index received' (duration: 114.66092ms)","trace[1389516216] 'applied index is now lower than readState.Index' (duration: 32.230888ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:22:47.425982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.081863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:22:47.425924Z","caller":"traceutil/trace.go:171","msg":"trace[1025149890] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"140.287222ms","start":"2026-09-07T03:22:47.285577Z","end":"2026-09-07T03:22:47.425865Z","steps":["trace[1025149890] 'process raft request' (duration: 139.818481ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:22:47.426037Z","caller":"traceutil/trace.go:171","msg":"trace[1064049988] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:589; }","duration":"147.197546ms","start":"2026-09-07T03:22:47.278819Z","end":"2026-09-07T03:22:47.426017Z","steps":["trace[1064049988] 'agreement among raft nodes before linearized reading' (duration: 147.004151ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:23:32.496129Z","caller":"traceutil/trace.go:171","msg":"trace[913136967] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"133.306501ms","start":"2026-09-07T03:23:32.362803Z","end":"2026-09-07T03:23:32.496109Z","steps":["trace[913136967] 'process raft request' (duration: 133.180699ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:23:56.726116Z","caller":"traceutil/trace.go:171","msg":"trace[1754401522] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"135.572288ms","start":"2026-09-07T03:23:56.590515Z","end":"2026-09-07T03:23:56.726087Z","steps":["trace[1754401522] 'process raft request' (duration: 134.894605ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:24:24.379146Z","caller":"traceutil/trace.go:171","msg":"trace[388526750] linearizableReadLoop","detail":"{readStateIndex:1909; appliedIndex:1908; }","duration":"163.821074ms","start":"2026-09-07T03:24:24.215298Z","end":"2026-09-07T03:24:24.379119Z","steps":["trace[388526750] 'read index received' (duration: 163.490599ms)","trace[388526750] 'applied index is now lower than readState.Index' (duration: 329.265µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:24:24.379422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.051108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/default\" ","response":"range_response_count:1 size:175"} {"level":"info","ts":"2026-09-07T03:24:24.379467Z","caller":"traceutil/trace.go:171","msg":"trace[517052109] range","detail":"{range_begin:/registry/serviceaccounts/openstack/default; range_end:; response_count:1; response_revision:1840; }","duration":"164.19885ms","start":"2026-09-07T03:24:24.215257Z","end":"2026-09-07T03:24:24.379456Z","steps":["trace[517052109] 'agreement among raft nodes before linearized reading' (duration: 163.955266ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:24:24.380183Z","caller":"traceutil/trace.go:171","msg":"trace[458142206] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"175.457541ms","start":"2026-09-07T03:24:24.204701Z","end":"2026-09-07T03:24:24.380159Z","steps":["trace[458142206] 'process raft request' (duration: 174.21662ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:24:26.221662Z","caller":"traceutil/trace.go:171","msg":"trace[150323859] linearizableReadLoop","detail":"{readStateIndex:1929; appliedIndex:1928; }","duration":"226.545196ms","start":"2026-09-07T03:24:25.995095Z","end":"2026-09-07T03:24:26.22164Z","steps":["trace[150323859] 'read index received' (duration: 226.432295ms)","trace[150323859] 'applied index is now lower than readState.Index' (duration: 111.461µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:24:26.221863Z","caller":"traceutil/trace.go:171","msg":"trace[1094721217] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"227.885749ms","start":"2026-09-07T03:24:25.993892Z","end":"2026-09-07T03:24:26.221778Z","steps":["trace[1094721217] 'process raft request' (duration: 227.600334ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:24:26.222059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.169448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-07T03:24:26.22216Z","caller":"traceutil/trace.go:171","msg":"trace[764455101] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1859; }","duration":"217.32245ms","start":"2026-09-07T03:24:26.00481Z","end":"2026-09-07T03:24:26.222132Z","steps":["trace[764455101] 'agreement among raft nodes before linearized reading' (duration: 217.007605ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:24:26.222397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.306399ms","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-07T03:24:26.222441Z","caller":"traceutil/trace.go:171","msg":"trace[1474753001] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1859; }","duration":"227.3488ms","start":"2026-09-07T03:24:25.995081Z","end":"2026-09-07T03:24:26.22243Z","steps":["trace[1474753001] 'agreement among raft nodes before linearized reading' (duration: 227.242727ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:24:26.751646Z","caller":"traceutil/trace.go:171","msg":"trace[25894760] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"292.095067ms","start":"2026-09-07T03:24:26.459523Z","end":"2026-09-07T03:24:26.751618Z","steps":["trace[25894760] 'process raft request' (duration: 291.904043ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:24:26.751983Z","caller":"traceutil/trace.go:171","msg":"trace[279776655] linearizableReadLoop","detail":"{readStateIndex:1933; appliedIndex:1931; }","duration":"270.865902ms","start":"2026-09-07T03:24:26.481097Z","end":"2026-09-07T03:24:26.751963Z","steps":["trace[279776655] 'read index received' (duration: 270.080408ms)","trace[279776655] 'applied index is now lower than readState.Index' (duration: 783.313µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:24:26.752033Z","caller":"traceutil/trace.go:171","msg":"trace[943438326] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"292.476453ms","start":"2026-09-07T03:24:26.459524Z","end":"2026-09-07T03:24:26.752001Z","steps":["trace[943438326] 'process raft request' (duration: 292.046805ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:24:26.75253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.40986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cf5e630e-eae4-4038-a90b-1732c95296e1\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-07T03:24:26.752593Z","caller":"traceutil/trace.go:171","msg":"trace[681349880] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cf5e630e-eae4-4038-a90b-1732c95296e1; range_end:; response_count:1; response_revision:1863; }","duration":"271.512881ms","start":"2026-09-07T03:24:26.481065Z","end":"2026-09-07T03:24:26.752577Z","steps":["trace[681349880] 'agreement among raft nodes before linearized reading' (duration: 270.968683ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:24:43.451802Z","caller":"traceutil/trace.go:171","msg":"trace[624756535] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"142.463791ms","start":"2026-09-07T03:24:43.309285Z","end":"2026-09-07T03:24:43.451749Z","steps":["trace[624756535] 'process raft request' (duration: 142.050464ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:25:01.422052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.884261ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:25:01.422125Z","caller":"traceutil/trace.go:171","msg":"trace[1983665271] linearizableReadLoop","detail":"{readStateIndex:2185; appliedIndex:2184; }","duration":"273.076804ms","start":"2026-09-07T03:25:01.149036Z","end":"2026-09-07T03:25:01.422113Z","steps":["trace[1983665271] 'read index received' (duration: 138.064261ms)","trace[1983665271] 'applied index is now lower than readState.Index' (duration: 135.011233ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:25:01.42219Z","caller":"traceutil/trace.go:171","msg":"trace[1748695776] transaction","detail":"{read_only:false; response_revision:2108; number_of_response:1; }","duration":"310.161983ms","start":"2026-09-07T03:25:01.112017Z","end":"2026-09-07T03:25:01.422179Z","steps":["trace[1748695776] 'process raft request' (duration: 175.093319ms)","trace[1748695776] 'compare' (duration: 134.8097ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:25:01.422242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:25:01.111998Z","time spent":"310.217703ms","remote":"127.0.0.1:51974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T03:25:01.422461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.432599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-07T03:25:01.422489Z","caller":"traceutil/trace.go:171","msg":"trace[106634710] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2108; }","duration":"273.460249ms","start":"2026-09-07T03:25:01.14902Z","end":"2026-09-07T03:25:01.42248Z","steps":["trace[106634710] 'agreement among raft nodes before linearized reading' (duration: 273.369648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:25:01.422572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.800198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-07T03:25:01.422686Z","caller":"traceutil/trace.go:171","msg":"trace[849797557] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:2108; }","duration":"219.961061ms","start":"2026-09-07T03:25:01.202707Z","end":"2026-09-07T03:25:01.422668Z","steps":["trace[849797557] 'agreement among raft nodes before linearized reading' (duration: 219.762398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:25:01.422791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.458613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:570"} {"level":"info","ts":"2026-09-07T03:25:01.422821Z","caller":"traceutil/trace.go:171","msg":"trace[1366845038] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2108; }","duration":"214.522174ms","start":"2026-09-07T03:25:01.208292Z","end":"2026-09-07T03:25:01.422814Z","steps":["trace[1366845038] 'agreement among raft nodes before linearized reading' (duration: 214.448333ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:25:01.692874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.371701ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:25:01.692989Z","caller":"traceutil/trace.go:171","msg":"trace[550257725] linearizableReadLoop","detail":"{readStateIndex:2188; appliedIndex:2187; }","duration":"120.289999ms","start":"2026-09-07T03:25:01.572684Z","end":"2026-09-07T03:25:01.692974Z","steps":["trace[550257725] 'read index received' (duration: 57.001µs)","trace[550257725] 'applied index is now lower than readState.Index' (duration: 120.231498ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:25:01.693107Z","caller":"traceutil/trace.go:171","msg":"trace[2052646206] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"179.176404ms","start":"2026-09-07T03:25:01.51391Z","end":"2026-09-07T03:25:01.693086Z","steps":["trace[2052646206] 'process raft request' (duration: 12.495978ms)","trace[2052646206] 'compare' (duration: 166.009845ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:25:01.69359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.891989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-07T03:25:01.693774Z","caller":"traceutil/trace.go:171","msg":"trace[1481961883] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2111; }","duration":"121.064352ms","start":"2026-09-07T03:25:01.572635Z","end":"2026-09-07T03:25:01.6937Z","steps":["trace[1481961883] 'agreement among raft nodes before linearized reading' (duration: 120.840768ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:25:02.632707Z","caller":"traceutil/trace.go:171","msg":"trace[274350358] linearizableReadLoop","detail":"{readStateIndex:2190; appliedIndex:2189; }","duration":"145.367003ms","start":"2026-09-07T03:25:02.487317Z","end":"2026-09-07T03:25:02.632684Z","steps":["trace[274350358] 'read index received' (duration: 145.15906ms)","trace[274350358] 'applied index is now lower than readState.Index' (duration: 206.953µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:25:02.63283Z","caller":"traceutil/trace.go:171","msg":"trace[199123350] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"203.905782ms","start":"2026-09-07T03:25:02.428893Z","end":"2026-09-07T03:25:02.632799Z","steps":["trace[199123350] 'process raft request' (duration: 203.590776ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:25:02.632889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.558187ms","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-07T03:25:02.632923Z","caller":"traceutil/trace.go:171","msg":"trace[1743321278] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2113; }","duration":"145.646669ms","start":"2026-09-07T03:25:02.487266Z","end":"2026-09-07T03:25:02.632913Z","steps":["trace[1743321278] 'agreement among raft nodes before linearized reading' (duration: 145.508487ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:26:14.29359Z","caller":"traceutil/trace.go:171","msg":"trace[32848139] linearizableReadLoop","detail":"{readStateIndex:2691; appliedIndex:2690; }","duration":"173.155338ms","start":"2026-09-07T03:26:14.12041Z","end":"2026-09-07T03:26:14.293565Z","steps":["trace[32848139] 'read index received' (duration: 168.324657ms)","trace[32848139] 'applied index is now lower than readState.Index' (duration: 4.829521ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:26:14.293692Z","caller":"traceutil/trace.go:171","msg":"trace[40625934] transaction","detail":"{read_only:false; response_revision:2597; number_of_response:1; }","duration":"263.86345ms","start":"2026-09-07T03:26:14.029796Z","end":"2026-09-07T03:26:14.29366Z","steps":["trace[40625934] 'process raft request' (duration: 259.044939ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:14.293859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.425888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-07T03:26:14.293922Z","caller":"traceutil/trace.go:171","msg":"trace[1127132564] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2597; }","duration":"173.534152ms","start":"2026-09-07T03:26:14.120369Z","end":"2026-09-07T03:26:14.293903Z","steps":["trace[1127132564] 'agreement among raft nodes before linearized reading' (duration: 173.317154ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:14.298252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.21628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:26:14.298345Z","caller":"traceutil/trace.go:171","msg":"trace[919032411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2598; }","duration":"153.353706ms","start":"2026-09-07T03:26:14.144968Z","end":"2026-09-07T03:26:14.298322Z","steps":["trace[919032411] 'agreement among raft nodes before linearized reading' (duration: 153.185379ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:26:51.688266Z","caller":"traceutil/trace.go:171","msg":"trace[415114296] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"176.755349ms","start":"2026-09-07T03:26:51.511496Z","end":"2026-09-07T03:26:51.688251Z","steps":["trace[415114296] 'process raft request' (duration: 176.702887ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:26:51.688272Z","caller":"traceutil/trace.go:171","msg":"trace[532059184] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"249.537547ms","start":"2026-09-07T03:26:51.438704Z","end":"2026-09-07T03:26:51.688241Z","steps":["trace[532059184] 'process raft request' (duration: 201.15322ms)","trace[532059184] 'compare' (duration: 48.058656ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:26:51.688386Z","caller":"traceutil/trace.go:171","msg":"trace[1152914430] linearizableReadLoop","detail":"{readStateIndex:2900; appliedIndex:2899; }","duration":"187.65534ms","start":"2026-09-07T03:26:51.500713Z","end":"2026-09-07T03:26:51.688368Z","steps":["trace[1152914430] 'read index received' (duration: 139.152349ms)","trace[1152914430] 'applied index is now lower than readState.Index' (duration: 48.501661ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:26:51.68856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.417681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1366"} {"level":"info","ts":"2026-09-07T03:26:51.688588Z","caller":"traceutil/trace.go:171","msg":"trace[1122263039] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2799; }","duration":"140.486594ms","start":"2026-09-07T03:26:51.548094Z","end":"2026-09-07T03:26:51.68858Z","steps":["trace[1122263039] 'agreement among raft nodes before linearized reading' (duration: 140.38638ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:51.688597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.829776ms","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-07T03:26:51.68866Z","caller":"traceutil/trace.go:171","msg":"trace[1578969312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2799; }","duration":"187.981232ms","start":"2026-09-07T03:26:51.500663Z","end":"2026-09-07T03:26:51.688644Z","steps":["trace[1578969312] 'agreement among raft nodes before linearized reading' (duration: 187.772535ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:26:51.689153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.393771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:26:51.689237Z","caller":"traceutil/trace.go:171","msg":"trace[993821244] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2799; }","duration":"125.488014ms","start":"2026-09-07T03:26:51.563728Z","end":"2026-09-07T03:26:51.689216Z","steps":["trace[993821244] 'agreement among raft nodes before linearized reading' (duration: 125.324118ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:17.635957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.305295ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:31:17.636122Z","caller":"traceutil/trace.go:171","msg":"trace[1524205097] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"145.840624ms","start":"2026-09-07T03:31:17.490261Z","end":"2026-09-07T03:31:17.636101Z","steps":["trace[1524205097] 'process raft request' (duration: 14.297475ms)","trace[1524205097] 'compare' (duration: 131.156841ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:31:23.060945Z","caller":"traceutil/trace.go:171","msg":"trace[287786176] linearizableReadLoop","detail":"{readStateIndex:5153; appliedIndex:5152; }","duration":"138.727961ms","start":"2026-09-07T03:31:22.922194Z","end":"2026-09-07T03:31:23.060922Z","steps":["trace[287786176] 'read index received' (duration: 138.455196ms)","trace[287786176] 'applied index is now lower than readState.Index' (duration: 271.295µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:31:23.061058Z","caller":"traceutil/trace.go:171","msg":"trace[1262403029] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"258.991387ms","start":"2026-09-07T03:31:22.801996Z","end":"2026-09-07T03:31:23.060988Z","steps":["trace[1262403029] 'process raft request' (duration: 258.728972ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:23.061171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.956086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-09-07T03:31:23.061205Z","caller":"traceutil/trace.go:171","msg":"trace[162451601] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4968; }","duration":"139.048697ms","start":"2026-09-07T03:31:22.922145Z","end":"2026-09-07T03:31:23.061194Z","steps":["trace[162451601] 'agreement among raft nodes before linearized reading' (duration: 138.895544ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:23.061614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.495ms","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-07T03:31:23.061687Z","caller":"traceutil/trace.go:171","msg":"trace[1973261181] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4968; }","duration":"124.618001ms","start":"2026-09-07T03:31:22.937053Z","end":"2026-09-07T03:31:23.061671Z","steps":["trace[1973261181] 'agreement among raft nodes before linearized reading' (duration: 124.039309ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:27.358981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.086076ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:31:27.359453Z","caller":"traceutil/trace.go:171","msg":"trace[1330243682] linearizableReadLoop","detail":"{readStateIndex:5231; appliedIndex:5230; }","duration":"154.540715ms","start":"2026-09-07T03:31:27.204888Z","end":"2026-09-07T03:31:27.359429Z","steps":["trace[1330243682] 'read index received' (duration: 42.911289ms)","trace[1330243682] 'applied index is now lower than readState.Index' (duration: 111.626856ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:31:27.359524Z","caller":"traceutil/trace.go:171","msg":"trace[2111810265] transaction","detail":"{read_only:false; response_revision:5044; number_of_response:1; }","duration":"157.796048ms","start":"2026-09-07T03:31:27.201702Z","end":"2026-09-07T03:31:27.359498Z","steps":["trace[2111810265] 'process raft request' (duration: 46.126551ms)","trace[2111810265] 'compare' (duration: 110.952213ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:31:27.35959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.696958ms","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-07T03:31:27.359626Z","caller":"traceutil/trace.go:171","msg":"trace[1558213231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5045; }","duration":"154.747908ms","start":"2026-09-07T03:31:27.204869Z","end":"2026-09-07T03:31:27.359617Z","steps":["trace[1558213231] 'agreement among raft nodes before linearized reading' (duration: 154.651796ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:27.359626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.508064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T03:31:27.359686Z","caller":"traceutil/trace.go:171","msg":"trace[1573288139] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:5045; }","duration":"112.680457ms","start":"2026-09-07T03:31:27.246989Z","end":"2026-09-07T03:31:27.359669Z","steps":["trace[1573288139] 'agreement among raft nodes before linearized reading' (duration: 112.577885ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:37.377312Z","caller":"traceutil/trace.go:171","msg":"trace[1573446500] transaction","detail":"{read_only:false; response_revision:5139; number_of_response:1; }","duration":"437.212751ms","start":"2026-09-07T03:31:36.940073Z","end":"2026-09-07T03:31:37.377286Z","steps":["trace[1573446500] 'process raft request' (duration: 437.064998ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.377523Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:31:36.940057Z","time spent":"437.335453ms","remote":"127.0.0.1:51900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11654,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:31:37.43165Z","caller":"traceutil/trace.go:171","msg":"trace[1261618443] linearizableReadLoop","detail":"{readStateIndex:5332; appliedIndex:5330; }","duration":"276.086088ms","start":"2026-09-07T03:31:37.15554Z","end":"2026-09-07T03:31:37.431626Z","steps":["trace[1261618443] 'read index received' (duration: 221.67179ms)","trace[1261618443] 'applied index is now lower than readState.Index' (duration: 54.413268ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:31:37.431996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.430965ms","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-07T03:31:37.432048Z","caller":"traceutil/trace.go:171","msg":"trace[2012024868] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5141; }","duration":"276.544307ms","start":"2026-09-07T03:31:37.155491Z","end":"2026-09-07T03:31:37.432036Z","steps":["trace[2012024868] 'agreement among raft nodes before linearized reading' (duration: 276.299302ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:37.432395Z","caller":"traceutil/trace.go:171","msg":"trace[1957440370] transaction","detail":"{read_only:false; response_revision:5140; number_of_response:1; }","duration":"326.232803ms","start":"2026-09-07T03:31:37.10615Z","end":"2026-09-07T03:31:37.432383Z","steps":["trace[1957440370] 'process raft request' (duration: 325.324705ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.432504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:31:37.106117Z","time spent":"326.317764ms","remote":"127.0.0.1:51974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:31:37.432648Z","caller":"traceutil/trace.go:171","msg":"trace[993640125] transaction","detail":"{read_only:false; response_revision:5141; number_of_response:1; }","duration":"260.631394ms","start":"2026-09-07T03:31:37.172006Z","end":"2026-09-07T03:31:37.432638Z","steps":["trace[993640125] 'process raft request' (duration: 259.578134ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:37.5245Z","caller":"traceutil/trace.go:171","msg":"trace[280757065] transaction","detail":"{read_only:false; response_revision:5142; number_of_response:1; }","duration":"138.704742ms","start":"2026-09-07T03:31:37.385752Z","end":"2026-09-07T03:31:37.524457Z","steps":["trace[280757065] 'process raft request' (duration: 117.7364ms)","trace[280757065] 'compare' (duration: 20.755958ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:31:37.524619Z","caller":"traceutil/trace.go:171","msg":"trace[1545405656] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"138.6201ms","start":"2026-09-07T03:31:37.385971Z","end":"2026-09-07T03:31:37.524591Z","steps":["trace[1545405656] 'process raft request' (duration: 138.399586ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:37.524637Z","caller":"traceutil/trace.go:171","msg":"trace[1941673365] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"134.775795ms","start":"2026-09-07T03:31:37.389841Z","end":"2026-09-07T03:31:37.524617Z","steps":["trace[1941673365] 'process raft request' (duration: 134.581681ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.52464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.83402ms","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-07T03:31:37.524731Z","caller":"traceutil/trace.go:171","msg":"trace[939117474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5144; }","duration":"122.939872ms","start":"2026-09-07T03:31:37.40175Z","end":"2026-09-07T03:31:37.52469Z","steps":["trace[939117474] 'agreement among raft nodes before linearized reading' (duration: 122.735598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.524857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.854877ms","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-07T03:31:37.524886Z","caller":"traceutil/trace.go:171","msg":"trace[2028663036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5144; }","duration":"107.928128ms","start":"2026-09-07T03:31:37.416948Z","end":"2026-09-07T03:31:37.524876Z","steps":["trace[2028663036] 'agreement among raft nodes before linearized reading' (duration: 107.802394ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:37.559855Z","caller":"traceutil/trace.go:171","msg":"trace[955381321] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"122.925033ms","start":"2026-09-07T03:31:37.436904Z","end":"2026-09-07T03:31:37.559829Z","steps":["trace[955381321] 'process raft request' (duration: 122.795739ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.93669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.851601ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T03:31:37.936916Z","caller":"traceutil/trace.go:171","msg":"trace[1565224580] transaction","detail":"{read_only:false; response_revision:5151; number_of_response:1; }","duration":"306.880322ms","start":"2026-09-07T03:31:37.630018Z","end":"2026-09-07T03:31:37.936898Z","steps":["trace[1565224580] 'process raft request' (duration: 184.747716ms)","trace[1565224580] 'compare' (duration: 121.662577ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T03:31:37.936983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:31:37.630011Z","time spent":"306.941253ms","remote":"127.0.0.1:51880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:31:37.937384Z","caller":"traceutil/trace.go:171","msg":"trace[139088865] linearizableReadLoop","detail":"{readStateIndex:5345; appliedIndex:5341; }","duration":"306.894932ms","start":"2026-09-07T03:31:37.630472Z","end":"2026-09-07T03:31:37.937367Z","steps":["trace[139088865] 'read index received' (duration: 47.773667ms)","trace[139088865] 'applied index is now lower than readState.Index' (duration: 259.119075ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:31:37.937456Z","caller":"traceutil/trace.go:171","msg":"trace[1131953225] transaction","detail":"{read_only:false; response_revision:5152; number_of_response:1; }","duration":"307.394862ms","start":"2026-09-07T03:31:37.630048Z","end":"2026-09-07T03:31:37.937443Z","steps":["trace[1131953225] 'process raft request' (duration: 306.77999ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:37.937476Z","caller":"traceutil/trace.go:171","msg":"trace[627704920] transaction","detail":"{read_only:false; response_revision:5153; number_of_response:1; }","duration":"307.362821ms","start":"2026-09-07T03:31:37.630105Z","end":"2026-09-07T03:31:37.937468Z","steps":["trace[627704920] 'process raft request' (duration: 307.087346ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.937524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:31:37.630023Z","time spent":"307.467644ms","remote":"127.0.0.1:51880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-07T03:31:37.937399Z","caller":"traceutil/trace.go:171","msg":"trace[1360801175] transaction","detail":"{read_only:false; response_revision:5154; number_of_response:1; }","duration":"242.509779ms","start":"2026-09-07T03:31:37.694858Z","end":"2026-09-07T03:31:37.937368Z","steps":["trace[1360801175] 'process raft request' (duration: 242.452978ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.937679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:31:37.630098Z","time spent":"307.419532ms","remote":"127.0.0.1:51976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T03:31:37.93781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.32501ms","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-07T03:31:37.9379Z","caller":"traceutil/trace.go:171","msg":"trace[1340674574] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5154; }","duration":"307.448264ms","start":"2026-09-07T03:31:37.630432Z","end":"2026-09-07T03:31:37.93788Z","steps":["trace[1340674574] 'agreement among raft nodes before linearized reading' (duration: 307.109497ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.937947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.983711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"warn","ts":"2026-09-07T03:31:37.937981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.650583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-09-07T03:31:37.937998Z","caller":"traceutil/trace.go:171","msg":"trace[2127153491] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5154; }","duration":"160.072612ms","start":"2026-09-07T03:31:37.777911Z","end":"2026-09-07T03:31:37.937984Z","steps":["trace[2127153491] 'agreement among raft nodes before linearized reading' (duration: 159.95809ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:37.938041Z","caller":"traceutil/trace.go:171","msg":"trace[1894391559] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5154; }","duration":"159.732985ms","start":"2026-09-07T03:31:37.778289Z","end":"2026-09-07T03:31:37.938022Z","steps":["trace[1894391559] 'agreement among raft nodes before linearized reading' (duration: 159.578232ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.938022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.535017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-07T03:31:37.938208Z","caller":"traceutil/trace.go:171","msg":"trace[1289401333] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5154; }","duration":"305.824893ms","start":"2026-09-07T03:31:37.632363Z","end":"2026-09-07T03:31:37.938188Z","steps":["trace[1289401333] 'agreement among raft nodes before linearized reading' (duration: 305.280461ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:37.938385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:31:37.63234Z","time spent":"305.960915ms","remote":"127.0.0.1:51974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-07T03:31:37.938392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T03:31:37.630415Z","time spent":"307.550256ms","remote":"127.0.0.1:51866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1887,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-09-07T03:31:46.797942Z","caller":"traceutil/trace.go:171","msg":"trace[1142723593] transaction","detail":"{read_only:false; response_revision:5238; number_of_response:1; }","duration":"117.642825ms","start":"2026-09-07T03:31:46.680276Z","end":"2026-09-07T03:31:46.797919Z","steps":["trace[1142723593] 'process raft request' (duration: 62.188543ms)","trace[1142723593] 'compare' (duration: 55.314608ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:31:46.798153Z","caller":"traceutil/trace.go:171","msg":"trace[606145141] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"117.841629ms","start":"2026-09-07T03:31:46.680289Z","end":"2026-09-07T03:31:46.798131Z","steps":["trace[606145141] 'process raft request' (duration: 117.698776ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:46.798432Z","caller":"traceutil/trace.go:171","msg":"trace[1872000140] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"117.943161ms","start":"2026-09-07T03:31:46.680481Z","end":"2026-09-07T03:31:46.798424Z","steps":["trace[1872000140] 'process raft request' (duration: 117.614684ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:46.798977Z","caller":"traceutil/trace.go:171","msg":"trace[842136990] linearizableReadLoop","detail":"{readStateIndex:5435; appliedIndex:5431; }","duration":"107.320503ms","start":"2026-09-07T03:31:46.69162Z","end":"2026-09-07T03:31:46.79894Z","steps":["trace[842136990] 'read index received' (duration: 50.853872ms)","trace[842136990] 'applied index is now lower than readState.Index' (duration: 56.465021ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T03:31:46.79911Z","caller":"traceutil/trace.go:171","msg":"trace[329404817] transaction","detail":"{read_only:false; response_revision:5241; number_of_response:1; }","duration":"118.301217ms","start":"2026-09-07T03:31:46.680788Z","end":"2026-09-07T03:31:46.79909Z","steps":["trace[329404817] 'process raft request' (duration: 117.598224ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T03:31:46.799288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.622819ms","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-07T03:31:46.799399Z","caller":"traceutil/trace.go:171","msg":"trace[1475602780] 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:5242; }","duration":"107.728141ms","start":"2026-09-07T03:31:46.691587Z","end":"2026-09-07T03:31:46.799315Z","steps":["trace[1475602780] 'agreement among raft nodes before linearized reading' (duration: 107.493026ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:31:46.799489Z","caller":"traceutil/trace.go:171","msg":"trace[336844666] transaction","detail":"{read_only:false; response_revision:5242; number_of_response:1; }","duration":"102.584682ms","start":"2026-09-07T03:31:46.696888Z","end":"2026-09-07T03:31:46.799473Z","steps":["trace[336844666] 'process raft request' (duration: 101.862368ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T03:32:02.297745Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2859} {"level":"info","ts":"2026-09-07T03:32:02.369539Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2859,"took":"70.575963ms","hash":525964947,"current-db-size-bytes":51597312,"current-db-size":"52 MB","current-db-size-in-use-bytes":28008448,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-07T03:32:02.369596Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":525964947,"revision":2859,"compact-revision":-1} {"level":"info","ts":"2026-09-07T03:37:02.305401Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5340} {"level":"info","ts":"2026-09-07T03:37:02.387665Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5340,"took":"80.782484ms","hash":3109291908,"current-db-size-bytes":51597312,"current-db-size":"52 MB","current-db-size-in-use-bytes":18776064,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-07T03:37:02.387763Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3109291908,"revision":5340,"compact-revision":2859}