{"level":"warn","ts":"2026-09-16T21:39:07.270717Z","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-16T21:39:07.270802Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.234: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.234:2380","--initial-cluster=instance=https://162.253.55.234:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.234:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.234: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-16T21:39:07.270876Z","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-16T21:39:07.270891Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.234:2380"]} {"level":"info","ts":"2026-09-16T21:39:07.27091Z","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-16T21:39:07.27159Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.234:2379"]} {"level":"info","ts":"2026-09-16T21:39:07.271671Z","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.234:2380"],"listen-peer-urls":["https://162.253.55.234:2380"],"advertise-client-urls":["https://162.253.55.234:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.234:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.234: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-16T21:39:07.275724Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.789488ms"} {"level":"info","ts":"2026-09-16T21:39:07.28297Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"403fac606ddb6bbc","cluster-id":"3f7d75ded657ac1e"} {"level":"info","ts":"2026-09-16T21:39:07.283055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc switched to configuration voters=()"} {"level":"info","ts":"2026-09-16T21:39:07.283082Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became follower at term 0"} {"level":"info","ts":"2026-09-16T21:39:07.283098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 403fac606ddb6bbc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-16T21:39:07.283113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became follower at term 1"} {"level":"info","ts":"2026-09-16T21:39:07.283168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc switched to configuration voters=(4629608472120093628)"} {"level":"warn","ts":"2026-09-16T21:39:07.289965Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-16T21:39:07.292416Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-16T21:39:07.293879Z","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-16T21:39:07.29677Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"403fac606ddb6bbc","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-16T21:39:07.297173Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"403fac606ddb6bbc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-16T21:39:07.297364Z","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-16T21:39:07.297445Z","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-16T21:39:07.297454Z","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-16T21:39:07.299938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc switched to configuration voters=(4629608472120093628)"} {"level":"info","ts":"2026-09-16T21:39:07.299976Z","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-16T21:39:07.300009Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f7d75ded657ac1e","local-member-id":"403fac606ddb6bbc","added-peer-id":"403fac606ddb6bbc","added-peer-peer-urls":["https://162.253.55.234:2380"]} {"level":"info","ts":"2026-09-16T21:39:07.300128Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"403fac606ddb6bbc","initial-advertise-peer-urls":["https://162.253.55.234:2380"],"listen-peer-urls":["https://162.253.55.234:2380"],"advertise-client-urls":["https://162.253.55.234:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.234:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-16T21:39:07.300147Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-16T21:39:07.300558Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.234:2380"} {"level":"info","ts":"2026-09-16T21:39:07.300568Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.234:2380"} {"level":"info","ts":"2026-09-16T21:39:07.384385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc is starting a new election at term 1"} {"level":"info","ts":"2026-09-16T21:39:07.384465Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became pre-candidate at term 1"} {"level":"info","ts":"2026-09-16T21:39:07.384489Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc received MsgPreVoteResp from 403fac606ddb6bbc at term 1"} {"level":"info","ts":"2026-09-16T21:39:07.384504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became candidate at term 2"} {"level":"info","ts":"2026-09-16T21:39:07.384512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc received MsgVoteResp from 403fac606ddb6bbc at term 2"} {"level":"info","ts":"2026-09-16T21:39:07.384527Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"403fac606ddb6bbc became leader at term 2"} {"level":"info","ts":"2026-09-16T21:39:07.384537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 403fac606ddb6bbc elected leader 403fac606ddb6bbc at term 2"} {"level":"info","ts":"2026-09-16T21:39:07.385493Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"403fac606ddb6bbc","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.234:2379]}","request-path":"/0/members/403fac606ddb6bbc/attributes","cluster-id":"3f7d75ded657ac1e","publish-timeout":"7s"} {"level":"info","ts":"2026-09-16T21:39:07.385534Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-16T21:39:07.385944Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T21:39:07.386062Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-16T21:39:07.388083Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-16T21:39:07.38815Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-16T21:39:07.388181Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-16T21:39:07.389949Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.234:2379"} {"level":"info","ts":"2026-09-16T21:39:07.391201Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f7d75ded657ac1e","local-member-id":"403fac606ddb6bbc","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T21:39:07.391286Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T21:39:07.391311Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-16T21:39:11.54589Z","caller":"traceutil/trace.go:171","msg":"trace[38105034] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"205.151732ms","start":"2026-09-16T21:39:11.34071Z","end":"2026-09-16T21:39:11.545861Z","steps":["trace[38105034] 'process raft request' (duration: 204.97023ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:11.602423Z","caller":"traceutil/trace.go:171","msg":"trace[323354009] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"260.618063ms","start":"2026-09-16T21:39:11.341769Z","end":"2026-09-16T21:39:11.602388Z","steps":["trace[323354009] 'process raft request' (duration: 260.351812ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:39:11.849169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.591077ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-16T21:39:11.849478Z","caller":"traceutil/trace.go:171","msg":"trace[595190079] transaction","detail":"{read_only:false; response_revision:212; number_of_response:1; }","duration":"231.82423ms","start":"2026-09-16T21:39:11.617509Z","end":"2026-09-16T21:39:11.849333Z","steps":["trace[595190079] 'process raft request' (duration: 77.318827ms)","trace[595190079] 'compare' (duration: 153.349765ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:39:12.26388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.532227ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-16T21:39:12.26402Z","caller":"traceutil/trace.go:171","msg":"trace[2087217292] linearizableReadLoop","detail":"{readStateIndex:218; appliedIndex:217; }","duration":"410.18606ms","start":"2026-09-16T21:39:11.853809Z","end":"2026-09-16T21:39:12.263995Z","steps":["trace[2087217292] 'read index received' (duration: 181.501853ms)","trace[2087217292] 'applied index is now lower than readState.Index' (duration: 228.682727ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:39:12.264132Z","caller":"traceutil/trace.go:171","msg":"trace[779211219] transaction","detail":"{read_only:false; response_revision:213; number_of_response:1; }","duration":"634.035534ms","start":"2026-09-16T21:39:11.630022Z","end":"2026-09-16T21:39:12.264057Z","steps":["trace[779211219] 'process raft request' (duration: 405.234755ms)","trace[779211219] 'compare' (duration: 228.349466ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:39:12.264266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.384681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-dxx87j\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T21:39:12.264327Z","caller":"traceutil/trace.go:171","msg":"trace[265171331] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-dxx87j; range_end:; response_count:0; response_revision:213; }","duration":"410.570693ms","start":"2026-09-16T21:39:11.853744Z","end":"2026-09-16T21:39:12.264315Z","steps":["trace[265171331] 'agreement among raft nodes before linearized reading' (duration: 410.370462ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:39:12.264398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:39:11.853717Z","time spent":"410.671514ms","remote":"127.0.0.1:44984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-dxx87j\" "} {"level":"warn","ts":"2026-09-16T21:39:12.264476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:39:11.629992Z","time spent":"634.284695ms","remote":"127.0.0.1:44968","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-16T21:39:12.561991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.787125ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-16T21:39:12.562129Z","caller":"traceutil/trace.go:171","msg":"trace[69568823] transaction","detail":"{read_only:false; response_revision:216; number_of_response:1; }","duration":"291.905863ms","start":"2026-09-16T21:39:12.270213Z","end":"2026-09-16T21:39:12.562119Z","steps":["trace[69568823] 'process raft request' (duration: 291.882173ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:12.562311Z","caller":"traceutil/trace.go:171","msg":"trace[902787723] transaction","detail":"{read_only:false; response_revision:214; number_of_response:1; }","duration":"293.384923ms","start":"2026-09-16T21:39:12.268921Z","end":"2026-09-16T21:39:12.562306Z","steps":["trace[902787723] 'process raft request' (duration: 187.235457ms)","trace[902787723] 'compare' (duration: 105.655133ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:39:12.562474Z","caller":"traceutil/trace.go:171","msg":"trace[46769485] transaction","detail":"{read_only:false; response_revision:215; number_of_response:1; }","duration":"292.294006ms","start":"2026-09-16T21:39:12.270147Z","end":"2026-09-16T21:39:12.562441Z","steps":["trace[46769485] 'process raft request' (duration: 291.920354ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:48.968878Z","caller":"traceutil/trace.go:171","msg":"trace[1088607001] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:554; }","duration":"140.337085ms","start":"2026-09-16T21:39:48.828516Z","end":"2026-09-16T21:39:48.968853Z","steps":["trace[1088607001] 'read index received' (duration: 140.194099ms)","trace[1088607001] 'applied index is now lower than readState.Index' (duration: 141.476µs)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:39:48.968959Z","caller":"traceutil/trace.go:171","msg":"trace[1981290115] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"169.873496ms","start":"2026-09-16T21:39:48.799045Z","end":"2026-09-16T21:39:48.968918Z","steps":["trace[1981290115] 'process raft request' (duration: 169.655646ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:39:48.969453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.92518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-09-16T21:39:48.969506Z","caller":"traceutil/trace.go:171","msg":"trace[902276563] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:535; }","duration":"141.032666ms","start":"2026-09-16T21:39:48.828459Z","end":"2026-09-16T21:39:48.969491Z","steps":["trace[902276563] 'agreement among raft nodes before linearized reading' (duration: 140.496373ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.584547Z","caller":"traceutil/trace.go:171","msg":"trace[1808515900] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"136.134532ms","start":"2026-09-16T21:39:50.448387Z","end":"2026-09-16T21:39:50.584522Z","steps":["trace[1808515900] 'process raft request' (duration: 128.982134ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.58483Z","caller":"traceutil/trace.go:171","msg":"trace[2014556613] transaction","detail":"{read_only:false; number_of_response:1; response_revision:549; }","duration":"129.883851ms","start":"2026-09-16T21:39:50.454913Z","end":"2026-09-16T21:39:50.584796Z","steps":["trace[2014556613] 'process raft request' (duration: 129.551728ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588351Z","caller":"traceutil/trace.go:171","msg":"trace[1318334188] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"111.83209ms","start":"2026-09-16T21:39:50.476488Z","end":"2026-09-16T21:39:50.58832Z","steps":["trace[1318334188] 'process raft request' (duration: 111.490366ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588359Z","caller":"traceutil/trace.go:171","msg":"trace[1172864923] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"127.786055ms","start":"2026-09-16T21:39:50.46056Z","end":"2026-09-16T21:39:50.588346Z","steps":["trace[1172864923] 'process raft request' (duration: 127.167539ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588421Z","caller":"traceutil/trace.go:171","msg":"trace[1504481709] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"111.950345ms","start":"2026-09-16T21:39:50.476448Z","end":"2026-09-16T21:39:50.588398Z","steps":["trace[1504481709] 'process raft request' (duration: 111.494036ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588435Z","caller":"traceutil/trace.go:171","msg":"trace[882339756] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"115.772395ms","start":"2026-09-16T21:39:50.47264Z","end":"2026-09-16T21:39:50.588412Z","steps":["trace[882339756] 'process raft request' (duration: 115.248923ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588374Z","caller":"traceutil/trace.go:171","msg":"trace[553835742] transaction","detail":"{read_only:false; number_of_response:0; response_revision:553; }","duration":"111.962005ms","start":"2026-09-16T21:39:50.476392Z","end":"2026-09-16T21:39:50.588354Z","steps":["trace[553835742] 'process raft request' (duration: 111.521517ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588512Z","caller":"traceutil/trace.go:171","msg":"trace[83081348] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"108.256712ms","start":"2026-09-16T21:39:50.480249Z","end":"2026-09-16T21:39:50.588506Z","steps":["trace[83081348] 'process raft request' (duration: 107.756281ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.58859Z","caller":"traceutil/trace.go:171","msg":"trace[593328064] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"108.20864ms","start":"2026-09-16T21:39:50.480372Z","end":"2026-09-16T21:39:50.588581Z","steps":["trace[593328064] 'process raft request' (duration: 107.691568ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588561Z","caller":"traceutil/trace.go:171","msg":"trace[1428693662] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"121.136397ms","start":"2026-09-16T21:39:50.467403Z","end":"2026-09-16T21:39:50.588539Z","steps":["trace[1428693662] 'process raft request' (duration: 120.402297ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588612Z","caller":"traceutil/trace.go:171","msg":"trace[38631826] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"118.846623ms","start":"2026-09-16T21:39:50.469755Z","end":"2026-09-16T21:39:50.588602Z","steps":["trace[38631826] 'process raft request' (duration: 118.098292ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588488Z","caller":"traceutil/trace.go:171","msg":"trace[1178876223] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"108.129857ms","start":"2026-09-16T21:39:50.48035Z","end":"2026-09-16T21:39:50.588479Z","steps":["trace[1178876223] 'process raft request' (duration: 107.689158ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.588714Z","caller":"traceutil/trace.go:171","msg":"trace[1298733452] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"103.733383ms","start":"2026-09-16T21:39:50.48497Z","end":"2026-09-16T21:39:50.588704Z","steps":["trace[1298733452] 'process raft request' (duration: 103.196381ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:50.595382Z","caller":"traceutil/trace.go:171","msg":"trace[1027685358] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"100.989368ms","start":"2026-09-16T21:39:50.494372Z","end":"2026-09-16T21:39:50.595361Z","steps":["trace[1027685358] 'process raft request' (duration: 93.843601ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:56.664926Z","caller":"traceutil/trace.go:171","msg":"trace[1151592294] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"105.428711ms","start":"2026-09-16T21:39:56.559452Z","end":"2026-09-16T21:39:56.664881Z","steps":["trace[1151592294] 'process raft request' (duration: 104.864739ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:56.91907Z","caller":"traceutil/trace.go:171","msg":"trace[1529136869] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"211.641774ms","start":"2026-09-16T21:39:56.7074Z","end":"2026-09-16T21:39:56.919042Z","steps":["trace[1529136869] 'process raft request' (duration: 211.459946ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:39:57.121328Z","caller":"traceutil/trace.go:171","msg":"trace[1596906312] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"114.298267ms","start":"2026-09-16T21:39:57.007006Z","end":"2026-09-16T21:39:57.121305Z","steps":["trace[1596906312] 'read index received' (duration: 21.975916ms)","trace[1596906312] 'applied index is now lower than readState.Index' (duration: 92.321391ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:39:57.121408Z","caller":"traceutil/trace.go:171","msg":"trace[1798574057] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"392.870562ms","start":"2026-09-16T21:39:56.728515Z","end":"2026-09-16T21:39:57.121385Z","steps":["trace[1798574057] 'process raft request' (duration: 300.53872ms)","trace[1798574057] 'compare' (duration: 92.094073ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:39:57.121513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-16T21:39:56.728494Z","time spent":"392.958967ms","remote":"127.0.0.1:45402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-16T21:39:57.121521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.511725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-16T21:39:57.121557Z","caller":"traceutil/trace.go:171","msg":"trace[329579478] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"114.611708ms","start":"2026-09-16T21:39:57.006935Z","end":"2026-09-16T21:39:57.121547Z","steps":["trace[329579478] 'agreement among raft nodes before linearized reading' (duration: 114.453692ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:41:05.739573Z","caller":"traceutil/trace.go:171","msg":"trace[192652256] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"106.629825ms","start":"2026-09-16T21:41:05.632897Z","end":"2026-09-16T21:41:05.739527Z","steps":["trace[192652256] 'process raft request' (duration: 41.988447ms)","trace[192652256] 'compare' (duration: 64.410654ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:41:05.73981Z","caller":"traceutil/trace.go:171","msg":"trace[2091870839] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"106.880581ms","start":"2026-09-16T21:41:05.632917Z","end":"2026-09-16T21:41:05.739798Z","steps":["trace[2091870839] 'process raft request' (duration: 106.741988ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:41:05.740128Z","caller":"traceutil/trace.go:171","msg":"trace[1504784486] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"105.542073ms","start":"2026-09-16T21:41:05.634545Z","end":"2026-09-16T21:41:05.740087Z","steps":["trace[1504784486] 'process raft request' (duration: 105.198986ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:41:16.501648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.299024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-16T21:41:16.501736Z","caller":"traceutil/trace.go:171","msg":"trace[1048414969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1512; }","duration":"102.438367ms","start":"2026-09-16T21:41:16.399278Z","end":"2026-09-16T21:41:16.501717Z","steps":["trace[1048414969] 'range keys from in-memory index tree' (duration: 102.11207ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:41:42.370432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.310999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-16T21:41:42.370555Z","caller":"traceutil/trace.go:171","msg":"trace[304300200] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1998; }","duration":"211.16558ms","start":"2026-09-16T21:41:42.159369Z","end":"2026-09-16T21:41:42.370534Z","steps":["trace[304300200] 'read index received' (duration: 33.549175ms)","trace[304300200] 'applied index is now lower than readState.Index' (duration: 177.614825ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:41:42.370917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.864887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T21:41:42.37097Z","caller":"traceutil/trace.go:171","msg":"trace[1311101485] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1924; }","duration":"164.962018ms","start":"2026-09-16T21:41:42.205994Z","end":"2026-09-16T21:41:42.370956Z","steps":["trace[1311101485] 'agreement among raft nodes before linearized reading' (duration: 164.855157ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:41:42.370961Z","caller":"traceutil/trace.go:171","msg":"trace[524914838] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"269.116531ms","start":"2026-09-16T21:41:42.1018Z","end":"2026-09-16T21:41:42.370916Z","steps":["trace[524914838] 'process raft request' (duration: 91.201512ms)","trace[524914838] 'compare' (duration: 177.189287ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:41:42.370948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.567076ms","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-16T21:41:42.371191Z","caller":"traceutil/trace.go:171","msg":"trace[689927248] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1924; }","duration":"211.82684ms","start":"2026-09-16T21:41:42.159336Z","end":"2026-09-16T21:41:42.371163Z","steps":["trace[689927248] 'agreement among raft nodes before linearized reading' (duration: 211.440844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:41:42.371202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.82977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-7e5cc9ff-83e2-4c8a-9b90-69892e4e2eac\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-16T21:41:42.371626Z","caller":"traceutil/trace.go:171","msg":"trace[1045260104] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-7e5cc9ff-83e2-4c8a-9b90-69892e4e2eac; range_end:; response_count:1; response_revision:1924; }","duration":"143.342349ms","start":"2026-09-16T21:41:42.228234Z","end":"2026-09-16T21:41:42.371576Z","steps":["trace[1045260104] 'agreement among raft nodes before linearized reading' (duration: 142.652277ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:41:48.876007Z","caller":"traceutil/trace.go:171","msg":"trace[899273344] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"138.30919ms","start":"2026-09-16T21:41:48.737683Z","end":"2026-09-16T21:41:48.875992Z","steps":["trace[899273344] 'process raft request' (duration: 137.938645ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:41:55.020518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.797597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-16T21:41:55.020639Z","caller":"traceutil/trace.go:171","msg":"trace[1517743821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2028; }","duration":"151.985739ms","start":"2026-09-16T21:41:54.868629Z","end":"2026-09-16T21:41:55.020615Z","steps":["trace[1517743821] 'range keys from in-memory index tree' (duration: 151.550713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:41:55.020994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.61116ms","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-16T21:41:55.021104Z","caller":"traceutil/trace.go:171","msg":"trace[10800579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2028; }","duration":"122.793022ms","start":"2026-09-16T21:41:54.898281Z","end":"2026-09-16T21:41:55.021074Z","steps":["trace[10800579] 'range keys from in-memory index tree' (duration: 122.326495ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:41:55.145544Z","caller":"traceutil/trace.go:171","msg":"trace[1989835830] transaction","detail":"{read_only:false; response_revision:2029; number_of_response:1; }","duration":"119.89293ms","start":"2026-09-16T21:41:55.025616Z","end":"2026-09-16T21:41:55.145509Z","steps":["trace[1989835830] 'process raft request' (duration: 119.711547ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:41:55.168424Z","caller":"traceutil/trace.go:171","msg":"trace[331828181] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"142.360894ms","start":"2026-09-16T21:41:55.026031Z","end":"2026-09-16T21:41:55.168391Z","steps":["trace[331828181] 'process raft request' (duration: 142.172341ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:42:21.161414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.117451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.234\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-16T21:42:21.161515Z","caller":"traceutil/trace.go:171","msg":"trace[1459978051] range","detail":"{range_begin:/registry/masterleases/162.253.55.234; range_end:; response_count:1; response_revision:2183; }","duration":"128.265152ms","start":"2026-09-16T21:42:21.033222Z","end":"2026-09-16T21:42:21.161487Z","steps":["trace[1459978051] 'range keys from in-memory index tree' (duration: 127.907218ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:42:21.161574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.280129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-09-16T21:42:21.161716Z","caller":"traceutil/trace.go:171","msg":"trace[1908940866] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2183; }","duration":"127.484654ms","start":"2026-09-16T21:42:21.034159Z","end":"2026-09-16T21:42:21.161643Z","steps":["trace[1908940866] 'range keys from in-memory index tree' (duration: 127.104088ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:42:21.299646Z","caller":"traceutil/trace.go:171","msg":"trace[2128855450] linearizableReadLoop","detail":"{readStateIndex:2267; appliedIndex:2266; }","duration":"126.280116ms","start":"2026-09-16T21:42:21.173343Z","end":"2026-09-16T21:42:21.299623Z","steps":["trace[2128855450] 'read index received' (duration: 126.109564ms)","trace[2128855450] 'applied index is now lower than readState.Index' (duration: 169.252µs)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:42:21.300003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.650401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T21:42:21.30005Z","caller":"traceutil/trace.go:171","msg":"trace[1481864506] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2183; }","duration":"126.735282ms","start":"2026-09-16T21:42:21.1733Z","end":"2026-09-16T21:42:21.300035Z","steps":["trace[1481864506] 'agreement among raft nodes before linearized reading' (duration: 126.646481ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:42:21.621118Z","caller":"traceutil/trace.go:171","msg":"trace[1929931969] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"239.602283ms","start":"2026-09-16T21:42:21.381488Z","end":"2026-09-16T21:42:21.62109Z","steps":["trace[1929931969] 'process raft request' (duration: 239.373129ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:43:18.606266Z","caller":"traceutil/trace.go:171","msg":"trace[1205135186] transaction","detail":"{read_only:false; response_revision:2598; number_of_response:1; }","duration":"193.49974ms","start":"2026-09-16T21:43:18.412743Z","end":"2026-09-16T21:43:18.606243Z","steps":["trace[1205135186] 'process raft request' (duration: 193.357878ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:43:56.257486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.091991ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-16T21:43:56.257859Z","caller":"traceutil/trace.go:171","msg":"trace[954327134] transaction","detail":"{read_only:false; response_revision:2804; number_of_response:1; }","duration":"217.997076ms","start":"2026-09-16T21:43:56.039797Z","end":"2026-09-16T21:43:56.257794Z","steps":["trace[954327134] 'process raft request' (duration: 93.509563ms)","trace[954327134] 'compare' (duration: 123.827493ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:48:30.830764Z","caller":"traceutil/trace.go:171","msg":"trace[2126258084] transaction","detail":"{read_only:false; response_revision:4911; number_of_response:1; }","duration":"101.507722ms","start":"2026-09-16T21:48:30.729222Z","end":"2026-09-16T21:48:30.83073Z","steps":["trace[2126258084] 'process raft request' (duration: 101.305399ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:38.044517Z","caller":"traceutil/trace.go:171","msg":"trace[1572532177] linearizableReadLoop","detail":"{readStateIndex:5178; appliedIndex:5177; }","duration":"205.980506ms","start":"2026-09-16T21:48:37.838517Z","end":"2026-09-16T21:48:38.044497Z","steps":["trace[1572532177] 'read index received' (duration: 205.831163ms)","trace[1572532177] 'applied index is now lower than readState.Index' (duration: 148.472µs)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:48:38.044609Z","caller":"traceutil/trace.go:171","msg":"trace[585454100] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"281.101486ms","start":"2026-09-16T21:48:37.763455Z","end":"2026-09-16T21:48:38.044556Z","steps":["trace[585454100] 'process raft request' (duration: 280.915874ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:48:38.044852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.268051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-16T21:48:38.044986Z","caller":"traceutil/trace.go:171","msg":"trace[353509822] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:0; response_revision:4989; }","duration":"206.495763ms","start":"2026-09-16T21:48:37.838471Z","end":"2026-09-16T21:48:38.044967Z","steps":["trace[353509822] 'agreement among raft nodes before linearized reading' (duration: 206.190619ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:48:38.119475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.411176ms","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-16T21:48:38.11971Z","caller":"traceutil/trace.go:171","msg":"trace[372803859] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4990; }","duration":"278.648589ms","start":"2026-09-16T21:48:37.841039Z","end":"2026-09-16T21:48:38.119688Z","steps":["trace[372803859] 'agreement among raft nodes before linearized reading' (duration: 278.290014ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:38.49256Z","caller":"traceutil/trace.go:171","msg":"trace[483795401] transaction","detail":"{read_only:false; response_revision:4994; number_of_response:1; }","duration":"201.839402ms","start":"2026-09-16T21:48:38.29069Z","end":"2026-09-16T21:48:38.492529Z","steps":["trace[483795401] 'process raft request' (duration: 177.663404ms)","trace[483795401] 'compare' (duration: 23.969455ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:48:38.535711Z","caller":"traceutil/trace.go:171","msg":"trace[1646010356] transaction","detail":"{read_only:false; response_revision:4995; number_of_response:1; }","duration":"243.152096ms","start":"2026-09-16T21:48:38.29253Z","end":"2026-09-16T21:48:38.535682Z","steps":["trace[1646010356] 'process raft request' (duration: 242.953553ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:38.535957Z","caller":"traceutil/trace.go:171","msg":"trace[244370639] transaction","detail":"{read_only:false; response_revision:4996; number_of_response:1; }","duration":"240.990104ms","start":"2026-09-16T21:48:38.294947Z","end":"2026-09-16T21:48:38.535937Z","steps":["trace[244370639] 'process raft request' (duration: 240.674659ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:38.536153Z","caller":"traceutil/trace.go:171","msg":"trace[276913457] transaction","detail":"{read_only:false; response_revision:4997; number_of_response:1; }","duration":"240.973964ms","start":"2026-09-16T21:48:38.295152Z","end":"2026-09-16T21:48:38.536126Z","steps":["trace[276913457] 'process raft request' (duration: 240.69078ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:38.536594Z","caller":"traceutil/trace.go:171","msg":"trace[580404799] transaction","detail":"{read_only:false; response_revision:4998; number_of_response:1; }","duration":"240.388916ms","start":"2026-09-16T21:48:38.296187Z","end":"2026-09-16T21:48:38.536576Z","steps":["trace[580404799] 'process raft request' (duration: 239.846228ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:38.536609Z","caller":"traceutil/trace.go:171","msg":"trace[408109996] linearizableReadLoop","detail":"{readStateIndex:5188; appliedIndex:5182; }","duration":"217.840294ms","start":"2026-09-16T21:48:38.318752Z","end":"2026-09-16T21:48:38.536593Z","steps":["trace[408109996] 'read index received' (duration: 149.616129ms)","trace[408109996] 'applied index is now lower than readState.Index' (duration: 68.223195ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:48:38.536752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.990506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-16T21:48:38.536774Z","caller":"traceutil/trace.go:171","msg":"trace[1911065038] transaction","detail":"{read_only:false; response_revision:4999; number_of_response:1; }","duration":"237.564843ms","start":"2026-09-16T21:48:38.299169Z","end":"2026-09-16T21:48:38.536734Z","steps":["trace[1911065038] 'process raft request' (duration: 237.241348ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:38.536789Z","caller":"traceutil/trace.go:171","msg":"trace[355385394] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4999; }","duration":"218.066488ms","start":"2026-09-16T21:48:38.318709Z","end":"2026-09-16T21:48:38.536776Z","steps":["trace[355385394] 'agreement among raft nodes before linearized reading' (duration: 217.939046ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:40.062905Z","caller":"traceutil/trace.go:171","msg":"trace[1901545859] linearizableReadLoop","detail":"{readStateIndex:5258; appliedIndex:5257; }","duration":"126.995993ms","start":"2026-09-16T21:48:39.935891Z","end":"2026-09-16T21:48:40.062887Z","steps":["trace[1901545859] 'read index received' (duration: 126.82189ms)","trace[1901545859] 'applied index is now lower than readState.Index' (duration: 173.253µs)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:48:40.06314Z","caller":"traceutil/trace.go:171","msg":"trace[940658527] transaction","detail":"{read_only:false; response_revision:5068; number_of_response:1; }","duration":"154.630473ms","start":"2026-09-16T21:48:39.908439Z","end":"2026-09-16T21:48:40.063069Z","steps":["trace[940658527] 'process raft request' (duration: 154.326648ms)"],"step_count":1} {"level":"warn","ts":"2026-09-16T21:48:40.063763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.854736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-16T21:48:40.063804Z","caller":"traceutil/trace.go:171","msg":"trace[697611878] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5068; }","duration":"127.929077ms","start":"2026-09-16T21:48:39.935862Z","end":"2026-09-16T21:48:40.063791Z","steps":["trace[697611878] 'agreement among raft nodes before linearized reading' (duration: 127.152196ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:42.71026Z","caller":"traceutil/trace.go:171","msg":"trace[1294505073] transaction","detail":"{read_only:false; response_revision:5091; number_of_response:1; }","duration":"108.582541ms","start":"2026-09-16T21:48:42.601647Z","end":"2026-09-16T21:48:42.710229Z","steps":["trace[1294505073] 'process raft request' (duration: 108.226425ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:48:51.459062Z","caller":"traceutil/trace.go:171","msg":"trace[906012987] transaction","detail":"{read_only:false; response_revision:5222; number_of_response:1; }","duration":"132.073869ms","start":"2026-09-16T21:48:51.326938Z","end":"2026-09-16T21:48:51.459012Z","steps":["trace[906012987] 'process raft request' (duration: 131.811225ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:49:07.866013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2865} {"level":"info","ts":"2026-09-16T21:49:07.939713Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2865,"took":"72.401641ms","hash":1526926750,"current-db-size-bytes":51355648,"current-db-size":"51 MB","current-db-size-in-use-bytes":27660288,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-16T21:49:07.939809Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1526926750,"revision":2865,"compact-revision":-1} {"level":"info","ts":"2026-09-16T21:49:31.760261Z","caller":"traceutil/trace.go:171","msg":"trace[2032155017] transaction","detail":"{read_only:false; response_revision:5582; number_of_response:1; }","duration":"127.796347ms","start":"2026-09-16T21:49:31.632415Z","end":"2026-09-16T21:49:31.760211Z","steps":["trace[2032155017] 'process raft request' (duration: 100.204496ms)","trace[2032155017] 'compare' (duration: 27.173365ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:49:44.135712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.724641ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-16T21:49:44.135833Z","caller":"traceutil/trace.go:171","msg":"trace[1948495662] linearizableReadLoop","detail":"{readStateIndex:5880; appliedIndex:5879; }","duration":"161.479257ms","start":"2026-09-16T21:49:43.974334Z","end":"2026-09-16T21:49:44.135813Z","steps":["trace[1948495662] 'read index received' (duration: 1.475371ms)","trace[1948495662] 'applied index is now lower than readState.Index' (duration: 160.002396ms)"],"step_count":2} {"level":"info","ts":"2026-09-16T21:49:44.135942Z","caller":"traceutil/trace.go:171","msg":"trace[189173236] transaction","detail":"{read_only:false; response_revision:5670; number_of_response:1; }","duration":"277.686583ms","start":"2026-09-16T21:49:43.858231Z","end":"2026-09-16T21:49:44.135918Z","steps":["trace[189173236] 'process raft request' (duration: 117.665897ms)","trace[189173236] 'compare' (duration: 159.576099ms)"],"step_count":2} {"level":"warn","ts":"2026-09-16T21:49:44.136058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.708111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-16T21:49:44.136098Z","caller":"traceutil/trace.go:171","msg":"trace[1396547893] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5670; }","duration":"161.816612ms","start":"2026-09-16T21:49:43.974271Z","end":"2026-09-16T21:49:44.136088Z","steps":["trace[1396547893] 'agreement among raft nodes before linearized reading' (duration: 161.63786ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:49:44.267574Z","caller":"traceutil/trace.go:171","msg":"trace[240088294] transaction","detail":"{read_only:false; response_revision:5671; number_of_response:1; }","duration":"127.036821ms","start":"2026-09-16T21:49:44.140513Z","end":"2026-09-16T21:49:44.26755Z","steps":["trace[240088294] 'process raft request' (duration: 120.303974ms)"],"step_count":1} {"level":"info","ts":"2026-09-16T21:54:07.884628Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5352} {"level":"info","ts":"2026-09-16T21:54:07.973684Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5352,"took":"87.569433ms","hash":1218690852,"current-db-size-bytes":51355648,"current-db-size":"51 MB","current-db-size-in-use-bytes":18636800,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-16T21:54:07.973732Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1218690852,"revision":5352,"compact-revision":2865}