{"level":"warn","ts":"2026-08-26T04:59:15.386071Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-26T04:59:15.386155Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.155: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.155:2380","--initial-cluster=instance=https://162.253.55.155:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.155:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.155: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-08-26T04:59:15.386222Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-26T04:59:15.386234Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.155:2380"]} {"level":"info","ts":"2026-08-26T04:59:15.38625Z","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-08-26T04:59:15.386854Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.155:2379"]} {"level":"info","ts":"2026-08-26T04:59:15.386941Z","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.155:2380"],"listen-peer-urls":["https://162.253.55.155:2380"],"advertise-client-urls":["https://162.253.55.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.155: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-08-26T04:59:15.390643Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.292198ms"} {"level":"info","ts":"2026-08-26T04:59:15.401091Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e7a3df655adff1be","cluster-id":"563ca9e04ae55d1c"} {"level":"info","ts":"2026-08-26T04:59:15.401168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be switched to configuration voters=()"} {"level":"info","ts":"2026-08-26T04:59:15.401187Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be became follower at term 0"} {"level":"info","ts":"2026-08-26T04:59:15.401215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e7a3df655adff1be [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-26T04:59:15.401243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be became follower at term 1"} {"level":"info","ts":"2026-08-26T04:59:15.401333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be switched to configuration voters=(16691430270374506942)"} {"level":"warn","ts":"2026-08-26T04:59:15.409398Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-26T04:59:15.412452Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-26T04:59:15.413801Z","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-08-26T04:59:15.41695Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e7a3df655adff1be","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-26T04:59:15.417148Z","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-08-26T04:59:15.417232Z","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-08-26T04:59:15.417252Z","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-08-26T04:59:15.417463Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e7a3df655adff1be","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-26T04:59:15.418407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be switched to configuration voters=(16691430270374506942)"} {"level":"info","ts":"2026-08-26T04:59:15.419303Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"563ca9e04ae55d1c","local-member-id":"e7a3df655adff1be","added-peer-id":"e7a3df655adff1be","added-peer-peer-urls":["https://162.253.55.155:2380"]} {"level":"info","ts":"2026-08-26T04:59:15.423782Z","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-08-26T04:59:15.423876Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.155:2380"} {"level":"info","ts":"2026-08-26T04:59:15.423919Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.155:2380"} {"level":"info","ts":"2026-08-26T04:59:15.424077Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e7a3df655adff1be","initial-advertise-peer-urls":["https://162.253.55.155:2380"],"listen-peer-urls":["https://162.253.55.155:2380"],"advertise-client-urls":["https://162.253.55.155:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.155:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-26T04:59:15.424131Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-26T04:59:15.602283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be is starting a new election at term 1"} {"level":"info","ts":"2026-08-26T04:59:15.60234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be became pre-candidate at term 1"} {"level":"info","ts":"2026-08-26T04:59:15.602362Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be received MsgPreVoteResp from e7a3df655adff1be at term 1"} {"level":"info","ts":"2026-08-26T04:59:15.602384Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be became candidate at term 2"} {"level":"info","ts":"2026-08-26T04:59:15.602396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be received MsgVoteResp from e7a3df655adff1be at term 2"} {"level":"info","ts":"2026-08-26T04:59:15.602413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e7a3df655adff1be became leader at term 2"} {"level":"info","ts":"2026-08-26T04:59:15.602429Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e7a3df655adff1be elected leader e7a3df655adff1be at term 2"} {"level":"info","ts":"2026-08-26T04:59:15.672658Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T04:59:15.706382Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e7a3df655adff1be","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.155:2379]}","request-path":"/0/members/e7a3df655adff1be/attributes","cluster-id":"563ca9e04ae55d1c","publish-timeout":"7s"} {"level":"info","ts":"2026-08-26T04:59:15.707054Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T04:59:15.707066Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T04:59:15.707443Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-26T04:59:15.707517Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-26T04:59:15.710002Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-26T04:59:15.713802Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.155:2379"} {"level":"info","ts":"2026-08-26T04:59:15.721079Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"563ca9e04ae55d1c","local-member-id":"e7a3df655adff1be","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T04:59:15.721177Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T04:59:15.721206Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-08-26T04:59:49.812994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.081302ms","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-08-26T04:59:49.813014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.010856ms","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-08-26T04:59:49.813086Z","caller":"traceutil/trace.go:171","msg":"trace[1089006476] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:486; }","duration":"114.26271ms","start":"2026-08-26T04:59:49.698802Z","end":"2026-08-26T04:59:49.813065Z","steps":["trace[1089006476] 'range keys from in-memory index tree' (duration: 113.965449ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T04:59:49.813095Z","caller":"traceutil/trace.go:171","msg":"trace[1597000527] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:486; }","duration":"185.174043ms","start":"2026-08-26T04:59:49.627906Z","end":"2026-08-26T04:59:49.81308Z","steps":["trace[1597000527] 'range keys from in-memory index tree' (duration: 184.886772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T04:59:49.813019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.074769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T04:59:49.813271Z","caller":"traceutil/trace.go:171","msg":"trace[1918114692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:486; }","duration":"136.358738ms","start":"2026-08-26T04:59:49.676875Z","end":"2026-08-26T04:59:49.813234Z","steps":["trace[1918114692] 'range keys from in-memory index tree' (duration: 135.983484ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T04:59:52.613681Z","caller":"traceutil/trace.go:171","msg":"trace[473156692] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"138.381749ms","start":"2026-08-26T04:59:52.475273Z","end":"2026-08-26T04:59:52.613654Z","steps":["trace[473156692] 'process raft request' (duration: 138.172151ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T04:59:52.619745Z","caller":"traceutil/trace.go:171","msg":"trace[203270343] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"138.965322ms","start":"2026-08-26T04:59:52.480758Z","end":"2026-08-26T04:59:52.619723Z","steps":["trace[203270343] 'process raft request' (duration: 138.821026ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T04:59:52.620113Z","caller":"traceutil/trace.go:171","msg":"trace[875363052] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"138.640498ms","start":"2026-08-26T04:59:52.481459Z","end":"2026-08-26T04:59:52.6201Z","steps":["trace[875363052] 'process raft request' (duration: 138.222052ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T04:59:52.620306Z","caller":"traceutil/trace.go:171","msg":"trace[1230100372] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"133.343176ms","start":"2026-08-26T04:59:52.486943Z","end":"2026-08-26T04:59:52.620286Z","steps":["trace[1230100372] 'process raft request' (duration: 133.048134ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T04:59:58.459197Z","caller":"traceutil/trace.go:171","msg":"trace[1273986488] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"134.110595ms","start":"2026-08-26T04:59:58.32506Z","end":"2026-08-26T04:59:58.459171Z","steps":["trace[1273986488] 'process raft request' (duration: 133.577414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T04:59:58.90762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.133593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ncpwc\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-26T04:59:58.907691Z","caller":"traceutil/trace.go:171","msg":"trace[352765476] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ncpwc; range_end:; response_count:1; response_revision:634; }","duration":"126.255409ms","start":"2026-08-26T04:59:58.781419Z","end":"2026-08-26T04:59:58.907674Z","steps":["trace[352765476] 'range keys from in-memory index tree' (duration: 125.936066ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T04:59:58.908002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.740197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T04:59:58.908031Z","caller":"traceutil/trace.go:171","msg":"trace[1795954863] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:634; }","duration":"232.426012ms","start":"2026-08-26T04:59:58.675597Z","end":"2026-08-26T04:59:58.908023Z","steps":["trace[1795954863] 'range keys from in-memory index tree' (duration: 230.648344ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T04:59:58.908264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.483264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.155\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-26T04:59:58.908291Z","caller":"traceutil/trace.go:171","msg":"trace[639569445] range","detail":"{range_begin:/registry/masterleases/162.253.55.155; range_end:; response_count:1; response_revision:634; }","duration":"129.550297ms","start":"2026-08-26T04:59:58.778733Z","end":"2026-08-26T04:59:58.908283Z","steps":["trace[639569445] 'range keys from in-memory index tree' (duration: 129.406002ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T04:59:59.568396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.95422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T04:59:59.570847Z","caller":"traceutil/trace.go:171","msg":"trace[1494792880] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"638.667598ms","start":"2026-08-26T04:59:58.932124Z","end":"2026-08-26T04:59:59.570791Z","steps":["trace[1494792880] 'process raft request' (duration: 520.576706ms)","trace[1494792880] 'compare' (duration: 112.794865ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T04:59:59.57117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T04:59:58.932089Z","time spent":"638.899877ms","remote":"127.0.0.1:60276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T04:59:59.573604Z","caller":"traceutil/trace.go:171","msg":"trace[807386268] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"611.472156ms","start":"2026-08-26T04:59:58.962113Z","end":"2026-08-26T04:59:59.573586Z","steps":["trace[807386268] 'process raft request' (duration: 610.029609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T04:59:59.573671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T04:59:58.962013Z","time spent":"611.625652ms","remote":"127.0.0.1:60342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T04:59:59.5736Z","caller":"traceutil/trace.go:171","msg":"trace[1664712635] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:660; }","duration":"351.737205ms","start":"2026-08-26T04:59:59.221819Z","end":"2026-08-26T04:59:59.573556Z","steps":["trace[1664712635] 'read index received' (duration: 230.890845ms)","trace[1664712635] 'applied index is now lower than readState.Index' (duration: 120.84546ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T04:59:59.57371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"351.88075ms","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-08-26T04:59:59.573743Z","caller":"traceutil/trace.go:171","msg":"trace[405301889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"351.946174ms","start":"2026-08-26T04:59:59.221788Z","end":"2026-08-26T04:59:59.573734Z","steps":["trace[405301889] 'agreement among raft nodes before linearized reading' (duration: 351.844259ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T04:59:59.573775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T04:59:59.221772Z","time spent":"351.997347ms","remote":"127.0.0.1:60508","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-08-26T05:00:59.48309Z","caller":"traceutil/trace.go:171","msg":"trace[88550530] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"236.439237ms","start":"2026-08-26T05:00:59.246628Z","end":"2026-08-26T05:00:59.483067Z","steps":["trace[88550530] 'process raft request' (duration: 236.288334ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:01:46.697487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.931864ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T05:01:46.697625Z","caller":"traceutil/trace.go:171","msg":"trace[1912869958] transaction","detail":"{read_only:false; response_revision:1913; number_of_response:1; }","duration":"468.99461ms","start":"2026-08-26T05:01:46.228588Z","end":"2026-08-26T05:01:46.697583Z","steps":["trace[1912869958] 'process raft request' (duration: 350.87949ms)","trace[1912869958] 'compare' (duration: 117.698517ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T05:01:46.697691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:01:46.228571Z","time spent":"469.093104ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T05:01:46.729578Z","caller":"traceutil/trace.go:171","msg":"trace[1715227950] linearizableReadLoop","detail":"{readStateIndex:1988; appliedIndex:1986; }","duration":"431.622493ms","start":"2026-08-26T05:01:46.297932Z","end":"2026-08-26T05:01:46.729554Z","steps":["trace[1715227950] 'read index received' (duration: 281.549746ms)","trace[1715227950] 'applied index is now lower than readState.Index' (duration: 150.071717ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T05:01:46.729827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.42273ms","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-08-26T05:01:46.729873Z","caller":"traceutil/trace.go:171","msg":"trace[703504525] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1915; }","duration":"257.508523ms","start":"2026-08-26T05:01:46.472351Z","end":"2026-08-26T05:01:46.729859Z","steps":["trace[703504525] 'agreement among raft nodes before linearized reading' (duration: 257.356418ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:01:46.729867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.912182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b16f2b9c-611a-4566-970c-a5eb17d6d52e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-26T05:01:46.729946Z","caller":"traceutil/trace.go:171","msg":"trace[2104984762] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b16f2b9c-611a-4566-970c-a5eb17d6d52e; range_end:; response_count:1; response_revision:1915; }","duration":"432.040765ms","start":"2026-08-26T05:01:46.297887Z","end":"2026-08-26T05:01:46.729928Z","steps":["trace[2104984762] 'agreement among raft nodes before linearized reading' (duration: 431.814848ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:01:46.730019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:01:46.297866Z","time spent":"432.142368ms","remote":"127.0.0.1:60422","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b16f2b9c-611a-4566-970c-a5eb17d6d52e\" "} {"level":"info","ts":"2026-08-26T05:01:46.730153Z","caller":"traceutil/trace.go:171","msg":"trace[109700165] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"238.557143ms","start":"2026-08-26T05:01:46.49105Z","end":"2026-08-26T05:01:46.729607Z","steps":["trace[109700165] 'process raft request' (duration: 238.46394ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:01:46.730215Z","caller":"traceutil/trace.go:171","msg":"trace[120721413] transaction","detail":"{read_only:false; response_revision:1914; number_of_response:1; }","duration":"500.809894ms","start":"2026-08-26T05:01:46.229377Z","end":"2026-08-26T05:01:46.730187Z","steps":["trace[120721413] 'process raft request' (duration: 500.021439ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:01:46.730299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.235831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T05:01:46.730338Z","caller":"traceutil/trace.go:171","msg":"trace[30564828] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1915; }","duration":"213.279832ms","start":"2026-08-26T05:01:46.517047Z","end":"2026-08-26T05:01:46.730327Z","steps":["trace[30564828] 'agreement among raft nodes before linearized reading' (duration: 213.2238ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:01:46.730348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.359546ms","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-08-26T05:01:46.730412Z","caller":"traceutil/trace.go:171","msg":"trace[2056991499] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1915; }","duration":"190.46556ms","start":"2026-08-26T05:01:46.539929Z","end":"2026-08-26T05:01:46.730395Z","steps":["trace[2056991499] 'agreement among raft nodes before linearized reading' (duration: 190.310865ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:01:46.730465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:01:46.229363Z","time spent":"500.954127ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T05:01:46.730662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.516039ms","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-08-26T05:01:46.730715Z","caller":"traceutil/trace.go:171","msg":"trace[1622125060] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1915; }","duration":"188.655323ms","start":"2026-08-26T05:01:46.542049Z","end":"2026-08-26T05:01:46.730704Z","steps":["trace[1622125060] 'agreement among raft nodes before linearized reading' (duration: 188.533989ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:01:46.730667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.064667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b16f2b9c-611a-4566-970c-a5eb17d6d52e\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-08-26T05:01:46.730828Z","caller":"traceutil/trace.go:171","msg":"trace[739931541] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b16f2b9c-611a-4566-970c-a5eb17d6d52e; range_end:; response_count:1; response_revision:1915; }","duration":"117.273193ms","start":"2026-08-26T05:01:46.613545Z","end":"2026-08-26T05:01:46.730819Z","steps":["trace[739931541] 'agreement among raft nodes before linearized reading' (duration: 117.044726ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:01:46.900506Z","caller":"traceutil/trace.go:171","msg":"trace[659360408] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"165.523601ms","start":"2026-08-26T05:01:46.734957Z","end":"2026-08-26T05:01:46.900481Z","steps":["trace[659360408] 'process raft request' (duration: 165.283773ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:01:46.900664Z","caller":"traceutil/trace.go:171","msg":"trace[1886467677] transaction","detail":"{read_only:false; response_revision:1919; number_of_response:1; }","duration":"161.802985ms","start":"2026-08-26T05:01:46.738832Z","end":"2026-08-26T05:01:46.900635Z","steps":["trace[1886467677] 'process raft request' (duration: 161.584578ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:01:46.901125Z","caller":"traceutil/trace.go:171","msg":"trace[771310459] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"164.917382ms","start":"2026-08-26T05:01:46.735621Z","end":"2026-08-26T05:01:46.900539Z","steps":["trace[771310459] 'process raft request' (duration: 164.747876ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:01:54.527159Z","caller":"traceutil/trace.go:171","msg":"trace[57035798] linearizableReadLoop","detail":"{readStateIndex:2073; appliedIndex:2071; }","duration":"135.372549ms","start":"2026-08-26T05:01:54.391759Z","end":"2026-08-26T05:01:54.527132Z","steps":["trace[57035798] 'read index received' (duration: 30.500577ms)","trace[57035798] 'applied index is now lower than readState.Index' (duration: 104.870852ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T05:01:54.527238Z","caller":"traceutil/trace.go:171","msg":"trace[1293361776] transaction","detail":"{read_only:false; response_revision:1997; number_of_response:1; }","duration":"163.649596ms","start":"2026-08-26T05:01:54.363555Z","end":"2026-08-26T05:01:54.527204Z","steps":["trace[1293361776] 'process raft request' (duration: 163.392097ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:01:54.527629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.857704ms","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-08-26T05:01:54.527696Z","caller":"traceutil/trace.go:171","msg":"trace[1074457948] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1997; }","duration":"135.974818ms","start":"2026-08-26T05:01:54.391703Z","end":"2026-08-26T05:01:54.527677Z","steps":["trace[1074457948] 'agreement among raft nodes before linearized reading' (duration: 135.543924ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:02:20.986298Z","caller":"traceutil/trace.go:171","msg":"trace[1501376138] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"136.700531ms","start":"2026-08-26T05:02:20.84956Z","end":"2026-08-26T05:02:20.98626Z","steps":["trace[1501376138] 'process raft request' (duration: 136.473803ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:02:21.3052Z","caller":"traceutil/trace.go:171","msg":"trace[1143136453] linearizableReadLoop","detail":"{readStateIndex:2238; appliedIndex:2236; }","duration":"417.689539ms","start":"2026-08-26T05:02:20.887487Z","end":"2026-08-26T05:02:21.305177Z","steps":["trace[1143136453] 'read index received' (duration: 98.459477ms)","trace[1143136453] 'applied index is now lower than readState.Index' (duration: 319.228512ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T05:02:21.305249Z","caller":"traceutil/trace.go:171","msg":"trace[1233047109] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"452.319491ms","start":"2026-08-26T05:02:20.85291Z","end":"2026-08-26T05:02:21.305229Z","steps":["trace[1233047109] 'process raft request' (duration: 452.135994ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.305477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:20.852896Z","time spent":"452.503317ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T05:02:21.305536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.958309ms","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-08-26T05:02:21.305927Z","caller":"traceutil/trace.go:171","msg":"trace[764006293] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2157; }","duration":"418.457186ms","start":"2026-08-26T05:02:20.887443Z","end":"2026-08-26T05:02:21.3059Z","steps":["trace[764006293] 'agreement among raft nodes before linearized reading' (duration: 417.855135ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.306041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:20.887428Z","time spent":"418.597681ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-08-26T05:02:21.345429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.979734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-08-26T05:02:21.345502Z","caller":"traceutil/trace.go:171","msg":"trace[460685633] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2158; }","duration":"285.103118ms","start":"2026-08-26T05:02:21.060383Z","end":"2026-08-26T05:02:21.345486Z","steps":["trace[460685633] 'agreement among raft nodes before linearized reading' (duration: 284.910852ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.345439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.850811ms","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-08-26T05:02:21.345575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:21.017929Z","time spent":"327.639931ms","remote":"127.0.0.1:60326","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-26T05:02:21.345614Z","caller":"traceutil/trace.go:171","msg":"trace[1901751273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2158; }","duration":"448.076968ms","start":"2026-08-26T05:02:20.897517Z","end":"2026-08-26T05:02:21.345594Z","steps":["trace[1901751273] 'agreement among raft nodes before linearized reading' (duration: 447.742586ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.345732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:20.897498Z","time spent":"448.216684ms","remote":"127.0.0.1:60508","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-08-26T05:02:21.345569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.755739ms","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-08-26T05:02:21.346355Z","caller":"traceutil/trace.go:171","msg":"trace[1851606912] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2158; }","duration":"446.547346ms","start":"2026-08-26T05:02:20.899787Z","end":"2026-08-26T05:02:21.346334Z","steps":["trace[1851606912] 'agreement among raft nodes before linearized reading' (duration: 445.680766ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.346492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:20.899779Z","time spent":"446.68401ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-26T05:02:21.345854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.219725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-08-26T05:02:21.347023Z","caller":"traceutil/trace.go:171","msg":"trace[11324678] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2158; }","duration":"289.440867ms","start":"2026-08-26T05:02:21.057567Z","end":"2026-08-26T05:02:21.347008Z","steps":["trace[11324678] 'agreement among raft nodes before linearized reading' (duration: 287.899373ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.345883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.463234ms","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-08-26T05:02:21.34728Z","caller":"traceutil/trace.go:171","msg":"trace[1926116525] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2158; }","duration":"193.835401ms","start":"2026-08-26T05:02:21.153364Z","end":"2026-08-26T05:02:21.347199Z","steps":["trace[1926116525] 'agreement among raft nodes before linearized reading' (duration: 192.018289ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:02:21.728042Z","caller":"traceutil/trace.go:171","msg":"trace[2010912286] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"418.047059ms","start":"2026-08-26T05:02:21.309918Z","end":"2026-08-26T05:02:21.727965Z","steps":["trace[2010912286] 'process raft request' (duration: 323.545441ms)","trace[2010912286] 'compare' (duration: 94.395205ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T05:02:21.728372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:21.309907Z","time spent":"418.225846ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T05:02:21.730165Z","caller":"traceutil/trace.go:171","msg":"trace[1850708899] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"383.298903ms","start":"2026-08-26T05:02:21.346822Z","end":"2026-08-26T05:02:21.730121Z","steps":["trace[1850708899] 'process raft request' (duration: 383.074455ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.730363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:21.346803Z","time spent":"383.469158ms","remote":"127.0.0.1:60326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":819,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-26T05:02:21.73038Z","caller":"traceutil/trace.go:171","msg":"trace[1475775741] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"379.915118ms","start":"2026-08-26T05:02:21.35044Z","end":"2026-08-26T05:02:21.730355Z","steps":["trace[1475775741] 'process raft request' (duration: 379.591647ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:02:21.730536Z","caller":"traceutil/trace.go:171","msg":"trace[849302176] linearizableReadLoop","detail":"{readStateIndex:2246; appliedIndex:2240; }","duration":"181.757929ms","start":"2026-08-26T05:02:21.548752Z","end":"2026-08-26T05:02:21.73051Z","steps":["trace[849302176] 'read index received' (duration: 84.743555ms)","trace[849302176] 'applied index is now lower than readState.Index' (duration: 97.013064ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T05:02:21.730599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:21.350417Z","time spent":"380.141635ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T05:02:21.730725Z","caller":"traceutil/trace.go:171","msg":"trace[917648319] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"378.207408ms","start":"2026-08-26T05:02:21.352508Z","end":"2026-08-26T05:02:21.730715Z","steps":["trace[917648319] 'process raft request' (duration: 377.947189ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.730808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:21.352482Z","time spent":"378.270272ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T05:02:21.730887Z","caller":"traceutil/trace.go:171","msg":"trace[1822714169] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"380.380963ms","start":"2026-08-26T05:02:21.350496Z","end":"2026-08-26T05:02:21.730877Z","steps":["trace[1822714169] 'process raft request' (duration: 379.586086ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.730912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.145461ms","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-08-26T05:02:21.730955Z","caller":"traceutil/trace.go:171","msg":"trace[1128492152] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"379.401209ms","start":"2026-08-26T05:02:21.351545Z","end":"2026-08-26T05:02:21.730946Z","steps":["trace[1128492152] 'process raft request' (duration: 378.85054ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:02:21.73098Z","caller":"traceutil/trace.go:171","msg":"trace[709724795] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2164; }","duration":"182.255346ms","start":"2026-08-26T05:02:21.548712Z","end":"2026-08-26T05:02:21.730967Z","steps":["trace[709724795] 'agreement among raft nodes before linearized reading' (duration: 182.071249ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:02:21.730993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:21.351532Z","time spent":"379.441621ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T05:02:21.730927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T05:02:21.350462Z","time spent":"380.444935ms","remote":"127.0.0.1:60508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T05:03:26.269633Z","caller":"traceutil/trace.go:171","msg":"trace[1434361042] transaction","detail":"{read_only:false; response_revision:2612; number_of_response:1; }","duration":"194.327552ms","start":"2026-08-26T05:03:26.075286Z","end":"2026-08-26T05:03:26.269613Z","steps":["trace[1434361042] 'process raft request' (duration: 194.225068ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:03:26.272869Z","caller":"traceutil/trace.go:171","msg":"trace[1230641289] linearizableReadLoop","detail":"{readStateIndex:2712; appliedIndex:2708; }","duration":"189.483875ms","start":"2026-08-26T05:03:26.083362Z","end":"2026-08-26T05:03:26.272846Z","steps":["trace[1230641289] 'read index received' (duration: 186.211285ms)","trace[1230641289] 'applied index is now lower than readState.Index' (duration: 3.2715ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T05:03:26.273075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.700962ms","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-08-26T05:03:26.273114Z","caller":"traceutil/trace.go:171","msg":"trace[1660864716] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2615; }","duration":"189.785527ms","start":"2026-08-26T05:03:26.083318Z","end":"2026-08-26T05:03:26.273104Z","steps":["trace[1660864716] 'agreement among raft nodes before linearized reading' (duration: 189.62169ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:03:26.273376Z","caller":"traceutil/trace.go:171","msg":"trace[1554221012] transaction","detail":"{read_only:false; response_revision:2613; number_of_response:1; }","duration":"197.714967ms","start":"2026-08-26T05:03:26.07565Z","end":"2026-08-26T05:03:26.273365Z","steps":["trace[1554221012] 'process raft request' (duration: 197.022652ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:03:26.273505Z","caller":"traceutil/trace.go:171","msg":"trace[1041967673] transaction","detail":"{read_only:false; response_revision:2614; number_of_response:1; }","duration":"195.779937ms","start":"2026-08-26T05:03:26.077716Z","end":"2026-08-26T05:03:26.273496Z","steps":["trace[1041967673] 'process raft request' (duration: 195.060771ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:03:26.273638Z","caller":"traceutil/trace.go:171","msg":"trace[284403656] transaction","detail":"{read_only:false; response_revision:2615; number_of_response:1; }","duration":"195.448734ms","start":"2026-08-26T05:03:26.07818Z","end":"2026-08-26T05:03:26.273629Z","steps":["trace[284403656] 'process raft request' (duration: 194.632414ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:03:59.038716Z","caller":"traceutil/trace.go:171","msg":"trace[1082225087] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"231.192016ms","start":"2026-08-26T05:03:58.80749Z","end":"2026-08-26T05:03:59.038682Z","steps":["trace[1082225087] 'process raft request' (duration: 172.27293ms)","trace[1082225087] 'compare' (duration: 58.761631ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T05:03:59.217913Z","caller":"traceutil/trace.go:171","msg":"trace[1623284511] transaction","detail":"{read_only:false; response_revision:2797; number_of_response:1; }","duration":"122.56426ms","start":"2026-08-26T05:03:59.09529Z","end":"2026-08-26T05:03:59.217854Z","steps":["trace[1623284511] 'process raft request' (duration: 111.59341ms)","trace[1623284511] 'compare' (duration: 10.847895ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T05:03:59.552741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.977778ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T05:03:59.553236Z","caller":"traceutil/trace.go:171","msg":"trace[1188184241] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"192.985466ms","start":"2026-08-26T05:03:59.36021Z","end":"2026-08-26T05:03:59.553195Z","steps":["trace[1188184241] 'process raft request' (duration: 22.483349ms)","trace[1188184241] 'compare' (duration: 169.703606ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T05:07:40.264486Z","caller":"traceutil/trace.go:171","msg":"trace[1788725217] linearizableReadLoop","detail":"{readStateIndex:4791; appliedIndex:4790; }","duration":"115.903206ms","start":"2026-08-26T05:07:40.148565Z","end":"2026-08-26T05:07:40.264468Z","steps":["trace[1788725217] 'read index received' (duration: 115.745882ms)","trace[1788725217] 'applied index is now lower than readState.Index' (duration: 156.654µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T05:07:40.264724Z","caller":"traceutil/trace.go:171","msg":"trace[2063212195] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"120.118176ms","start":"2026-08-26T05:07:40.144593Z","end":"2026-08-26T05:07:40.264711Z","steps":["trace[2063212195] 'process raft request' (duration: 119.774255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:07:40.264731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.144764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:57150"} {"level":"info","ts":"2026-08-26T05:07:40.264758Z","caller":"traceutil/trace.go:171","msg":"trace[1250646494] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4619; }","duration":"116.203795ms","start":"2026-08-26T05:07:40.148548Z","end":"2026-08-26T05:07:40.264752Z","steps":["trace[1250646494] 'agreement among raft nodes before linearized reading' (duration: 116.000539ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:07:46.6676Z","caller":"traceutil/trace.go:171","msg":"trace[874508505] transaction","detail":"{read_only:false; response_revision:4757; number_of_response:1; }","duration":"215.536597ms","start":"2026-08-26T05:07:46.452037Z","end":"2026-08-26T05:07:46.667574Z","steps":["trace[874508505] 'process raft request' (duration: 215.366892ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:07:46.893559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.607868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T05:07:46.893691Z","caller":"traceutil/trace.go:171","msg":"trace[505266965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4757; }","duration":"214.778175ms","start":"2026-08-26T05:07:46.678891Z","end":"2026-08-26T05:07:46.893669Z","steps":["trace[505266965] 'range keys from in-memory index tree' (duration: 214.542277ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:07:46.897924Z","caller":"traceutil/trace.go:171","msg":"trace[1323959715] transaction","detail":"{read_only:false; response_revision:4758; number_of_response:1; }","duration":"122.32972ms","start":"2026-08-26T05:07:46.775565Z","end":"2026-08-26T05:07:46.897895Z","steps":["trace[1323959715] 'process raft request' (duration: 122.197616ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:07:47.34354Z","caller":"traceutil/trace.go:171","msg":"trace[1891472527] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"194.043988ms","start":"2026-08-26T05:07:47.149464Z","end":"2026-08-26T05:07:47.343508Z","steps":["trace[1891472527] 'process raft request' (duration: 193.819851ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:07:47.343578Z","caller":"traceutil/trace.go:171","msg":"trace[1696731725] transaction","detail":"{read_only:false; response_revision:4765; number_of_response:1; }","duration":"193.4384ms","start":"2026-08-26T05:07:47.15012Z","end":"2026-08-26T05:07:47.343558Z","steps":["trace[1696731725] 'process raft request' (duration: 193.303216ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:07:47.343663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.139851ms","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-08-26T05:07:47.343542Z","caller":"traceutil/trace.go:171","msg":"trace[1421599562] linearizableReadLoop","detail":"{readStateIndex:4940; appliedIndex:4938; }","duration":"194.017398ms","start":"2026-08-26T05:07:47.149499Z","end":"2026-08-26T05:07:47.343517Z","steps":["trace[1421599562] 'read index received' (duration: 6.909234ms)","trace[1421599562] 'applied index is now lower than readState.Index' (duration: 187.107144ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T05:07:47.343732Z","caller":"traceutil/trace.go:171","msg":"trace[123922930] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4766; }","duration":"194.202263ms","start":"2026-08-26T05:07:47.149492Z","end":"2026-08-26T05:07:47.343694Z","steps":["trace[123922930] 'agreement among raft nodes before linearized reading' (duration: 194.103139ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:07:47.343605Z","caller":"traceutil/trace.go:171","msg":"trace[1648690589] transaction","detail":"{read_only:false; response_revision:4766; number_of_response:1; }","duration":"192.665775ms","start":"2026-08-26T05:07:47.150922Z","end":"2026-08-26T05:07:47.343587Z","steps":["trace[1648690589] 'process raft request' (duration: 192.555382ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:07:47.362149Z","caller":"traceutil/trace.go:171","msg":"trace[558664691] transaction","detail":"{read_only:false; response_revision:4767; number_of_response:1; }","duration":"185.73801ms","start":"2026-08-26T05:07:47.176382Z","end":"2026-08-26T05:07:47.36212Z","steps":["trace[558664691] 'process raft request' (duration: 185.625676ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:07:59.946388Z","caller":"traceutil/trace.go:171","msg":"trace[1900591811] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"208.268012ms","start":"2026-08-26T05:07:59.738096Z","end":"2026-08-26T05:07:59.946364Z","steps":["trace[1900591811] 'process raft request' (duration: 208.176229ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:07:59.946624Z","caller":"traceutil/trace.go:171","msg":"trace[431234495] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"212.04547ms","start":"2026-08-26T05:07:59.734542Z","end":"2026-08-26T05:07:59.946588Z","steps":["trace[431234495] 'process raft request' (duration: 205.457654ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:08:00.350626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.155582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-08-26T05:08:00.350721Z","caller":"traceutil/trace.go:171","msg":"trace[198650556] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4929; }","duration":"158.307057ms","start":"2026-08-26T05:08:00.192384Z","end":"2026-08-26T05:08:00.350692Z","steps":["trace[198650556] 'range keys from in-memory index tree' (duration: 157.943656ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:08:00.350848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.61522ms","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-08-26T05:08:00.3509Z","caller":"traceutil/trace.go:171","msg":"trace[904559742] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4929; }","duration":"154.720885ms","start":"2026-08-26T05:08:00.196167Z","end":"2026-08-26T05:08:00.350888Z","steps":["trace[904559742] 'range keys from in-memory index tree' (duration: 154.442366ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:08:00.89223Z","caller":"traceutil/trace.go:171","msg":"trace[548820939] linearizableReadLoop","detail":"{readStateIndex:5119; appliedIndex:5118; }","duration":"101.105378ms","start":"2026-08-26T05:08:00.791099Z","end":"2026-08-26T05:08:00.892205Z","steps":["trace[548820939] 'read index received' (duration: 100.297613ms)","trace[548820939] 'applied index is now lower than readState.Index' (duration: 806.675µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T05:08:00.892311Z","caller":"traceutil/trace.go:171","msg":"trace[739754194] transaction","detail":"{read_only:false; response_revision:4936; number_of_response:1; }","duration":"104.95034ms","start":"2026-08-26T05:08:00.787307Z","end":"2026-08-26T05:08:00.892258Z","steps":["trace[739754194] 'process raft request' (duration: 104.198957ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T05:08:00.892456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.340306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:1 size:9637"} {"level":"info","ts":"2026-08-26T05:08:00.892572Z","caller":"traceutil/trace.go:171","msg":"trace[770225433] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:1; response_revision:4936; }","duration":"101.414379ms","start":"2026-08-26T05:08:00.791067Z","end":"2026-08-26T05:08:00.892482Z","steps":["trace[770225433] 'agreement among raft nodes before linearized reading' (duration: 101.235063ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:09:15.8922Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2882} {"level":"info","ts":"2026-08-26T05:09:15.989368Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2882,"took":"95.7563ms","hash":3220654779,"current-db-size-bytes":54132736,"current-db-size":"54 MB","current-db-size-in-use-bytes":29286400,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-26T05:09:15.989446Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3220654779,"revision":2882,"compact-revision":-1} {"level":"warn","ts":"2026-08-26T05:11:52.865322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.333379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T05:11:52.865386Z","caller":"traceutil/trace.go:171","msg":"trace[568225044] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6658; }","duration":"186.431561ms","start":"2026-08-26T05:11:52.678942Z","end":"2026-08-26T05:11:52.865374Z","steps":["trace[568225044] 'range keys from in-memory index tree' (duration: 186.283127ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T05:14:15.896907Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5571} {"level":"info","ts":"2026-08-26T05:14:15.974058Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5571,"took":"75.948184ms","hash":2258975867,"current-db-size-bytes":54132736,"current-db-size":"54 MB","current-db-size-in-use-bytes":18296832,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-08-26T05:14:15.974125Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2258975867,"revision":5571,"compact-revision":2882}